{"level":"warn","ts":"2026-05-19T18:45:23.187775Z","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-19T18:45:23.187909Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.84: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://162.253.55.84:2380","--initial-cluster=instance=https://162.253.55.84:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.84:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.84: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-19T18:45:23.188017Z","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-19T18:45:23.188038Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.84:2380"]} {"level":"info","ts":"2026-05-19T18:45:23.188175Z","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-19T18:45:23.189315Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.84:2379"]} {"level":"info","ts":"2026-05-19T18:45:23.189487Z","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://162.253.55.84:2380"],"listen-peer-urls":["https://162.253.55.84:2380"],"advertise-client-urls":["https://162.253.55.84:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.84:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.84: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-19T18:45:23.228062Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"38.184339ms"} {"level":"info","ts":"2026-05-19T18:45:23.461046Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ca4c710a8d5349d7","cluster-id":"8e28a51debf1c8ab"} {"level":"info","ts":"2026-05-19T18:45:23.461204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T18:45:23.461238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 became follower at term 0"} {"level":"info","ts":"2026-05-19T18:45:23.46148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ca4c710a8d5349d7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-19T18:45:23.461501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 became follower at term 1"} {"level":"info","ts":"2026-05-19T18:45:23.461575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 switched to configuration voters=(14577150384026110423)"} {"level":"warn","ts":"2026-05-19T18:45:23.637148Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T18:45:23.643824Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T18:45:23.645696Z","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-19T18:45:23.651043Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ca4c710a8d5349d7","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-19T18:45:23.655024Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ca4c710a8d5349d7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-19T18:45:23.655061Z","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-19T18:45:23.655405Z","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-19T18:45:23.655427Z","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-19T18:45:23.656105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 switched to configuration voters=(14577150384026110423)"} {"level":"info","ts":"2026-05-19T18:45:23.656424Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8e28a51debf1c8ab","local-member-id":"ca4c710a8d5349d7","added-peer-id":"ca4c710a8d5349d7","added-peer-peer-urls":["https://162.253.55.84:2380"]} {"level":"info","ts":"2026-05-19T18:45:23.659673Z","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-19T18:45:23.660005Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ca4c710a8d5349d7","initial-advertise-peer-urls":["https://162.253.55.84:2380"],"listen-peer-urls":["https://162.253.55.84:2380"],"advertise-client-urls":["https://162.253.55.84:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.84:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-19T18:45:23.660063Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T18:45:23.660161Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.84:2380"} {"level":"info","ts":"2026-05-19T18:45:23.660187Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.84:2380"} {"level":"info","ts":"2026-05-19T18:45:23.700742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T18:45:23.701001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T18:45:23.701253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 received MsgPreVoteResp from ca4c710a8d5349d7 at term 1"} {"level":"info","ts":"2026-05-19T18:45:23.701347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 became candidate at term 2"} {"level":"info","ts":"2026-05-19T18:45:23.701364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 received MsgVoteResp from ca4c710a8d5349d7 at term 2"} {"level":"info","ts":"2026-05-19T18:45:23.701379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca4c710a8d5349d7 became leader at term 2"} {"level":"info","ts":"2026-05-19T18:45:23.701442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ca4c710a8d5349d7 elected leader ca4c710a8d5349d7 at term 2"} {"level":"info","ts":"2026-05-19T18:45:23.929006Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"warn","ts":"2026-05-19T18:45:24.682195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"753.079305ms","expected-duration":"100ms","prefix":"","request":"ID:5320895489163635714 Method:\"PUT\" Path:\"/0/members/ca4c710a8d5349d7/attributes\" Val:\"{\\\"name\\\":\\\"instance\\\",\\\"clientURLs\\\":[\\\"https://162.253.55.84:2379\\\"]}\" ","response":""} {"level":"info","ts":"2026-05-19T18:45:24.682316Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8e28a51debf1c8ab","local-member-id":"ca4c710a8d5349d7","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T18:45:24.682408Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T18:45:24.682502Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T18:45:24.682577Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T18:45:24.682593Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ca4c710a8d5349d7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.84:2379]}","request-path":"/0/members/ca4c710a8d5349d7/attributes","cluster-id":"8e28a51debf1c8ab","publish-timeout":"7s"} {"level":"info","ts":"2026-05-19T18:45:24.682835Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T18:45:24.68294Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T18:45:24.682968Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T18:45:24.68801Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-19T18:45:24.688146Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.84:2379"} {"level":"warn","ts":"2026-05-19T18:45:26.519088Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5320895489163635842,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-19T18:45:26.54202Z","caller":"traceutil/trace.go:171","msg":"trace[1216881759] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"556.860927ms","start":"2026-05-19T18:45:25.985123Z","end":"2026-05-19T18:45:26.541984Z","steps":["trace[1216881759] 'process raft request' (duration: 556.586716ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:26.542124Z","caller":"traceutil/trace.go:171","msg":"trace[2071900203] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"553.752698ms","start":"2026-05-19T18:45:25.988336Z","end":"2026-05-19T18:45:26.542089Z","steps":["trace[2071900203] 'process raft request' (duration: 553.616428ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:26.542118Z","caller":"traceutil/trace.go:171","msg":"trace[825507517] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"553.803103ms","start":"2026-05-19T18:45:25.988282Z","end":"2026-05-19T18:45:26.542085Z","steps":["trace[825507517] 'process raft request' (duration: 553.593487ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:26.542231Z","caller":"traceutil/trace.go:171","msg":"trace[460381898] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"553.883749ms","start":"2026-05-19T18:45:25.988335Z","end":"2026-05-19T18:45:26.542218Z","steps":["trace[460381898] 'process raft request' (duration: 553.650431ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:26.542306Z","caller":"traceutil/trace.go:171","msg":"trace[1113052238] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"554.046822ms","start":"2026-05-19T18:45:25.988229Z","end":"2026-05-19T18:45:26.542276Z","steps":["trace[1113052238] 'process raft request' (duration: 553.614639ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:26.542407Z","caller":"traceutil/trace.go:171","msg":"trace[1149415361] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"553.933832ms","start":"2026-05-19T18:45:25.988444Z","end":"2026-05-19T18:45:26.542378Z","steps":["trace[1149415361] 'process raft request' (duration: 553.568584ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:26.542778Z","caller":"traceutil/trace.go:171","msg":"trace[1891950704] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:6; }","duration":"524.645233ms","start":"2026-05-19T18:45:26.018107Z","end":"2026-05-19T18:45:26.542752Z","steps":["trace[1891950704] 'read index received' (duration: 523.521277ms)","trace[1891950704] 'applied index is now lower than readState.Index' (duration: 1.122916ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:45:26.542825Z","caller":"traceutil/trace.go:171","msg":"trace[1335786454] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"544.813002ms","start":"2026-05-19T18:45:25.997996Z","end":"2026-05-19T18:45:26.542809Z","steps":["trace[1335786454] 'process raft request' (duration: 544.701864ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:26.543102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.526508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T18:45:26.543158Z","caller":"traceutil/trace.go:171","msg":"trace[2006068673] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"557.644527ms","start":"2026-05-19T18:45:25.985496Z","end":"2026-05-19T18:45:26.543141Z","steps":["trace[2006068673] 'agreement among raft nodes before linearized reading' (duration: 557.384717ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:26.543147Z","caller":"traceutil/trace.go:171","msg":"trace[1633355442] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"548.640645ms","start":"2026-05-19T18:45:25.994471Z","end":"2026-05-19T18:45:26.543112Z","steps":["trace[1633355442] 'process raft request' (duration: 547.561133ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:26.543195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:25.985477Z","time spent":"557.708942ms","remote":"127.0.0.1:54682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-19T18:45:26.54326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:25.994463Z","time spent":"548.729043ms","remote":"127.0.0.1:54852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:45:26.54326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:25.997987Z","time spent":"544.878977ms","remote":"127.0.0.1:54752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:45:26.543362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.884476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T18:45:26.543413Z","caller":"traceutil/trace.go:171","msg":"trace[1331215792] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"557.986373ms","start":"2026-05-19T18:45:25.985412Z","end":"2026-05-19T18:45:26.543399Z","steps":["trace[1331215792] 'agreement among raft nodes before linearized reading' (duration: 557.893136ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:26.543451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.027289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-05-19T18:45:26.543491Z","caller":"traceutil/trace.go:171","msg":"trace[1175685454] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"523.097894ms","start":"2026-05-19T18:45:26.020384Z","end":"2026-05-19T18:45:26.543482Z","steps":["trace[1175685454] 'agreement among raft nodes before linearized reading' (duration: 523.036199ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:26.54353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:26.020369Z","time spent":"523.154178ms","remote":"127.0.0.1:54752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3194,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-19T18:45:26.543248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.992013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.84\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T18:45:26.54359Z","caller":"traceutil/trace.go:171","msg":"trace[1524288833] range","detail":"{range_begin:/registry/masterleases/162.253.55.84; range_end:; response_count:0; response_revision:11; }","duration":"561.391495ms","start":"2026-05-19T18:45:25.982177Z","end":"2026-05-19T18:45:26.543568Z","steps":["trace[1524288833] 'agreement among raft nodes before linearized reading' (duration: 560.977333ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:26.543645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:25.982164Z","time spent":"561.45779ms","remote":"127.0.0.1:54640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/162.253.55.84\" "} {"level":"warn","ts":"2026-05-19T18:45:26.543672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:25.985406Z","time spent":"558.063479ms","remote":"127.0.0.1:54670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-05-19T18:45:26.54376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.595531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T18:45:26.543805Z","caller":"traceutil/trace.go:171","msg":"trace[1958419991] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"480.672698ms","start":"2026-05-19T18:45:26.063123Z","end":"2026-05-19T18:45:26.543795Z","steps":["trace[1958419991] 'agreement among raft nodes before linearized reading' (duration: 480.610213ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:26.543832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:26.063103Z","time spent":"480.722621ms","remote":"127.0.0.1:54682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-19T18:45:26.543967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.321473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T18:45:26.544011Z","caller":"traceutil/trace.go:171","msg":"trace[75956599] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"507.389068ms","start":"2026-05-19T18:45:26.036612Z","end":"2026-05-19T18:45:26.544001Z","steps":["trace[75956599] 'agreement among raft nodes before linearized reading' (duration: 507.320363ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:26.544039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:26.036601Z","time spent":"507.431432ms","remote":"127.0.0.1:54682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-19T18:45:26.54418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:25.988324Z","time spent":"553.858686ms","remote":"127.0.0.1:55122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:45:26.544358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:25.988272Z","time spent":"553.943123ms","remote":"127.0.0.1:55122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:45:26.544463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:25.98833Z","time spent":"553.932703ms","remote":"127.0.0.1:55122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:45:26.544549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:25.988212Z","time spent":"554.16794ms","remote":"127.0.0.1:55122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:45:26.544661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:25.988428Z","time spent":"554.049111ms","remote":"127.0.0.1:55122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:45:26.548375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:25.985106Z","time spent":"557.023319ms","remote":"127.0.0.1:55040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:45:26.745708Z","caller":"traceutil/trace.go:171","msg":"trace[144070575] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"198.864968ms","start":"2026-05-19T18:45:26.546813Z","end":"2026-05-19T18:45:26.745678Z","steps":["trace[144070575] 'process raft request' (duration: 131.03458ms)","trace[144070575] 'compare' (duration: 67.660745ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:45:26.776873Z","caller":"traceutil/trace.go:171","msg":"trace[1827770535] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"228.072801ms","start":"2026-05-19T18:45:26.548759Z","end":"2026-05-19T18:45:26.776832Z","steps":["trace[1827770535] 'process raft request' (duration: 227.780778ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:26.77695Z","caller":"traceutil/trace.go:171","msg":"trace[716558374] transaction","detail":"{read_only:false; number_of_response:0; response_revision:14; }","duration":"227.93315ms","start":"2026-05-19T18:45:26.548984Z","end":"2026-05-19T18:45:26.776917Z","steps":["trace[716558374] 'process raft request' (duration: 227.777488ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:26.777095Z","caller":"traceutil/trace.go:171","msg":"trace[1760043451] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"226.574205ms","start":"2026-05-19T18:45:26.550459Z","end":"2026-05-19T18:45:26.777033Z","steps":["trace[1760043451] 'process raft request' (duration: 226.413983ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:26.777126Z","caller":"traceutil/trace.go:171","msg":"trace[119287194] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"227.487795ms","start":"2026-05-19T18:45:26.54962Z","end":"2026-05-19T18:45:26.777107Z","steps":["trace[119287194] 'process raft request' (duration: 227.16502ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:26.777179Z","caller":"traceutil/trace.go:171","msg":"trace[518158150] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"228.272906ms","start":"2026-05-19T18:45:26.548894Z","end":"2026-05-19T18:45:26.777167Z","steps":["trace[518158150] 'process raft request' (duration: 227.831573ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:26.777202Z","caller":"traceutil/trace.go:171","msg":"trace[1271970881] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"226.582816ms","start":"2026-05-19T18:45:26.550584Z","end":"2026-05-19T18:45:26.777167Z","steps":["trace[1271970881] 'process raft request' (duration: 226.314606ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:26.777252Z","caller":"traceutil/trace.go:171","msg":"trace[994582732] linearizableReadLoop","detail":"{readStateIndex:16; appliedIndex:14; }","duration":"228.302668ms","start":"2026-05-19T18:45:26.548903Z","end":"2026-05-19T18:45:26.777206Z","steps":["trace[994582732] 'read index received' (duration: 128.904387ms)","trace[994582732] 'applied index is now lower than readState.Index' (duration: 99.396911ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:45:26.777274Z","caller":"traceutil/trace.go:171","msg":"trace[748396442] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"226.012163ms","start":"2026-05-19T18:45:26.551252Z","end":"2026-05-19T18:45:26.777264Z","steps":["trace[748396442] 'process raft request' (duration: 225.676517ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:26.777344Z","caller":"traceutil/trace.go:171","msg":"trace[1722705346] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"223.353718ms","start":"2026-05-19T18:45:26.553979Z","end":"2026-05-19T18:45:26.777333Z","steps":["trace[1722705346] 'process raft request' (duration: 222.98671ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:26.777353Z","caller":"traceutil/trace.go:171","msg":"trace[1311998912] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"227.447682ms","start":"2026-05-19T18:45:26.549893Z","end":"2026-05-19T18:45:26.77734Z","steps":["trace[1311998912] 'process raft request' (duration: 226.955014ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:26.777462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.10805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-19T18:45:26.77749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.578449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-z7nwg\" ","response":"range_response_count:1 size:857"} {"level":"info","ts":"2026-05-19T18:45:26.777507Z","caller":"traceutil/trace.go:171","msg":"trace[603498404] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:20; }","duration":"189.238799ms","start":"2026-05-19T18:45:26.588255Z","end":"2026-05-19T18:45:26.777494Z","steps":["trace[603498404] 'agreement among raft nodes before linearized reading' (duration: 189.11427ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:26.777529Z","caller":"traceutil/trace.go:171","msg":"trace[898521645] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-z7nwg; range_end:; response_count:1; response_revision:20; }","duration":"228.635074ms","start":"2026-05-19T18:45:26.548877Z","end":"2026-05-19T18:45:26.777512Z","steps":["trace[898521645] 'agreement among raft nodes before linearized reading' (duration: 228.565148ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:26.777692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.782242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-05-19T18:45:26.777731Z","caller":"traceutil/trace.go:171","msg":"trace[1414580587] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"173.87606ms","start":"2026-05-19T18:45:26.603844Z","end":"2026-05-19T18:45:26.77772Z","steps":["trace[1414580587] 'agreement among raft nodes before linearized reading' (duration: 173.779232ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:27.00559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.063324ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-19T18:45:27.005978Z","caller":"traceutil/trace.go:171","msg":"trace[1514495430] linearizableReadLoop","detail":"{readStateIndex:30; appliedIndex:24; }","duration":"221.869616ms","start":"2026-05-19T18:45:26.78409Z","end":"2026-05-19T18:45:27.005959Z","steps":["trace[1514495430] 'read index received' (duration: 99.991658ms)","trace[1514495430] 'applied index is now lower than readState.Index' (duration: 121.876488ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:45:27.005996Z","caller":"traceutil/trace.go:171","msg":"trace[1813867892] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"225.437979ms","start":"2026-05-19T18:45:26.78053Z","end":"2026-05-19T18:45:27.005968Z","steps":["trace[1813867892] 'process raft request' (duration: 103.784329ms)","trace[1813867892] 'compare' (duration: 120.923424ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:45:27.006009Z","caller":"traceutil/trace.go:171","msg":"trace[539303476] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"222.338171ms","start":"2026-05-19T18:45:26.78363Z","end":"2026-05-19T18:45:27.005968Z","steps":["trace[539303476] 'process raft request' (duration: 222.123164ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:27.006038Z","caller":"traceutil/trace.go:171","msg":"trace[895821108] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"222.19467ms","start":"2026-05-19T18:45:26.783824Z","end":"2026-05-19T18:45:27.006019Z","steps":["trace[895821108] 'process raft request' (duration: 221.970142ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:27.00607Z","caller":"traceutil/trace.go:171","msg":"trace[1136912961] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"222.228593ms","start":"2026-05-19T18:45:26.783828Z","end":"2026-05-19T18:45:27.006057Z","steps":["trace[1136912961] 'process raft request' (duration: 222.001076ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:27.006181Z","caller":"traceutil/trace.go:171","msg":"trace[1059761600] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"222.285417ms","start":"2026-05-19T18:45:26.783878Z","end":"2026-05-19T18:45:27.006164Z","steps":["trace[1059761600] 'process raft request' (duration: 221.980124ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:27.006239Z","caller":"traceutil/trace.go:171","msg":"trace[1829992078] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"221.842484ms","start":"2026-05-19T18:45:26.784365Z","end":"2026-05-19T18:45:27.006208Z","steps":["trace[1829992078] 'process raft request' (duration: 221.568123ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:27.006291Z","caller":"traceutil/trace.go:171","msg":"trace[983534868] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"221.984374ms","start":"2026-05-19T18:45:26.784299Z","end":"2026-05-19T18:45:27.006284Z","steps":["trace[983534868] 'process raft request' (duration: 221.613066ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:27.00635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.245004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T18:45:27.006396Z","caller":"traceutil/trace.go:171","msg":"trace[1846915556] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:29; }","duration":"222.312149ms","start":"2026-05-19T18:45:26.784071Z","end":"2026-05-19T18:45:27.006384Z","steps":["trace[1846915556] 'agreement among raft nodes before linearized reading' (duration: 222.220182ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:27.006409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.049532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T18:45:27.006436Z","caller":"traceutil/trace.go:171","msg":"trace[1064265615] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:29; }","duration":"171.126778ms","start":"2026-05-19T18:45:26.8353Z","end":"2026-05-19T18:45:27.006427Z","steps":["trace[1064265615] 'agreement among raft nodes before linearized reading' (duration: 171.065424ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:27.006188Z","caller":"traceutil/trace.go:171","msg":"trace[890692721] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"224.520489ms","start":"2026-05-19T18:45:26.78166Z","end":"2026-05-19T18:45:27.00618Z","steps":["trace[890692721] 'process raft request' (duration: 224.049562ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:27.006674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.637025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T18:45:27.006722Z","caller":"traceutil/trace.go:171","msg":"trace[1070793659] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:29; }","duration":"122.743003ms","start":"2026-05-19T18:45:26.883968Z","end":"2026-05-19T18:45:27.006711Z","steps":["trace[1070793659] 'agreement among raft nodes before linearized reading' (duration: 122.627694ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:27.007299Z","caller":"traceutil/trace.go:171","msg":"trace[346013050] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"222.388645ms","start":"2026-05-19T18:45:26.784307Z","end":"2026-05-19T18:45:27.006695Z","steps":["trace[346013050] 'process raft request' (duration: 221.579143ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:27.008947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.30649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T18:45:27.009032Z","caller":"traceutil/trace.go:171","msg":"trace[1867273972] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:29; }","duration":"124.792651ms","start":"2026-05-19T18:45:26.88422Z","end":"2026-05-19T18:45:27.009013Z","steps":["trace[1867273972] 'agreement among raft nodes before linearized reading' (duration: 122.262667ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:42.596364Z","caller":"traceutil/trace.go:171","msg":"trace[699923898] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"927.206127ms","start":"2026-05-19T18:45:41.66913Z","end":"2026-05-19T18:45:42.596336Z","steps":["trace[699923898] 'process raft request' (duration: 927.074616ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:42.59671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:41.669109Z","time spent":"927.338258ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:45:43.288955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.860767ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T18:45:43.289137Z","caller":"traceutil/trace.go:171","msg":"trace[1494383853] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"1.619946308s","start":"2026-05-19T18:45:41.669166Z","end":"2026-05-19T18:45:43.289113Z","steps":["trace[1494383853] 'process raft request' (duration: 1.344836632s)","trace[1494383853] 'compare' (duration: 274.746158ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:45:43.289221Z","caller":"traceutil/trace.go:171","msg":"trace[1937731344] linearizableReadLoop","detail":"{readStateIndex:455; appliedIndex:454; }","duration":"881.926655ms","start":"2026-05-19T18:45:42.407278Z","end":"2026-05-19T18:45:43.289204Z","steps":["trace[1937731344] 'read index received' (duration: 190.011378ms)","trace[1937731344] 'applied index is now lower than readState.Index' (duration: 691.912477ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:45:43.289222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:41.66914Z","time spent":"1.620042255s","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:45:43.29087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"860.640482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6961"} {"level":"info","ts":"2026-05-19T18:45:43.290999Z","caller":"traceutil/trace.go:171","msg":"trace[1976985142] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:444; }","duration":"860.807276ms","start":"2026-05-19T18:45:42.430177Z","end":"2026-05-19T18:45:43.290985Z","steps":["trace[1976985142] 'agreement among raft nodes before linearized reading' (duration: 860.637243ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:43.291109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:42.430162Z","time spent":"860.930366ms","remote":"127.0.0.1:54768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6985,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"warn","ts":"2026-05-19T18:45:43.291172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.889214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:45:43.291358Z","caller":"traceutil/trace.go:171","msg":"trace[58562201] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:444; }","duration":"647.114861ms","start":"2026-05-19T18:45:42.644227Z","end":"2026-05-19T18:45:43.291342Z","steps":["trace[58562201] 'agreement among raft nodes before linearized reading' (duration: 646.896234ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:43.291121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.167517ms","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-19T18:45:43.291502Z","caller":"traceutil/trace.go:171","msg":"trace[1429745554] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:444; }","duration":"580.607362ms","start":"2026-05-19T18:45:42.710871Z","end":"2026-05-19T18:45:43.291478Z","steps":["trace[1429745554] 'agreement among raft nodes before linearized reading' (duration: 580.100632ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:43.291624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:42.710849Z","time spent":"580.750543ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T18:45:43.290914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"883.639406ms","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-19T18:45:43.291819Z","caller":"traceutil/trace.go:171","msg":"trace[558222272] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:444; }","duration":"884.573499ms","start":"2026-05-19T18:45:42.407229Z","end":"2026-05-19T18:45:43.291802Z","steps":["trace[558222272] 'agreement among raft nodes before linearized reading' (duration: 882.063545ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:43.29141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:42.644208Z","time spent":"647.188767ms","remote":"127.0.0.1:54622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T18:45:43.291865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:42.407205Z","time spent":"884.647935ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-19T18:45:48.265344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.306071ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T18:45:48.265433Z","caller":"traceutil/trace.go:171","msg":"trace[1172010654] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"343.037711ms","start":"2026-05-19T18:45:47.922382Z","end":"2026-05-19T18:45:48.265419Z","steps":["trace[1172010654] 'process raft request' (duration: 193.591931ms)","trace[1172010654] 'compare' (duration: 149.19318ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:45:48.265487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:47.922362Z","time spent":"343.106068ms","remote":"127.0.0.1:54640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:45:48.862684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.308252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T18:45:48.862741Z","caller":"traceutil/trace.go:171","msg":"trace[31115800] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:458; }","duration":"240.416943ms","start":"2026-05-19T18:45:48.622312Z","end":"2026-05-19T18:45:48.862729Z","steps":["trace[31115800] 'range keys from in-memory index tree' (duration: 240.166513ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:52.138186Z","caller":"traceutil/trace.go:171","msg":"trace[1408544516] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"127.128027ms","start":"2026-05-19T18:45:52.011035Z","end":"2026-05-19T18:45:52.138163Z","steps":["trace[1408544516] 'process raft request' (duration: 123.144422ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:54.469415Z","caller":"traceutil/trace.go:171","msg":"trace[1217097323] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"101.156476ms","start":"2026-05-19T18:45:54.368228Z","end":"2026-05-19T18:45:54.469384Z","steps":["trace[1217097323] 'process raft request' (duration: 80.401253ms)","trace[1217097323] 'compare' (duration: 20.542798ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:45:54.642495Z","caller":"traceutil/trace.go:171","msg":"trace[1166254399] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"141.147377ms","start":"2026-05-19T18:45:54.501312Z","end":"2026-05-19T18:45:54.64246Z","steps":["trace[1166254399] 'process raft request' (duration: 80.852082ms)","trace[1166254399] 'compare' (duration: 60.132686ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:45:54.659456Z","caller":"traceutil/trace.go:171","msg":"trace[1158659347] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"129.130981ms","start":"2026-05-19T18:45:54.530298Z","end":"2026-05-19T18:45:54.659429Z","steps":["trace[1158659347] 'process raft request' (duration: 128.383092ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:54.659956Z","caller":"traceutil/trace.go:171","msg":"trace[1628328892] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"128.922605ms","start":"2026-05-19T18:45:54.531Z","end":"2026-05-19T18:45:54.659923Z","steps":["trace[1628328892] 'process raft request' (duration: 127.858728ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:55.026316Z","caller":"traceutil/trace.go:171","msg":"trace[381670713] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"354.980809ms","start":"2026-05-19T18:45:54.671305Z","end":"2026-05-19T18:45:55.026286Z","steps":["trace[381670713] 'process raft request' (duration: 278.834019ms)","trace[381670713] 'compare' (duration: 75.9902ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:45:55.026476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:54.67129Z","time spent":"355.10448ms","remote":"127.0.0.1:54656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:45:55.02773Z","caller":"traceutil/trace.go:171","msg":"trace[729247729] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"352.865014ms","start":"2026-05-19T18:45:54.674838Z","end":"2026-05-19T18:45:55.027703Z","steps":["trace[729247729] 'process raft request' (duration: 352.345668ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:55.027902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:54.674828Z","time spent":"352.985597ms","remote":"127.0.0.1:54656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31111,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:45:55.028144Z","caller":"traceutil/trace.go:171","msg":"trace[263268477] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"316.107465ms","start":"2026-05-19T18:45:54.71202Z","end":"2026-05-19T18:45:55.028127Z","steps":["trace[263268477] 'process raft request' (duration: 315.549352ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:55.028225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:54.711996Z","time spent":"316.193029ms","remote":"127.0.0.1:54656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:45:55.304019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.223194ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T18:45:55.304124Z","caller":"traceutil/trace.go:171","msg":"trace[661379080] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"241.032121ms","start":"2026-05-19T18:45:55.063074Z","end":"2026-05-19T18:45:55.304106Z","steps":["trace[661379080] 'process raft request' (duration: 139.643148ms)","trace[661379080] 'compare' (duration: 101.075863ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:45:55.310763Z","caller":"traceutil/trace.go:171","msg":"trace[735688649] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"205.404993ms","start":"2026-05-19T18:45:55.105338Z","end":"2026-05-19T18:45:55.310743Z","steps":["trace[735688649] 'process raft request' (duration: 205.333768ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:55.310825Z","caller":"traceutil/trace.go:171","msg":"trace[291691764] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"212.022298ms","start":"2026-05-19T18:45:55.098785Z","end":"2026-05-19T18:45:55.310808Z","steps":["trace[291691764] 'process raft request' (duration: 211.763405ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:55.654454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.745235ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T18:45:55.654916Z","caller":"traceutil/trace.go:171","msg":"trace[1843178947] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"317.059342ms","start":"2026-05-19T18:45:55.33783Z","end":"2026-05-19T18:45:55.654889Z","steps":["trace[1843178947] 'process raft request' (duration: 316.746752ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:55.654944Z","caller":"traceutil/trace.go:171","msg":"trace[1941548112] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"316.32549ms","start":"2026-05-19T18:45:55.338583Z","end":"2026-05-19T18:45:55.654909Z","steps":["trace[1941548112] 'process raft request' (duration: 316.035089ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:55.655048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:55.337805Z","time spent":"317.181233ms","remote":"127.0.0.1:54656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:45:55.655109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:55.338563Z","time spent":"316.453531ms","remote":"127.0.0.1:54656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59607,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:45:55.655133Z","caller":"traceutil/trace.go:171","msg":"trace[21879908] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"334.352174ms","start":"2026-05-19T18:45:55.320764Z","end":"2026-05-19T18:45:55.655117Z","steps":["trace[21879908] 'process raft request' (duration: 119.881758ms)","trace[21879908] 'compare' (duration: 213.65855ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:45:55.655217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:55.320732Z","time spent":"334.427579ms","remote":"127.0.0.1:54656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:45:56.134185Z","caller":"traceutil/trace.go:171","msg":"trace[1353808832] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"255.162602ms","start":"2026-05-19T18:45:55.878999Z","end":"2026-05-19T18:45:56.134162Z","steps":["trace[1353808832] 'process raft request' (duration: 250.417805ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:56.144676Z","caller":"traceutil/trace.go:171","msg":"trace[248160867] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"225.272907ms","start":"2026-05-19T18:45:55.919372Z","end":"2026-05-19T18:45:56.144645Z","steps":["trace[248160867] 'process raft request' (duration: 224.695904ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:45:56.144827Z","caller":"traceutil/trace.go:171","msg":"trace[788061234] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"157.281349ms","start":"2026-05-19T18:45:55.987525Z","end":"2026-05-19T18:45:56.144806Z","steps":["trace[788061234] 'process raft request' (duration: 157.003567ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:57.143674Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5320895489163636856,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T18:45:57.644734Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5320895489163636856,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T18:45:57.69033Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.266672424s","expected-duration":"1s"} {"level":"info","ts":"2026-05-19T18:45:57.690898Z","caller":"traceutil/trace.go:171","msg":"trace[1352695192] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"1.267454615s","start":"2026-05-19T18:45:56.423424Z","end":"2026-05-19T18:45:57.690878Z","steps":["trace[1352695192] 'process raft request' (duration: 1.267188151s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:57.691023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:56.4234Z","time spent":"1.267554089s","remote":"127.0.0.1:54656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":74754,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:45:57.702215Z","caller":"traceutil/trace.go:171","msg":"trace[538333225] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"1.260556547s","start":"2026-05-19T18:45:56.441634Z","end":"2026-05-19T18:45:57.70219Z","steps":["trace[538333225] 'process raft request' (duration: 1.260142163s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:57.702457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:56.441613Z","time spent":"1.26066624s","remote":"127.0.0.1:54656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:45:57.703826Z","caller":"traceutil/trace.go:171","msg":"trace[601321734] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"1.251357088s","start":"2026-05-19T18:45:56.452441Z","end":"2026-05-19T18:45:57.703798Z","steps":["trace[601321734] 'process raft request' (duration: 1.25001451s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:57.710694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:56.452416Z","time spent":"1.25147681s","remote":"127.0.0.1:54656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:45:57.712005Z","caller":"traceutil/trace.go:171","msg":"trace[333778797] linearizableReadLoop","detail":"{readStateIndex:594; appliedIndex:590; }","duration":"1.068497798s","start":"2026-05-19T18:45:56.643415Z","end":"2026-05-19T18:45:57.711913Z","steps":["trace[333778797] 'read index received' (duration: 1.047334547s)","trace[333778797] 'applied index is now lower than readState.Index' (duration: 21.160531ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:45:57.712381Z","caller":"traceutil/trace.go:171","msg":"trace[1337336702] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"148.811105ms","start":"2026-05-19T18:45:57.563488Z","end":"2026-05-19T18:45:57.712299Z","steps":["trace[1337336702] 'process raft request' (duration: 140.251315ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:57.712496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.069033684s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:45:57.712604Z","caller":"traceutil/trace.go:171","msg":"trace[282844876] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:579; }","duration":"1.069195065s","start":"2026-05-19T18:45:56.643381Z","end":"2026-05-19T18:45:57.712576Z","steps":["trace[282844876] 'agreement among raft nodes before linearized reading' (duration: 1.068759942s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:57.712858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:56.643366Z","time spent":"1.069320437s","remote":"127.0.0.1:54622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T18:45:57.71298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.440492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-19T18:45:57.713363Z","caller":"traceutil/trace.go:171","msg":"trace[1743129938] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:579; }","duration":"659.560435ms","start":"2026-05-19T18:45:57.053466Z","end":"2026-05-19T18:45:57.713027Z","steps":["trace[1743129938] 'agreement among raft nodes before linearized reading' (duration: 659.054996ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:45:57.713416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:45:57.053414Z","time spent":"659.990258ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T18:46:03.914811Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5320895489163637017,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-19T18:46:03.953601Z","caller":"traceutil/trace.go:171","msg":"trace[599515072] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"572.149474ms","start":"2026-05-19T18:46:03.381436Z","end":"2026-05-19T18:46:03.953585Z","steps":["trace[599515072] 'process raft request' (duration: 572.002281ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:03.953696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.381421Z","time spent":"572.227869ms","remote":"127.0.0.1:54768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:46:03.953873Z","caller":"traceutil/trace.go:171","msg":"trace[320520332] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"539.963431ms","start":"2026-05-19T18:46:03.413901Z","end":"2026-05-19T18:46:03.953865Z","steps":["trace[320520332] 'read index received' (duration: 539.492985ms)","trace[320520332] 'applied index is now lower than readState.Index' (duration: 171.712µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:46:03.953845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.914703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:46:03.95395Z","caller":"traceutil/trace.go:171","msg":"trace[1586810853] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:618; }","duration":"540.076345ms","start":"2026-05-19T18:46:03.413853Z","end":"2026-05-19T18:46:03.953929Z","steps":["trace[1586810853] 'agreement among raft nodes before linearized reading' (duration: 539.850066ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:03.953999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.413833Z","time spent":"540.153801ms","remote":"127.0.0.1:41464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-19T18:46:03.954021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.184613ms","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-19T18:46:03.954041Z","caller":"traceutil/trace.go:171","msg":"trace[1563032617] 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:618; }","duration":"360.220372ms","start":"2026-05-19T18:46:03.593813Z","end":"2026-05-19T18:46:03.954033Z","steps":["trace[1563032617] 'agreement among raft nodes before linearized reading' (duration: 360.193973ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:03.954057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.593804Z","time spent":"360.248671ms","remote":"127.0.0.1:41496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-19T18:46:03.95415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.818814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:46:03.954163Z","caller":"traceutil/trace.go:171","msg":"trace[1191512045] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"310.859271ms","start":"2026-05-19T18:46:03.6433Z","end":"2026-05-19T18:46:03.954159Z","steps":["trace[1191512045] 'agreement among raft nodes before linearized reading' (duration: 310.836712ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:03.954176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.643283Z","time spent":"310.889939ms","remote":"127.0.0.1:54622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T18:46:03.954145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.896472ms","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-19T18:46:03.954168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.41523ms","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":"info","ts":"2026-05-19T18:46:03.954216Z","caller":"traceutil/trace.go:171","msg":"trace[1045030390] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:618; }","duration":"215.009686ms","start":"2026-05-19T18:46:03.739196Z","end":"2026-05-19T18:46:03.954206Z","steps":["trace[1045030390] 'agreement among raft nodes before linearized reading' (duration: 214.867513ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:03.953963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.046547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:46:03.954243Z","caller":"traceutil/trace.go:171","msg":"trace[44293156] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:618; }","duration":"514.511955ms","start":"2026-05-19T18:46:03.439708Z","end":"2026-05-19T18:46:03.95422Z","steps":["trace[44293156] 'agreement among raft nodes before linearized reading' (duration: 514.328074ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:46:03.954286Z","caller":"traceutil/trace.go:171","msg":"trace[1920283047] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:618; }","duration":"540.408798ms","start":"2026-05-19T18:46:03.413853Z","end":"2026-05-19T18:46:03.954262Z","steps":["trace[1920283047] 'agreement among raft nodes before linearized reading' (duration: 540.086764ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:03.954295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.439701Z","time spent":"514.578502ms","remote":"127.0.0.1:41476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"warn","ts":"2026-05-19T18:46:03.954341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.413833Z","time spent":"540.493624ms","remote":"127.0.0.1:41464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-19T18:46:03.954407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.086346ms","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-19T18:46:03.954447Z","caller":"traceutil/trace.go:171","msg":"trace[1510990294] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:618; }","duration":"515.160952ms","start":"2026-05-19T18:46:03.439275Z","end":"2026-05-19T18:46:03.954436Z","steps":["trace[1510990294] 'agreement among raft nodes before linearized reading' (duration: 515.088466ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:03.954382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.187481ms","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-19T18:46:03.954533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.210609ms","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-19T18:46:03.954242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.865639ms","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":"warn","ts":"2026-05-19T18:46:03.954553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.230634ms","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":"warn","ts":"2026-05-19T18:46:03.954548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.571474ms","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-19T18:46:03.954578Z","caller":"traceutil/trace.go:171","msg":"trace[574081290] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:618; }","duration":"215.280912ms","start":"2026-05-19T18:46:03.739289Z","end":"2026-05-19T18:46:03.95457Z","steps":["trace[574081290] 'agreement among raft nodes before linearized reading' (duration: 215.246024ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:46:03.954589Z","caller":"traceutil/trace.go:171","msg":"trace[795617614] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:618; }","duration":"383.624381ms","start":"2026-05-19T18:46:03.570954Z","end":"2026-05-19T18:46:03.954579Z","steps":["trace[795617614] 'agreement among raft nodes before linearized reading' (duration: 383.563074ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:46:03.954589Z","caller":"traceutil/trace.go:171","msg":"trace[508994982] 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:618; }","duration":"360.207341ms","start":"2026-05-19T18:46:03.594359Z","end":"2026-05-19T18:46:03.954566Z","steps":["trace[508994982] 'agreement among raft nodes before linearized reading' (duration: 359.870069ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:46:03.954571Z","caller":"traceutil/trace.go:171","msg":"trace[78881948] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:618; }","duration":"187.459817ms","start":"2026-05-19T18:46:03.767087Z","end":"2026-05-19T18:46:03.954547Z","steps":["trace[78881948] 'agreement among raft nodes before linearized reading' (duration: 186.911905ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:03.95466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.594343Z","time spent":"360.273778ms","remote":"127.0.0.1:41496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-19T18:46:03.95462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.570948Z","time spent":"383.664839ms","remote":"127.0.0.1:41488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"info","ts":"2026-05-19T18:46:03.954561Z","caller":"traceutil/trace.go:171","msg":"trace[1444535208] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:618; }","duration":"515.257387ms","start":"2026-05-19T18:46:03.439295Z","end":"2026-05-19T18:46:03.954553Z","steps":["trace[1444535208] 'agreement among raft nodes before linearized reading' (duration: 515.215469ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:03.954717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.439285Z","time spent":"515.420168ms","remote":"127.0.0.1:41476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"warn","ts":"2026-05-19T18:46:03.954488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.439266Z","time spent":"515.207019ms","remote":"127.0.0.1:41476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-05-19T18:46:03.954516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.139969ms","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-19T18:46:03.954839Z","caller":"traceutil/trace.go:171","msg":"trace[1938314500] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:618; }","duration":"215.472413ms","start":"2026-05-19T18:46:03.739356Z","end":"2026-05-19T18:46:03.954829Z","steps":["trace[1938314500] 'agreement among raft nodes before linearized reading' (duration: 215.13142ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:03.954851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.404241ms","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":"info","ts":"2026-05-19T18:46:03.954885Z","caller":"traceutil/trace.go:171","msg":"trace[490471960] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:618; }","duration":"384.457658ms","start":"2026-05-19T18:46:03.570416Z","end":"2026-05-19T18:46:03.954873Z","steps":["trace[490471960] 'agreement among raft nodes before linearized reading' (duration: 384.398502ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:03.954914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.570412Z","time spent":"384.494247ms","remote":"127.0.0.1:41488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-19T18:46:03.955032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.677557ms","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":"warn","ts":"2026-05-19T18:46:03.955021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.009884ms","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-19T18:46:03.955046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.078113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T18:46:03.955056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.975039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T18:46:03.954261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.131526ms","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-19T18:46:03.955092Z","caller":"traceutil/trace.go:171","msg":"trace[1645606480] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:618; }","duration":"541.161999ms","start":"2026-05-19T18:46:03.41391Z","end":"2026-05-19T18:46:03.955072Z","steps":["trace[1645606480] 'agreement among raft nodes before linearized reading' (duration: 541.107872ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:46:03.955093Z","caller":"traceutil/trace.go:171","msg":"trace[687986023] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:618; }","duration":"111.098179ms","start":"2026-05-19T18:46:03.843959Z","end":"2026-05-19T18:46:03.955057Z","steps":["trace[687986023] 'agreement among raft nodes before linearized reading' (duration: 110.983225ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:46:03.955105Z","caller":"traceutil/trace.go:171","msg":"trace[1989481523] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:618; }","duration":"155.040825ms","start":"2026-05-19T18:46:03.80005Z","end":"2026-05-19T18:46:03.955091Z","steps":["trace[1989481523] 'agreement among raft nodes before linearized reading' (duration: 154.974309ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:03.955123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.413878Z","time spent":"541.236665ms","remote":"127.0.0.1:41464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-19T18:46:03.955135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.791195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T18:46:03.955253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.396435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:46:03.955258Z","caller":"traceutil/trace.go:171","msg":"trace[886604119] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:618; }","duration":"181.8938ms","start":"2026-05-19T18:46:03.773305Z","end":"2026-05-19T18:46:03.955199Z","steps":["trace[886604119] 'agreement among raft nodes before linearized reading' (duration: 181.786195ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:46:03.955284Z","caller":"traceutil/trace.go:171","msg":"trace[1481838196] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:618; }","duration":"111.455701ms","start":"2026-05-19T18:46:03.84382Z","end":"2026-05-19T18:46:03.955275Z","steps":["trace[1481838196] 'agreement among raft nodes before linearized reading' (duration: 111.408813ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:03.954469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.317735ms","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-19T18:46:03.955365Z","caller":"traceutil/trace.go:171","msg":"trace[597740519] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:618; }","duration":"211.223978ms","start":"2026-05-19T18:46:03.744131Z","end":"2026-05-19T18:46:03.955355Z","steps":["trace[597740519] 'agreement among raft nodes before linearized reading' (duration: 210.246048ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:03.955417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.603644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:46:03.955476Z","caller":"traceutil/trace.go:171","msg":"trace[1308879350] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:618; }","duration":"111.662411ms","start":"2026-05-19T18:46:03.843775Z","end":"2026-05-19T18:46:03.955437Z","steps":["trace[1308879350] 'agreement among raft nodes before linearized reading' (duration: 111.608233ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:03.955528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.248532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:46:03.955557Z","caller":"traceutil/trace.go:171","msg":"trace[1499180241] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:618; }","duration":"182.317838ms","start":"2026-05-19T18:46:03.77323Z","end":"2026-05-19T18:46:03.955548Z","steps":["trace[1499180241] 'agreement among raft nodes before linearized reading' (duration: 182.259761ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:03.955604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.469665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T18:46:03.955618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.48211ms","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-19T18:46:03.955649Z","caller":"traceutil/trace.go:171","msg":"trace[240054677] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:618; }","duration":"154.520192ms","start":"2026-05-19T18:46:03.801106Z","end":"2026-05-19T18:46:03.955626Z","steps":["trace[240054677] 'agreement among raft nodes before linearized reading' (duration: 154.473114ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:46:03.955666Z","caller":"traceutil/trace.go:171","msg":"trace[1115105030] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:618; }","duration":"111.568056ms","start":"2026-05-19T18:46:03.844087Z","end":"2026-05-19T18:46:03.955655Z","steps":["trace[1115105030] 'agreement among raft nodes before linearized reading' (duration: 111.438732ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:03.955769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.600437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:46:03.955099Z","caller":"traceutil/trace.go:171","msg":"trace[623914821] 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:618; }","duration":"360.997592ms","start":"2026-05-19T18:46:03.594089Z","end":"2026-05-19T18:46:03.955086Z","steps":["trace[623914821] 'agreement among raft nodes before linearized reading' (duration: 360.162444ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:46:03.955797Z","caller":"traceutil/trace.go:171","msg":"trace[1454697708] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:618; }","duration":"155.645896ms","start":"2026-05-19T18:46:03.800143Z","end":"2026-05-19T18:46:03.955788Z","steps":["trace[1454697708] 'agreement among raft nodes before linearized reading' (duration: 155.573799ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:03.955821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.594062Z","time spent":"361.736155ms","remote":"127.0.0.1:41496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-19T18:46:03.955062Z","caller":"traceutil/trace.go:171","msg":"trace[1390879095] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:618; }","duration":"384.738414ms","start":"2026-05-19T18:46:03.570312Z","end":"2026-05-19T18:46:03.955051Z","steps":["trace[1390879095] 'agreement among raft nodes before linearized reading' (duration: 384.697476ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:03.955917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.570295Z","time spent":"385.610051ms","remote":"127.0.0.1:41488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-19T18:46:03.956572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.307673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T18:46:03.956611Z","caller":"traceutil/trace.go:171","msg":"trace[1732748112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:618; }","duration":"212.38188ms","start":"2026-05-19T18:46:03.744218Z","end":"2026-05-19T18:46:03.9566Z","steps":["trace[1732748112] 'agreement among raft nodes before linearized reading' (duration: 209.765143ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:46:04.497642Z","caller":"traceutil/trace.go:171","msg":"trace[1169294743] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"535.558265ms","start":"2026-05-19T18:46:03.962049Z","end":"2026-05-19T18:46:04.497608Z","steps":["trace[1169294743] 'process raft request' (duration: 535.074299ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:46:04.497723Z","caller":"traceutil/trace.go:171","msg":"trace[392788823] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"535.641341ms","start":"2026-05-19T18:46:03.962056Z","end":"2026-05-19T18:46:04.497698Z","steps":["trace[392788823] 'process raft request' (duration: 535.419362ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:04.497832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.962034Z","time spent":"535.688139ms","remote":"127.0.0.1:54834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:46:04.497862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.962041Z","time spent":"535.732747ms","remote":"127.0.0.1:54668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:46:04.497979Z","caller":"traceutil/trace.go:171","msg":"trace[509125575] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"534.871232ms","start":"2026-05-19T18:46:03.963096Z","end":"2026-05-19T18:46:04.497967Z","steps":["trace[509125575] 'process raft request' (duration: 534.446023ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:04.498039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.963084Z","time spent":"534.925049ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:46:04.498147Z","caller":"traceutil/trace.go:171","msg":"trace[618548536] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:635; }","duration":"531.405038ms","start":"2026-05-19T18:46:03.966729Z","end":"2026-05-19T18:46:04.498134Z","steps":["trace[618548536] 'read index received' (duration: 2.76026ms)","trace[618548536] 'applied index is now lower than readState.Index' (duration: 528.643868ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:46:04.498271Z","caller":"traceutil/trace.go:171","msg":"trace[1521411699] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"532.228666ms","start":"2026-05-19T18:46:03.966032Z","end":"2026-05-19T18:46:04.498261Z","steps":["trace[1521411699] 'process raft request' (duration: 532.036876ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:46:04.498276Z","caller":"traceutil/trace.go:171","msg":"trace[1681023457] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"533.502421ms","start":"2026-05-19T18:46:03.964755Z","end":"2026-05-19T18:46:04.498258Z","steps":["trace[1681023457] 'process raft request' (duration: 533.190807ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:04.498345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.966025Z","time spent":"532.275964ms","remote":"127.0.0.1:54768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:46:04.49836Z","caller":"traceutil/trace.go:171","msg":"trace[40485488] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"534.253402ms","start":"2026-05-19T18:46:03.964064Z","end":"2026-05-19T18:46:04.498318Z","steps":["trace[40485488] 'process raft request' (duration: 533.584535ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:04.498412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.964049Z","time spent":"534.334989ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:46:04.498411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.964746Z","time spent":"533.580057ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:46:04.498431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.698634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:46:04.498612Z","caller":"traceutil/trace.go:171","msg":"trace[990964479] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"531.902933ms","start":"2026-05-19T18:46:03.966698Z","end":"2026-05-19T18:46:04.498601Z","steps":["trace[990964479] 'agreement among raft nodes before linearized reading' (duration: 531.694134ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:04.498673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.966682Z","time spent":"531.978859ms","remote":"127.0.0.1:41548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-05-19T18:46:04.49888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.605442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T18:46:04.498878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.304978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:46:04.498916Z","caller":"traceutil/trace.go:171","msg":"trace[243587765] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:626; }","duration":"515.680798ms","start":"2026-05-19T18:46:03.983224Z","end":"2026-05-19T18:46:04.498904Z","steps":["trace[243587765] 'agreement among raft nodes before linearized reading' (duration: 515.628661ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:46:04.498922Z","caller":"traceutil/trace.go:171","msg":"trace[1185109474] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:626; }","duration":"515.376684ms","start":"2026-05-19T18:46:03.983533Z","end":"2026-05-19T18:46:04.49891Z","steps":["trace[1185109474] 'agreement among raft nodes before linearized reading' (duration: 515.309177ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:04.498939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.983198Z","time spent":"515.732816ms","remote":"127.0.0.1:41558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-05-19T18:46:04.49896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.983519Z","time spent":"515.429602ms","remote":"127.0.0.1:41558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-05-19T18:46:04.499117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.86028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:46:04.499211Z","caller":"traceutil/trace.go:171","msg":"trace[937163705] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:626; }","duration":"516.011413ms","start":"2026-05-19T18:46:03.983177Z","end":"2026-05-19T18:46:04.499189Z","steps":["trace[937163705] 'agreement among raft nodes before linearized reading' (duration: 515.828391ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:04.499285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.983162Z","time spent":"516.105728ms","remote":"127.0.0.1:41558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-05-19T18:46:04.499555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.776781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:46:04.500427Z","caller":"traceutil/trace.go:171","msg":"trace[1660720159] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"533.673017ms","start":"2026-05-19T18:46:03.966737Z","end":"2026-05-19T18:46:04.50041Z","steps":["trace[1660720159] 'agreement among raft nodes before linearized reading' (duration: 532.082325ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:04.50049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.966725Z","time spent":"533.738304ms","remote":"127.0.0.1:41548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-05-19T18:46:04.500523Z","caller":"traceutil/trace.go:171","msg":"trace[1057588958] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"533.854412ms","start":"2026-05-19T18:46:03.964144Z","end":"2026-05-19T18:46:04.497998Z","steps":["trace[1057588958] 'process raft request' (duration: 533.68943ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:04.502552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:03.964135Z","time spent":"537.526582ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:46:05.606088Z","caller":"traceutil/trace.go:171","msg":"trace[639502986] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"623.919268ms","start":"2026-05-19T18:46:04.982146Z","end":"2026-05-19T18:46:05.606065Z","steps":["trace[639502986] 'process raft request' (duration: 623.715497ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:05.606236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:04.98211Z","time spent":"624.053441ms","remote":"127.0.0.1:54768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:46:08.634497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"776.683486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.84\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-19T18:46:08.634553Z","caller":"traceutil/trace.go:171","msg":"trace[628199690] range","detail":"{range_begin:/registry/masterleases/162.253.55.84; range_end:; response_count:1; response_revision:630; }","duration":"776.791432ms","start":"2026-05-19T18:46:07.85775Z","end":"2026-05-19T18:46:08.634541Z","steps":["trace[628199690] 'range keys from in-memory index tree' (duration: 776.548383ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:08.634564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.990635488s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T18:46:08.634577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:07.857729Z","time spent":"776.842519ms","remote":"127.0.0.1:54640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.84\" "} {"level":"warn","ts":"2026-05-19T18:46:08.634501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:06.562516Z","time spent":"2.071979099s","remote":"127.0.0.1:41560","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-19T18:46:08.63459Z","caller":"traceutil/trace.go:171","msg":"trace[1697924714] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"1.990691836s","start":"2026-05-19T18:46:06.643887Z","end":"2026-05-19T18:46:08.634579Z","steps":["trace[1697924714] 'range keys from in-memory index tree' (duration: 1.990550653s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:08.634821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:06.643875Z","time spent":"1.990938666s","remote":"127.0.0.1:54622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T18:46:08.634808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.128258636s","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-19T18:46:08.635702Z","caller":"traceutil/trace.go:171","msg":"trace[511304875] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:630; }","duration":"2.129178476s","start":"2026-05-19T18:46:06.506486Z","end":"2026-05-19T18:46:08.635665Z","steps":["trace[511304875] 'range keys from in-memory index tree' (duration: 2.128115353s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:08.635749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:06.506466Z","time spent":"2.129272402s","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T18:46:08.634779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.131415852s","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-19T18:46:08.635861Z","caller":"traceutil/trace.go:171","msg":"trace[1871734045] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:630; }","duration":"2.132522614s","start":"2026-05-19T18:46:06.503321Z","end":"2026-05-19T18:46:08.635844Z","steps":["trace[1871734045] 'range keys from in-memory index tree' (duration: 2.131278838s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:08.635898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:06.503305Z","time spent":"2.132578331s","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-19T18:46:08.634842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.12817481s","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-19T18:46:08.635957Z","caller":"traceutil/trace.go:171","msg":"trace[1922342823] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:630; }","duration":"2.129326631s","start":"2026-05-19T18:46:06.506625Z","end":"2026-05-19T18:46:08.635951Z","steps":["trace[1922342823] 'range keys from in-memory index tree' (duration: 2.128113413s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:08.635977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:06.506618Z","time spent":"2.129354009s","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T18:46:08.634981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.127635683s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T18:46:08.636031Z","caller":"traceutil/trace.go:171","msg":"trace[839236604] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:630; }","duration":"2.129459595s","start":"2026-05-19T18:46:06.506565Z","end":"2026-05-19T18:46:08.636025Z","steps":["trace[839236604] 'range keys from in-memory index tree' (duration: 2.127492919s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:08.636055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:06.506558Z","time spent":"2.129491104s","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-19T18:46:08.640047Z","caller":"traceutil/trace.go:171","msg":"trace[1513085030] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"667.189501ms","start":"2026-05-19T18:46:07.972843Z","end":"2026-05-19T18:46:08.640032Z","steps":["trace[1513085030] 'process raft request' (duration: 667.029998ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:08.640155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:07.972822Z","time spent":"667.264299ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:46:10.66801Z","caller":"traceutil/trace.go:171","msg":"trace[152909164] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:664; }","duration":"138.233152ms","start":"2026-05-19T18:46:10.529757Z","end":"2026-05-19T18:46:10.66799Z","steps":["trace[152909164] 'read index received' (duration: 133.158631ms)","trace[152909164] 'applied index is now lower than readState.Index' (duration: 5.073221ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:46:10.668101Z","caller":"traceutil/trace.go:171","msg":"trace[1008714226] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"526.187195ms","start":"2026-05-19T18:46:10.141881Z","end":"2026-05-19T18:46:10.668068Z","steps":["trace[1008714226] 'process raft request' (duration: 521.068246ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:10.668272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:10.141842Z","time spent":"526.353299ms","remote":"127.0.0.1:54668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":763,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:46:10.66816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.389945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:46:10.668584Z","caller":"traceutil/trace.go:171","msg":"trace[1080780204] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:647; }","duration":"138.826738ms","start":"2026-05-19T18:46:10.529713Z","end":"2026-05-19T18:46:10.66854Z","steps":["trace[1080780204] 'agreement among raft nodes before linearized reading' (duration: 138.389626ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:25.76271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.686056064s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fhm9z\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-05-19T18:46:25.762799Z","caller":"traceutil/trace.go:171","msg":"trace[843574398] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fhm9z; range_end:; response_count:1; response_revision:782; }","duration":"1.686198461s","start":"2026-05-19T18:46:24.076579Z","end":"2026-05-19T18:46:25.762777Z","steps":["trace[843574398] 'range keys from in-memory index tree' (duration: 1.685675492s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:25.762856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:24.076557Z","time spent":"1.68627533s","remote":"127.0.0.1:54768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fhm9z\" "} {"level":"warn","ts":"2026-05-19T18:46:25.763009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.905868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:46:25.763104Z","caller":"traceutil/trace.go:171","msg":"trace[400486718] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:782; }","duration":"120.047286ms","start":"2026-05-19T18:46:25.643037Z","end":"2026-05-19T18:46:25.763084Z","steps":["trace[400486718] 'range keys from in-memory index tree' (duration: 119.837059ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:25.763205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"774.618343ms","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-19T18:46:25.763358Z","caller":"traceutil/trace.go:171","msg":"trace[1574524052] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:782; }","duration":"774.7842ms","start":"2026-05-19T18:46:24.988556Z","end":"2026-05-19T18:46:25.76334Z","steps":["trace[1574524052] 'range keys from in-memory index tree' (duration: 774.567613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:25.763784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"972.524014ms","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-19T18:46:25.764242Z","caller":"traceutil/trace.go:171","msg":"trace[753657315] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:782; }","duration":"973.001374ms","start":"2026-05-19T18:46:24.791226Z","end":"2026-05-19T18:46:25.764227Z","steps":["trace[753657315] 'range keys from in-memory index tree' (duration: 972.378256ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:25.764336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:24.791215Z","time spent":"973.105632ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T18:46:25.763546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.024063713s","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-19T18:46:25.764544Z","caller":"traceutil/trace.go:171","msg":"trace[1365147201] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:782; }","duration":"1.025114224s","start":"2026-05-19T18:46:24.739399Z","end":"2026-05-19T18:46:25.764513Z","steps":["trace[1365147201] 'range keys from in-memory index tree' (duration: 1.023851637s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:25.764663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:24.739378Z","time spent":"1.025245991s","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-19T18:46:25.763909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.021312327s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T18:46:25.764915Z","caller":"traceutil/trace.go:171","msg":"trace[58326101] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:782; }","duration":"1.022329879s","start":"2026-05-19T18:46:24.742567Z","end":"2026-05-19T18:46:25.764897Z","steps":["trace[58326101] 'range keys from in-memory index tree' (duration: 1.02118703s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:25.764981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:24.742557Z","time spent":"1.022407087s","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T18:46:25.764083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"954.911ms","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-19T18:46:25.765084Z","caller":"traceutil/trace.go:171","msg":"trace[198916945] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:782; }","duration":"955.980709ms","start":"2026-05-19T18:46:24.80909Z","end":"2026-05-19T18:46:25.765071Z","steps":["trace[198916945] 'range keys from in-memory index tree' (duration: 954.716383ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:25.764273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.025305379s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-19T18:46:25.765139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:24.80907Z","time spent":"956.055077ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-19T18:46:25.765388Z","caller":"traceutil/trace.go:171","msg":"trace[1849031085] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:782; }","duration":"1.02631656s","start":"2026-05-19T18:46:24.738837Z","end":"2026-05-19T18:46:25.765153Z","steps":["trace[1849031085] 'range keys from in-memory index tree' (duration: 1.023863655s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:46:25.765516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:46:24.738808Z","time spent":"1.026688593s","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-19T18:46:25.881395Z","caller":"traceutil/trace.go:171","msg":"trace[570129633] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"111.719909ms","start":"2026-05-19T18:46:25.769654Z","end":"2026-05-19T18:46:25.881374Z","steps":["trace[570129633] 'process raft request' (duration: 111.567802ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:46:25.889224Z","caller":"traceutil/trace.go:171","msg":"trace[643075404] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"119.448617ms","start":"2026-05-19T18:46:25.769759Z","end":"2026-05-19T18:46:25.889208Z","steps":["trace[643075404] 'process raft request' (duration: 119.402437ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:46:25.889278Z","caller":"traceutil/trace.go:171","msg":"trace[863431215] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"119.546755ms","start":"2026-05-19T18:46:25.769698Z","end":"2026-05-19T18:46:25.889245Z","steps":["trace[863431215] 'process raft request' (duration: 119.300209ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:46:25.88937Z","caller":"traceutil/trace.go:171","msg":"trace[475230574] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"118.537494ms","start":"2026-05-19T18:46:25.770822Z","end":"2026-05-19T18:46:25.88936Z","steps":["trace[475230574] 'process raft request' (duration: 118.361517ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:46:25.889648Z","caller":"traceutil/trace.go:171","msg":"trace[723552924] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"118.603423ms","start":"2026-05-19T18:46:25.771038Z","end":"2026-05-19T18:46:25.889641Z","steps":["trace[723552924] 'process raft request' (duration: 118.283189ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:46:25.889699Z","caller":"traceutil/trace.go:171","msg":"trace[405409081] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"118.396497ms","start":"2026-05-19T18:46:25.771296Z","end":"2026-05-19T18:46:25.889693Z","steps":["trace[405409081] 'process raft request' (duration: 118.21348ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:46:29.892089Z","caller":"traceutil/trace.go:171","msg":"trace[421215381] transaction","detail":"{read_only:false; response_revision:834; number_of_response:1; }","duration":"114.392517ms","start":"2026-05-19T18:46:29.777651Z","end":"2026-05-19T18:46:29.892043Z","steps":["trace[421215381] 'process raft request' (duration: 87.193767ms)","trace[421215381] 'compare' (duration: 26.906054ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:18.95984Z","caller":"traceutil/trace.go:171","msg":"trace[585453867] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"108.78612ms","start":"2026-05-19T18:48:18.851035Z","end":"2026-05-19T18:48:18.959821Z","steps":["trace[585453867] 'process raft request' (duration: 108.671375ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:20.890969Z","caller":"traceutil/trace.go:171","msg":"trace[11283718] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"448.480238ms","start":"2026-05-19T18:48:20.44246Z","end":"2026-05-19T18:48:20.890941Z","steps":["trace[11283718] 'process raft request' (duration: 448.341281ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:20.891165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:48:20.442442Z","time spent":"448.601383ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:48:20.906972Z","caller":"traceutil/trace.go:171","msg":"trace[1631598482] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"462.997334ms","start":"2026-05-19T18:48:20.443944Z","end":"2026-05-19T18:48:20.906941Z","steps":["trace[1631598482] 'process raft request' (duration: 462.752382ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:20.906952Z","caller":"traceutil/trace.go:171","msg":"trace[831477724] linearizableReadLoop","detail":"{readStateIndex:1383; appliedIndex:1380; }","duration":"432.835518ms","start":"2026-05-19T18:48:20.474085Z","end":"2026-05-19T18:48:20.90692Z","steps":["trace[831477724] 'read index received' (duration: 416.777628ms)","trace[831477724] 'applied index is now lower than readState.Index' (duration: 16.0566ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:20.907068Z","caller":"traceutil/trace.go:171","msg":"trace[1346079639] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"462.623117ms","start":"2026-05-19T18:48:20.444403Z","end":"2026-05-19T18:48:20.907026Z","steps":["trace[1346079639] 'process raft request' (duration: 462.47321ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:20.907102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:48:20.443932Z","time spent":"463.089808ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:48:20.907195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:48:20.444397Z","time spent":"462.728911ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:48:20.907313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.208255ms","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-19T18:48:20.907378Z","caller":"traceutil/trace.go:171","msg":"trace[108796672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1336; }","duration":"433.3288ms","start":"2026-05-19T18:48:20.474033Z","end":"2026-05-19T18:48:20.907362Z","steps":["trace[108796672] 'agreement among raft nodes before linearized reading' (duration: 433.11238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:20.907433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:48:20.474013Z","time spent":"433.407534ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T18:48:20.907419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.170721ms","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-19T18:48:20.907577Z","caller":"traceutil/trace.go:171","msg":"trace[123237731] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1336; }","duration":"423.36843ms","start":"2026-05-19T18:48:20.484185Z","end":"2026-05-19T18:48:20.907554Z","steps":["trace[123237731] 'agreement among raft nodes before linearized reading' (duration: 423.035865ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:20.907646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:48:20.484169Z","time spent":"423.465924ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-19T18:48:27.155264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.827954ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T18:48:27.155503Z","caller":"traceutil/trace.go:171","msg":"trace[722413648] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"141.935302ms","start":"2026-05-19T18:48:27.013516Z","end":"2026-05-19T18:48:27.155451Z","steps":["trace[722413648] 'process raft request' (duration: 27.708577ms)","trace[722413648] 'compare' (duration: 113.661417ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:27.155887Z","caller":"traceutil/trace.go:171","msg":"trace[251305393] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"138.404861ms","start":"2026-05-19T18:48:27.017465Z","end":"2026-05-19T18:48:27.15587Z","steps":["trace[251305393] 'process raft request' (duration: 138.215962ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:27.155957Z","caller":"traceutil/trace.go:171","msg":"trace[1369418763] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"138.38587ms","start":"2026-05-19T18:48:27.017521Z","end":"2026-05-19T18:48:27.155907Z","steps":["trace[1369418763] 'process raft request' (duration: 138.284085ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:27.155899Z","caller":"traceutil/trace.go:171","msg":"trace[463239878] transaction","detail":"{read_only:false; response_revision:1363; number_of_response:1; }","duration":"138.347368ms","start":"2026-05-19T18:48:27.017532Z","end":"2026-05-19T18:48:27.15588Z","steps":["trace[463239878] 'process raft request' (duration: 138.307186ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:29.438669Z","caller":"traceutil/trace.go:171","msg":"trace[1020053698] linearizableReadLoop","detail":"{readStateIndex:1417; appliedIndex:1416; }","duration":"194.097818ms","start":"2026-05-19T18:48:29.244503Z","end":"2026-05-19T18:48:29.438601Z","steps":["trace[1020053698] 'read index received' (duration: 193.590413ms)","trace[1020053698] 'applied index is now lower than readState.Index' (duration: 505.855µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:29.438746Z","caller":"traceutil/trace.go:171","msg":"trace[416281555] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"194.613874ms","start":"2026-05-19T18:48:29.244093Z","end":"2026-05-19T18:48:29.438707Z","steps":["trace[416281555] 'process raft request' (duration: 193.981932ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:29.439106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.558981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/cluster-admin\" ","response":"range_response_count:1 size:553"} {"level":"info","ts":"2026-05-19T18:48:29.439236Z","caller":"traceutil/trace.go:171","msg":"trace[1544984456] range","detail":"{range_begin:/registry/clusterroles/cluster-admin; range_end:; response_count:1; response_revision:1368; }","duration":"194.733769ms","start":"2026-05-19T18:48:29.244481Z","end":"2026-05-19T18:48:29.439214Z","steps":["trace[1544984456] 'agreement among raft nodes before linearized reading' (duration: 194.386242ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:29.439528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.874775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:1 size:3475"} {"level":"info","ts":"2026-05-19T18:48:29.439591Z","caller":"traceutil/trace.go:171","msg":"trace[85263515] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:1; response_revision:1370; }","duration":"127.964899ms","start":"2026-05-19T18:48:29.311611Z","end":"2026-05-19T18:48:29.439576Z","steps":["trace[85263515] 'agreement among raft nodes before linearized reading' (duration: 127.797471ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:29.439932Z","caller":"traceutil/trace.go:171","msg":"trace[1255724692] transaction","detail":"{read_only:false; response_revision:1369; number_of_response:1; }","duration":"194.718828ms","start":"2026-05-19T18:48:29.245201Z","end":"2026-05-19T18:48:29.43992Z","steps":["trace[1255724692] 'process raft request' (duration: 194.084107ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:29.439995Z","caller":"traceutil/trace.go:171","msg":"trace[1413283962] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"194.750779ms","start":"2026-05-19T18:48:29.245203Z","end":"2026-05-19T18:48:29.439953Z","steps":["trace[1413283962] 'process raft request' (duration: 194.164381ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:31.775529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.019482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:48:31.775631Z","caller":"traceutil/trace.go:171","msg":"trace[813234037] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1376; }","duration":"133.165819ms","start":"2026-05-19T18:48:31.64244Z","end":"2026-05-19T18:48:31.775605Z","steps":["trace[813234037] 'range keys from in-memory index tree' (duration: 132.943218ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:31.775666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.017082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:endpointslice-controller\" ","response":"range_response_count:1 size:793"} {"level":"info","ts":"2026-05-19T18:48:31.775772Z","caller":"traceutil/trace.go:171","msg":"trace[822945975] range","detail":"{range_begin:/registry/clusterroles/system:controller:endpointslice-controller; range_end:; response_count:1; response_revision:1376; }","duration":"133.17359ms","start":"2026-05-19T18:48:31.642579Z","end":"2026-05-19T18:48:31.775752Z","steps":["trace[822945975] 'range keys from in-memory index tree' (duration: 132.850784ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:35.957642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.25315ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T18:48:35.957843Z","caller":"traceutil/trace.go:171","msg":"trace[515282173] linearizableReadLoop","detail":"{readStateIndex:1441; appliedIndex:1439; }","duration":"316.642098ms","start":"2026-05-19T18:48:35.641183Z","end":"2026-05-19T18:48:35.957825Z","steps":["trace[515282173] 'read index received' (duration: 94.099614ms)","trace[515282173] 'applied index is now lower than readState.Index' (duration: 222.539144ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:35.957925Z","caller":"traceutil/trace.go:171","msg":"trace[1225891477] transaction","detail":"{read_only:false; response_revision:1391; number_of_response:1; }","duration":"341.871139ms","start":"2026-05-19T18:48:35.616043Z","end":"2026-05-19T18:48:35.957915Z","steps":["trace[1225891477] 'process raft request' (duration: 341.722691ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:35.957984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:48:35.616024Z","time spent":"341.928612ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:48:35.958038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.964184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:endpointslicemirroring-controller\" ","response":"range_response_count:1 size:807"} {"level":"info","ts":"2026-05-19T18:48:35.958095Z","caller":"traceutil/trace.go:171","msg":"trace[1037068769] transaction","detail":"{read_only:false; response_revision:1390; number_of_response:1; }","duration":"343.026527ms","start":"2026-05-19T18:48:35.615042Z","end":"2026-05-19T18:48:35.958068Z","steps":["trace[1037068769] 'process raft request' (duration: 120.268122ms)","trace[1037068769] 'compare' (duration: 222.149914ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:35.95813Z","caller":"traceutil/trace.go:171","msg":"trace[637385888] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:endpointslicemirroring-controller; range_end:; response_count:1; response_revision:1391; }","duration":"263.093861ms","start":"2026-05-19T18:48:35.695012Z","end":"2026-05-19T18:48:35.958105Z","steps":["trace[637385888] 'agreement among raft nodes before linearized reading' (duration: 262.947674ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:35.958219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:48:35.61502Z","time spent":"343.141873ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:48:35.958382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.6594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:endpointslice-controller\" ","response":"range_response_count:1 size:771"} {"level":"info","ts":"2026-05-19T18:48:35.95844Z","caller":"traceutil/trace.go:171","msg":"trace[345864689] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:endpointslice-controller; range_end:; response_count:1; response_revision:1391; }","duration":"258.728714ms","start":"2026-05-19T18:48:35.699694Z","end":"2026-05-19T18:48:35.958422Z","steps":["trace[345864689] 'agreement among raft nodes before linearized reading' (duration: 258.636369ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:35.958921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.166394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:48:35.959075Z","caller":"traceutil/trace.go:171","msg":"trace[1560634069] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1391; }","duration":"317.838337ms","start":"2026-05-19T18:48:35.641145Z","end":"2026-05-19T18:48:35.958983Z","steps":["trace[1560634069] 'agreement among raft nodes before linearized reading' (duration: 317.078409ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:35.959242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:48:35.641128Z","time spent":"318.040727ms","remote":"127.0.0.1:54626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T18:48:36.264781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.697563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:ephemeral-volume-controller\" ","response":"range_response_count:1 size:783"} {"level":"info","ts":"2026-05-19T18:48:36.264877Z","caller":"traceutil/trace.go:171","msg":"trace[2091086452] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:ephemeral-volume-controller; range_end:; response_count:1; response_revision:1391; }","duration":"128.83263ms","start":"2026-05-19T18:48:36.136024Z","end":"2026-05-19T18:48:36.264857Z","steps":["trace[2091086452] 'range keys from in-memory index tree' (duration: 128.483153ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:36.264781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.201808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:discovery\" ","response":"range_response_count:1 size:647"} {"level":"info","ts":"2026-05-19T18:48:36.265047Z","caller":"traceutil/trace.go:171","msg":"trace[1257206871] range","detail":"{range_begin:/registry/clusterroles/system:discovery; range_end:; response_count:1; response_revision:1391; }","duration":"124.528524ms","start":"2026-05-19T18:48:36.140504Z","end":"2026-05-19T18:48:36.265033Z","steps":["trace[1257206871] 'range keys from in-memory index tree' (duration: 124.074261ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:37.459193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.382677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:node-controller\" ","response":"range_response_count:1 size:735"} {"level":"info","ts":"2026-05-19T18:48:37.459275Z","caller":"traceutil/trace.go:171","msg":"trace[2118988881] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:node-controller; range_end:; response_count:1; response_revision:1393; }","duration":"128.506294ms","start":"2026-05-19T18:48:37.330748Z","end":"2026-05-19T18:48:37.459254Z","steps":["trace[2118988881] 'range keys from in-memory index tree' (duration: 128.261562ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:37.459264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.808676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:kubelet-api-admin\" ","response":"range_response_count:1 size:662"} {"level":"info","ts":"2026-05-19T18:48:37.459394Z","caller":"traceutil/trace.go:171","msg":"trace[490089955] range","detail":"{range_begin:/registry/clusterroles/system:kubelet-api-admin; range_end:; response_count:1; response_revision:1393; }","duration":"187.965354ms","start":"2026-05-19T18:48:37.271377Z","end":"2026-05-19T18:48:37.459342Z","steps":["trace[490089955] 'range keys from in-memory index tree' (duration: 187.707211ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:37.459754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.410338ms","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-19T18:48:37.45982Z","caller":"traceutil/trace.go:171","msg":"trace[539382581] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1393; }","duration":"123.501292ms","start":"2026-05-19T18:48:37.336304Z","end":"2026-05-19T18:48:37.459805Z","steps":["trace[539382581] 'range keys from in-memory index tree' (duration: 123.250559ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:37.756368Z","caller":"traceutil/trace.go:171","msg":"trace[612568084] linearizableReadLoop","detail":"{readStateIndex:1444; appliedIndex:1443; }","duration":"225.992808ms","start":"2026-05-19T18:48:37.530352Z","end":"2026-05-19T18:48:37.756345Z","steps":["trace[612568084] 'read index received' (duration: 225.766786ms)","trace[612568084] 'applied index is now lower than readState.Index' (duration: 224.792µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:37.75644Z","caller":"traceutil/trace.go:171","msg":"trace[445423998] transaction","detail":"{read_only:false; response_revision:1394; number_of_response:1; }","duration":"291.738625ms","start":"2026-05-19T18:48:37.46467Z","end":"2026-05-19T18:48:37.756409Z","steps":["trace[445423998] 'process raft request' (duration: 291.534095ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:37.756532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.155346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:node-controller\" ","response":"range_response_count:1 size:735"} {"level":"info","ts":"2026-05-19T18:48:37.756605Z","caller":"traceutil/trace.go:171","msg":"trace[463317095] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:node-controller; range_end:; response_count:1; response_revision:1394; }","duration":"226.264712ms","start":"2026-05-19T18:48:37.530321Z","end":"2026-05-19T18:48:37.756585Z","steps":["trace[463317095] 'agreement among raft nodes before linearized reading' (duration: 226.145376ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:37.756681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.777633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:48:37.756729Z","caller":"traceutil/trace.go:171","msg":"trace[203251054] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1394; }","duration":"114.875178ms","start":"2026-05-19T18:48:37.641844Z","end":"2026-05-19T18:48:37.756719Z","steps":["trace[203251054] 'agreement among raft nodes before linearized reading' (duration: 114.784454ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:37.756707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.939065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:kubelet-api-admin\" ","response":"range_response_count:1 size:662"} {"level":"info","ts":"2026-05-19T18:48:37.756819Z","caller":"traceutil/trace.go:171","msg":"trace[342951202] range","detail":"{range_begin:/registry/clusterroles/system:kubelet-api-admin; range_end:; response_count:1; response_revision:1394; }","duration":"225.065242ms","start":"2026-05-19T18:48:37.531739Z","end":"2026-05-19T18:48:37.756804Z","steps":["trace[342951202] 'agreement among raft nodes before linearized reading' (duration: 224.855501ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:37.75704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.968811ms","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-19T18:48:37.757121Z","caller":"traceutil/trace.go:171","msg":"trace[1788531422] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1394; }","duration":"142.104098ms","start":"2026-05-19T18:48:37.614998Z","end":"2026-05-19T18:48:37.757102Z","steps":["trace[1788531422] 'agreement among raft nodes before linearized reading' (duration: 141.881327ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:39.389184Z","caller":"traceutil/trace.go:171","msg":"trace[1786410812] linearizableReadLoop","detail":"{readStateIndex:1450; appliedIndex:1449; }","duration":"193.133662ms","start":"2026-05-19T18:48:39.196026Z","end":"2026-05-19T18:48:39.38916Z","steps":["trace[1786410812] 'read index received' (duration: 192.90048ms)","trace[1786410812] 'applied index is now lower than readState.Index' (duration: 232.182µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:39.38929Z","caller":"traceutil/trace.go:171","msg":"trace[388271931] transaction","detail":"{read_only:false; response_revision:1399; number_of_response:1; }","duration":"200.509306ms","start":"2026-05-19T18:48:39.188736Z","end":"2026-05-19T18:48:39.389246Z","steps":["trace[388271931] 'process raft request' (duration: 200.273445ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:39.38947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.100773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/view\" ","response":"range_response_count:1 size:2108"} {"level":"info","ts":"2026-05-19T18:48:39.389563Z","caller":"traceutil/trace.go:171","msg":"trace[27677975] range","detail":"{range_begin:/registry/clusterroles/view; range_end:; response_count:1; response_revision:1399; }","duration":"162.24524ms","start":"2026-05-19T18:48:39.227296Z","end":"2026-05-19T18:48:39.389542Z","steps":["trace[27677975] 'agreement among raft nodes before linearized reading' (duration: 162.078022ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:39.389612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.301122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:resourcequota-controller\" ","response":"range_response_count:1 size:771"} {"level":"warn","ts":"2026-05-19T18:48:39.389486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.264192ms","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-19T18:48:39.389948Z","caller":"traceutil/trace.go:171","msg":"trace[1271263786] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:resourcequota-controller; range_end:; response_count:1; response_revision:1399; }","duration":"193.846199ms","start":"2026-05-19T18:48:39.195989Z","end":"2026-05-19T18:48:39.389835Z","steps":["trace[1271263786] 'agreement among raft nodes before linearized reading' (duration: 193.290391ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:39.389977Z","caller":"traceutil/trace.go:171","msg":"trace[1519047090] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1399; }","duration":"129.793119ms","start":"2026-05-19T18:48:39.260164Z","end":"2026-05-19T18:48:39.389957Z","steps":["trace[1519047090] 'agreement among raft nodes before linearized reading' (duration: 129.21803ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:40.119208Z","caller":"traceutil/trace.go:171","msg":"trace[1923441458] linearizableReadLoop","detail":"{readStateIndex:1452; appliedIndex:1451; }","duration":"297.322194ms","start":"2026-05-19T18:48:39.821865Z","end":"2026-05-19T18:48:40.119187Z","steps":["trace[1923441458] 'read index received' (duration: 297.226739ms)","trace[1923441458] 'applied index is now lower than readState.Index' (duration: 93.805µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:40.119301Z","caller":"traceutil/trace.go:171","msg":"trace[1072995972] transaction","detail":"{read_only:false; response_revision:1401; number_of_response:1; }","duration":"354.772652ms","start":"2026-05-19T18:48:39.764488Z","end":"2026-05-19T18:48:40.11926Z","steps":["trace[1072995972] 'process raft request' (duration: 354.563701ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:40.119465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.664327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:service-controller\" ","response":"range_response_count:1 size:747"} {"level":"warn","ts":"2026-05-19T18:48:40.119492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:48:39.764453Z","time spent":"354.935689ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:48:40.119504Z","caller":"traceutil/trace.go:171","msg":"trace[1083599089] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:service-controller; range_end:; response_count:1; response_revision:1401; }","duration":"257.700678ms","start":"2026-05-19T18:48:39.861793Z","end":"2026-05-19T18:48:40.119494Z","steps":["trace[1083599089] 'agreement among raft nodes before linearized reading' (duration: 257.644446ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:40.11935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.480401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:service-account-controller\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-05-19T18:48:40.119605Z","caller":"traceutil/trace.go:171","msg":"trace[1188661680] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:service-account-controller; range_end:; response_count:1; response_revision:1401; }","duration":"297.782477ms","start":"2026-05-19T18:48:39.821798Z","end":"2026-05-19T18:48:40.11958Z","steps":["trace[1188661680] 'agreement among raft nodes before linearized reading' (duration: 297.498392ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:40.119786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.406105ms","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-19T18:48:40.119817Z","caller":"traceutil/trace.go:171","msg":"trace[1535809762] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1401; }","duration":"293.459477ms","start":"2026-05-19T18:48:39.826352Z","end":"2026-05-19T18:48:40.119811Z","steps":["trace[1535809762] 'agreement among raft nodes before linearized reading' (duration: 293.024465ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:40.120176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.299849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T18:48:40.120235Z","caller":"traceutil/trace.go:171","msg":"trace[581090501] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1401; }","duration":"126.361302ms","start":"2026-05-19T18:48:39.993861Z","end":"2026-05-19T18:48:40.120222Z","steps":["trace[581090501] 'agreement among raft nodes before linearized reading' (duration: 125.551201ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:41.604407Z","caller":"traceutil/trace.go:171","msg":"trace[1350754705] linearizableReadLoop","detail":"{readStateIndex:1456; appliedIndex:1455; }","duration":"193.802204ms","start":"2026-05-19T18:48:41.410588Z","end":"2026-05-19T18:48:41.604391Z","steps":["trace[1350754705] 'read index received' (duration: 193.700719ms)","trace[1350754705] 'applied index is now lower than readState.Index' (duration: 100.355µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:41.604672Z","caller":"traceutil/trace.go:171","msg":"trace[992587465] transaction","detail":"{read_only:false; response_revision:1405; number_of_response:1; }","duration":"210.482534ms","start":"2026-05-19T18:48:41.394182Z","end":"2026-05-19T18:48:41.604664Z","steps":["trace[992587465] 'process raft request' (duration: 210.093474ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:41.60489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.29437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-05-19T18:48:41.604912Z","caller":"traceutil/trace.go:171","msg":"trace[562015297] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:1405; }","duration":"194.355402ms","start":"2026-05-19T18:48:41.410551Z","end":"2026-05-19T18:48:41.604907Z","steps":["trace[562015297] 'agreement among raft nodes before linearized reading' (duration: 194.222636ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:41.605027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.779077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:1 size:339"} {"level":"info","ts":"2026-05-19T18:48:41.605101Z","caller":"traceutil/trace.go:171","msg":"trace[744862208] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:1; response_revision:1405; }","duration":"164.906673ms","start":"2026-05-19T18:48:41.440176Z","end":"2026-05-19T18:48:41.605083Z","steps":["trace[744862208] 'agreement among raft nodes before linearized reading' (duration: 164.715834ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:41.605121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.000141ms","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-19T18:48:41.605183Z","caller":"traceutil/trace.go:171","msg":"trace[453819462] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1405; }","duration":"146.066525ms","start":"2026-05-19T18:48:41.4591Z","end":"2026-05-19T18:48:41.605167Z","steps":["trace[453819462] 'agreement among raft nodes before linearized reading' (duration: 145.870305ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:42.236154Z","caller":"traceutil/trace.go:171","msg":"trace[1651874671] linearizableReadLoop","detail":"{readStateIndex:1458; appliedIndex:1457; }","duration":"102.865731ms","start":"2026-05-19T18:48:42.133261Z","end":"2026-05-19T18:48:42.236126Z","steps":["trace[1651874671] 'read index received' (duration: 102.777297ms)","trace[1651874671] 'applied index is now lower than readState.Index' (duration: 87.144µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:42.236299Z","caller":"traceutil/trace.go:171","msg":"trace[69104372] transaction","detail":"{read_only:false; response_revision:1407; number_of_response:1; }","duration":"108.251996ms","start":"2026-05-19T18:48:42.128031Z","end":"2026-05-19T18:48:42.236283Z","steps":["trace[69104372] 'process raft request' (duration: 107.903408ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:42.236592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.305973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T18:48:42.236661Z","caller":"traceutil/trace.go:171","msg":"trace[2028469075] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1407; }","duration":"103.429279ms","start":"2026-05-19T18:48:42.133216Z","end":"2026-05-19T18:48:42.236646Z","steps":["trace[2028469075] 'agreement among raft nodes before linearized reading' (duration: 103.228939ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:42.252411Z","caller":"traceutil/trace.go:171","msg":"trace[2133972225] transaction","detail":"{read_only:false; response_revision:1408; number_of_response:1; }","duration":"117.662466ms","start":"2026-05-19T18:48:42.134729Z","end":"2026-05-19T18:48:42.252392Z","steps":["trace[2133972225] 'process raft request' (duration: 117.57771ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:42.406041Z","caller":"traceutil/trace.go:171","msg":"trace[1962344370] linearizableReadLoop","detail":"{readStateIndex:1461; appliedIndex:1459; }","duration":"149.636897ms","start":"2026-05-19T18:48:42.256382Z","end":"2026-05-19T18:48:42.406019Z","steps":["trace[1962344370] 'read index received' (duration: 30.859785ms)","trace[1962344370] 'applied index is now lower than readState.Index' (duration: 118.775832ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:42.406093Z","caller":"traceutil/trace.go:171","msg":"trace[395431558] transaction","detail":"{read_only:false; response_revision:1411; number_of_response:1; }","duration":"149.360224ms","start":"2026-05-19T18:48:42.256711Z","end":"2026-05-19T18:48:42.406071Z","steps":["trace[395431558] 'process raft request' (duration: 149.264159ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:42.406291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.88573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/local-path-storage\" ","response":"range_response_count:1 size:404"} {"level":"info","ts":"2026-05-19T18:48:42.406081Z","caller":"traceutil/trace.go:171","msg":"trace[2124433300] transaction","detail":"{read_only:false; response_revision:1410; number_of_response:1; }","duration":"149.833208ms","start":"2026-05-19T18:48:42.256216Z","end":"2026-05-19T18:48:42.406049Z","steps":["trace[2124433300] 'process raft request' (duration: 85.61089ms)","trace[2124433300] 'compare' (duration: 64.028008ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:42.406348Z","caller":"traceutil/trace.go:171","msg":"trace[1924306734] range","detail":"{range_begin:/registry/namespaces/local-path-storage; range_end:; response_count:1; response_revision:1411; }","duration":"149.978275ms","start":"2026-05-19T18:48:42.256356Z","end":"2026-05-19T18:48:42.406334Z","steps":["trace[1924306734] 'agreement among raft nodes before linearized reading' (duration: 149.794976ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:43.903872Z","caller":"traceutil/trace.go:171","msg":"trace[871162672] linearizableReadLoop","detail":"{readStateIndex:1464; appliedIndex:1463; }","duration":"279.648924ms","start":"2026-05-19T18:48:43.624202Z","end":"2026-05-19T18:48:43.903851Z","steps":["trace[871162672] 'read index received' (duration: 279.525688ms)","trace[871162672] 'applied index is now lower than readState.Index' (duration: 121.936µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:43.904013Z","caller":"traceutil/trace.go:171","msg":"trace[529620192] transaction","detail":"{read_only:false; response_revision:1412; number_of_response:1; }","duration":"286.61304ms","start":"2026-05-19T18:48:43.61739Z","end":"2026-05-19T18:48:43.904003Z","steps":["trace[529620192] 'process raft request' (duration: 286.318285ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:43.904162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.938918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/envoy-gateway-system/\" range_end:\"/registry/daemonsets/envoy-gateway-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:48:43.904244Z","caller":"traceutil/trace.go:171","msg":"trace[1146242363] range","detail":"{range_begin:/registry/daemonsets/envoy-gateway-system/; range_end:/registry/daemonsets/envoy-gateway-system0; response_count:0; response_revision:1412; }","duration":"280.061155ms","start":"2026-05-19T18:48:43.624169Z","end":"2026-05-19T18:48:43.90423Z","steps":["trace[1146242363] 'agreement among raft nodes before linearized reading' (duration: 279.946439ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:43.904504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.969319ms","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-19T18:48:43.90451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.244271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/envoy-gateway-system/kube-root-ca.crt\" ","response":"range_response_count:1 size:1764"} {"level":"info","ts":"2026-05-19T18:48:43.904567Z","caller":"traceutil/trace.go:171","msg":"trace[228519305] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1412; }","duration":"229.060184ms","start":"2026-05-19T18:48:43.675491Z","end":"2026-05-19T18:48:43.904552Z","steps":["trace[228519305] 'agreement among raft nodes before linearized reading' (duration: 228.908866ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:43.904579Z","caller":"traceutil/trace.go:171","msg":"trace[1027961580] range","detail":"{range_begin:/registry/configmaps/envoy-gateway-system/kube-root-ca.crt; range_end:; response_count:1; response_revision:1412; }","duration":"227.342476ms","start":"2026-05-19T18:48:43.67722Z","end":"2026-05-19T18:48:43.904562Z","steps":["trace[1027961580] 'agreement among raft nodes before linearized reading' (duration: 227.159797ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:43.904596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.861015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/default/\" range_end:\"/registry/deployments/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:48:43.904671Z","caller":"traceutil/trace.go:171","msg":"trace[1095831208] range","detail":"{range_begin:/registry/deployments/default/; range_end:/registry/deployments/default0; response_count:0; response_revision:1412; }","duration":"204.926539ms","start":"2026-05-19T18:48:43.699722Z","end":"2026-05-19T18:48:43.904649Z","steps":["trace[1095831208] 'agreement among raft nodes before linearized reading' (duration: 204.833425ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:43.904693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.799912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:48:43.904723Z","caller":"traceutil/trace.go:171","msg":"trace[253634825] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1412; }","duration":"263.860816ms","start":"2026-05-19T18:48:43.640854Z","end":"2026-05-19T18:48:43.904715Z","steps":["trace[253634825] 'agreement among raft nodes before linearized reading' (duration: 263.479566ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:43.904504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.94194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:48:43.905057Z","caller":"traceutil/trace.go:171","msg":"trace[1601057086] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1412; }","duration":"222.5477ms","start":"2026-05-19T18:48:43.682494Z","end":"2026-05-19T18:48:43.905042Z","steps":["trace[1601057086] 'agreement among raft nodes before linearized reading' (duration: 221.857695ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:44.617589Z","caller":"traceutil/trace.go:171","msg":"trace[1585465899] linearizableReadLoop","detail":"{readStateIndex:1470; appliedIndex:1468; }","duration":"112.464492ms","start":"2026-05-19T18:48:44.505101Z","end":"2026-05-19T18:48:44.617566Z","steps":["trace[1585465899] 'read index received' (duration: 8.823903ms)","trace[1585465899] 'applied index is now lower than readState.Index' (duration: 103.639429ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:44.617688Z","caller":"traceutil/trace.go:171","msg":"trace[1376044251] transaction","detail":"{read_only:false; response_revision:1418; number_of_response:1; }","duration":"181.721287ms","start":"2026-05-19T18:48:44.435923Z","end":"2026-05-19T18:48:44.617644Z","steps":["trace[1376044251] 'process raft request' (duration: 181.505526ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:44.617754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.62295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-05-19T18:48:44.617793Z","caller":"traceutil/trace.go:171","msg":"trace[1698607156] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1418; }","duration":"112.710475ms","start":"2026-05-19T18:48:44.505073Z","end":"2026-05-19T18:48:44.617784Z","steps":["trace[1698607156] 'agreement among raft nodes before linearized reading' (duration: 112.60959ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:44.902047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.603479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/\" range_end:\"/registry/rolebindings/envoy-gateway-system0\" limit:500 ","response":"range_response_count:3 size:3302"} {"level":"info","ts":"2026-05-19T18:48:44.902108Z","caller":"traceutil/trace.go:171","msg":"trace[1654248091] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/; range_end:/registry/rolebindings/envoy-gateway-system0; response_count:3; response_revision:1418; }","duration":"127.710935ms","start":"2026-05-19T18:48:44.774385Z","end":"2026-05-19T18:48:44.902096Z","steps":["trace[1654248091] 'range keys from in-memory index tree' (duration: 127.42318ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:46.639736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.717764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-node-lease/\" range_end:\"/registry/pods/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:48:46.639825Z","caller":"traceutil/trace.go:171","msg":"trace[105073882] range","detail":"{range_begin:/registry/pods/kube-node-lease/; range_end:/registry/pods/kube-node-lease0; response_count:0; response_revision:1422; }","duration":"111.8255ms","start":"2026-05-19T18:48:46.527979Z","end":"2026-05-19T18:48:46.639805Z","steps":["trace[105073882] 'range keys from in-memory index tree' (duration: 111.679663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:46.64011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.766224ms","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-19T18:48:46.640177Z","caller":"traceutil/trace.go:171","msg":"trace[605086358] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1422; }","duration":"122.859529ms","start":"2026-05-19T18:48:46.5173Z","end":"2026-05-19T18:48:46.640159Z","steps":["trace[605086358] 'range keys from in-memory index tree' (duration: 122.234797ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:46.956986Z","caller":"traceutil/trace.go:171","msg":"trace[1515648130] transaction","detail":"{read_only:false; response_revision:1423; number_of_response:1; }","duration":"310.302601ms","start":"2026-05-19T18:48:46.646654Z","end":"2026-05-19T18:48:46.956956Z","steps":["trace[1515648130] 'process raft request' (duration: 310.024907ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:46.957144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:48:46.646606Z","time spent":"310.454508ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:48:47.116926Z","caller":"traceutil/trace.go:171","msg":"trace[592999371] linearizableReadLoop","detail":"{readStateIndex:1476; appliedIndex:1474; }","duration":"397.539648ms","start":"2026-05-19T18:48:46.71936Z","end":"2026-05-19T18:48:47.1169Z","steps":["trace[592999371] 'read index received' (duration: 237.296055ms)","trace[592999371] 'applied index is now lower than readState.Index' (duration: 160.242273ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:47.117011Z","caller":"traceutil/trace.go:171","msg":"trace[496539250] transaction","detail":"{read_only:false; response_revision:1424; number_of_response:1; }","duration":"469.455608ms","start":"2026-05-19T18:48:46.647532Z","end":"2026-05-19T18:48:47.116988Z","steps":["trace[496539250] 'process raft request' (duration: 466.602851ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:47.11711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.722377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-public/\" range_end:\"/registry/rolebindings/kube-public0\" limit:500 ","response":"range_response_count:2 size:1230"} {"level":"warn","ts":"2026-05-19T18:48:47.117124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:48:46.647506Z","time spent":"469.554053ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:48:47.117163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.078433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-05-19T18:48:47.117165Z","caller":"traceutil/trace.go:171","msg":"trace[1713822765] range","detail":"{range_begin:/registry/rolebindings/kube-public/; range_end:/registry/rolebindings/kube-public0; response_count:2; response_revision:1424; }","duration":"397.819662ms","start":"2026-05-19T18:48:46.719332Z","end":"2026-05-19T18:48:47.117151Z","steps":["trace[1713822765] 'agreement among raft nodes before linearized reading' (duration: 397.696875ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:47.117197Z","caller":"traceutil/trace.go:171","msg":"trace[492085427] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway; range_end:; response_count:1; response_revision:1424; }","duration":"397.127877ms","start":"2026-05-19T18:48:46.720058Z","end":"2026-05-19T18:48:47.117186Z","steps":["trace[492085427] 'agreement among raft nodes before linearized reading' (duration: 396.99815ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:47.117227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:48:46.720054Z","time spent":"397.165608ms","remote":"127.0.0.1:54792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":870,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" "} {"level":"warn","ts":"2026-05-19T18:48:47.117267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.0483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/kube-public/\" range_end:\"/registry/persistentvolumeclaims/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T18:48:47.117205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:48:46.719319Z","time spent":"397.875375ms","remote":"127.0.0.1:54916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":2,"response size":1254,"request content":"key:\"/registry/rolebindings/kube-public/\" range_end:\"/registry/rolebindings/kube-public0\" limit:500 "} {"level":"info","ts":"2026-05-19T18:48:47.11732Z","caller":"traceutil/trace.go:171","msg":"trace[669107869] range","detail":"{range_begin:/registry/persistentvolumeclaims/kube-public/; range_end:/registry/persistentvolumeclaims/kube-public0; response_count:0; response_revision:1424; }","duration":"383.133134ms","start":"2026-05-19T18:48:46.734171Z","end":"2026-05-19T18:48:47.117304Z","steps":["trace[669107869] 'agreement among raft nodes before linearized reading' (duration: 383.005887ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:47.117325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.036593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:833"} {"level":"warn","ts":"2026-05-19T18:48:47.117365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:48:46.734159Z","time spent":"383.196407ms","remote":"127.0.0.1:54732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumeclaims/kube-public/\" range_end:\"/registry/persistentvolumeclaims/kube-public0\" limit:500 "} {"level":"info","ts":"2026-05-19T18:48:47.117405Z","caller":"traceutil/trace.go:171","msg":"trace[1671854386] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:1424; }","duration":"392.133479ms","start":"2026-05-19T18:48:46.72525Z","end":"2026-05-19T18:48:47.117384Z","steps":["trace[1671854386] 'agreement among raft nodes before linearized reading' (duration: 391.936229ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:47.117447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:48:46.725245Z","time spent":"392.193132ms","remote":"127.0.0.1:54792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":857,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-05-19T18:48:48.080693Z","caller":"traceutil/trace.go:171","msg":"trace[1546226318] linearizableReadLoop","detail":"{readStateIndex:1477; appliedIndex:1476; }","duration":"180.077775ms","start":"2026-05-19T18:48:47.900591Z","end":"2026-05-19T18:48:48.080668Z","steps":["trace[1546226318] 'read index received' (duration: 180.030653ms)","trace[1546226318] 'applied index is now lower than readState.Index' (duration: 45.472µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:48:48.080857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.229353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-public/kubeadm:bootstrap-signer-clusterinfo\" ","response":"range_response_count:1 size:371"} {"level":"info","ts":"2026-05-19T18:48:48.08094Z","caller":"traceutil/trace.go:171","msg":"trace[319120360] range","detail":"{range_begin:/registry/roles/kube-public/kubeadm:bootstrap-signer-clusterinfo; range_end:; response_count:1; response_revision:1424; }","duration":"180.35654ms","start":"2026-05-19T18:48:47.900564Z","end":"2026-05-19T18:48:48.08092Z","steps":["trace[319120360] 'agreement among raft nodes before linearized reading' (duration: 180.189192ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:48.15715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.065616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/kube-system/\" range_end:\"/registry/cronjobs/kube-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T18:48:48.157235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.363075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/kube-node-lease/\" range_end:\"/registry/statefulsets/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:48:48.157217Z","caller":"traceutil/trace.go:171","msg":"trace[502084952] transaction","detail":"{read_only:false; response_revision:1425; number_of_response:1; }","duration":"187.450788ms","start":"2026-05-19T18:48:47.969733Z","end":"2026-05-19T18:48:48.157183Z","steps":["trace[502084952] 'process raft request' (duration: 187.10921ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:48.157314Z","caller":"traceutil/trace.go:171","msg":"trace[1419544702] range","detail":"{range_begin:/registry/statefulsets/kube-node-lease/; range_end:/registry/statefulsets/kube-node-lease0; response_count:0; response_revision:1425; }","duration":"246.497462ms","start":"2026-05-19T18:48:47.910793Z","end":"2026-05-19T18:48:48.157291Z","steps":["trace[1419544702] 'agreement among raft nodes before linearized reading' (duration: 246.321873ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:48.157343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.558278ms","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-19T18:48:48.157281Z","caller":"traceutil/trace.go:171","msg":"trace[194669804] range","detail":"{range_begin:/registry/cronjobs/kube-system/; range_end:/registry/cronjobs/kube-system0; response_count:0; response_revision:1425; }","duration":"198.215604ms","start":"2026-05-19T18:48:47.959046Z","end":"2026-05-19T18:48:48.157262Z","steps":["trace[194669804] 'agreement among raft nodes before linearized reading' (duration: 198.003373ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:48.157422Z","caller":"traceutil/trace.go:171","msg":"trace[1069082989] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1425; }","duration":"167.665134ms","start":"2026-05-19T18:48:47.989734Z","end":"2026-05-19T18:48:48.157399Z","steps":["trace[1069082989] 'agreement among raft nodes before linearized reading' (duration: 167.482644ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:48.157156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.914966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-public/system:controller:bootstrap-signer\" ","response":"range_response_count:1 size:709"} {"level":"info","ts":"2026-05-19T18:48:48.157593Z","caller":"traceutil/trace.go:171","msg":"trace[372087916] range","detail":"{range_begin:/registry/roles/kube-public/system:controller:bootstrap-signer; range_end:; response_count:1; response_revision:1425; }","duration":"231.38888ms","start":"2026-05-19T18:48:47.926185Z","end":"2026-05-19T18:48:48.157574Z","steps":["trace[372087916] 'agreement among raft nodes before linearized reading' (duration: 230.862723ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:48.293556Z","caller":"traceutil/trace.go:171","msg":"trace[1292498822] transaction","detail":"{read_only:false; response_revision:1426; number_of_response:1; }","duration":"211.011223ms","start":"2026-05-19T18:48:48.082511Z","end":"2026-05-19T18:48:48.293522Z","steps":["trace[1292498822] 'process raft request' (duration: 133.483003ms)","trace[1292498822] 'compare' (duration: 77.305929ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:48.293593Z","caller":"traceutil/trace.go:171","msg":"trace[655266362] transaction","detail":"{read_only:false; response_revision:1427; number_of_response:1; }","duration":"132.160683ms","start":"2026-05-19T18:48:48.161416Z","end":"2026-05-19T18:48:48.293577Z","steps":["trace[655266362] 'process raft request' (duration: 132.08796ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:48.293731Z","caller":"traceutil/trace.go:171","msg":"trace[1862798179] linearizableReadLoop","detail":"{readStateIndex:1479; appliedIndex:1478; }","duration":"136.590574ms","start":"2026-05-19T18:48:48.157023Z","end":"2026-05-19T18:48:48.293613Z","steps":["trace[1862798179] 'read index received' (duration: 58.984249ms)","trace[1862798179] 'applied index is now lower than readState.Index' (duration: 77.602985ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:48:48.293965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.284919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-public/kubeadm:bootstrap-signer-clusterinfo\" ","response":"range_response_count:1 size:371"} {"level":"info","ts":"2026-05-19T18:48:48.294069Z","caller":"traceutil/trace.go:171","msg":"trace[706370053] range","detail":"{range_begin:/registry/roles/kube-public/kubeadm:bootstrap-signer-clusterinfo; range_end:; response_count:1; response_revision:1427; }","duration":"142.432986ms","start":"2026-05-19T18:48:48.151612Z","end":"2026-05-19T18:48:48.294045Z","steps":["trace[706370053] 'agreement among raft nodes before linearized reading' (duration: 142.256067ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:49.15825Z","caller":"traceutil/trace.go:171","msg":"trace[1435385060] linearizableReadLoop","detail":"{readStateIndex:1483; appliedIndex:1482; }","duration":"191.718853ms","start":"2026-05-19T18:48:48.966506Z","end":"2026-05-19T18:48:49.158224Z","steps":["trace[1435385060] 'read index received' (duration: 191.551354ms)","trace[1435385060] 'applied index is now lower than readState.Index' (duration: 166.019µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:49.158344Z","caller":"traceutil/trace.go:171","msg":"trace[2130370127] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"194.522448ms","start":"2026-05-19T18:48:48.963784Z","end":"2026-05-19T18:48:49.158306Z","steps":["trace[2130370127] 'process raft request' (duration: 194.245524ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:49.158428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.902242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kube-proxy\" ","response":"range_response_count:1 size:1948"} {"level":"info","ts":"2026-05-19T18:48:49.158462Z","caller":"traceutil/trace.go:171","msg":"trace[1876249430] range","detail":"{range_begin:/registry/configmaps/kube-system/kube-proxy; range_end:; response_count:1; response_revision:1430; }","duration":"191.966465ms","start":"2026-05-19T18:48:48.966485Z","end":"2026-05-19T18:48:49.158452Z","steps":["trace[1876249430] 'agreement among raft nodes before linearized reading' (duration: 191.876151ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:49.158462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.890568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/local-path-storage/\" range_end:\"/registry/ingress/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T18:48:49.158495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.997207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kube-root-ca.crt\" ","response":"range_response_count:1 size:1746"} {"level":"info","ts":"2026-05-19T18:48:49.158531Z","caller":"traceutil/trace.go:171","msg":"trace[90039279] range","detail":"{range_begin:/registry/ingress/local-path-storage/; range_end:/registry/ingress/local-path-storage0; response_count:0; response_revision:1430; }","duration":"147.997155ms","start":"2026-05-19T18:48:49.010517Z","end":"2026-05-19T18:48:49.158514Z","steps":["trace[90039279] 'agreement among raft nodes before linearized reading' (duration: 147.879008ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:49.158563Z","caller":"traceutil/trace.go:171","msg":"trace[1003421096] range","detail":"{range_begin:/registry/configmaps/kube-system/kube-root-ca.crt; range_end:; response_count:1; response_revision:1430; }","duration":"124.094232ms","start":"2026-05-19T18:48:49.034451Z","end":"2026-05-19T18:48:49.158545Z","steps":["trace[1003421096] 'agreement among raft nodes before linearized reading' (duration: 123.954985ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:49.158847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.684952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/\" range_end:\"/registry/rolebindings/kube-system0\" limit:500 ","response":"range_response_count:11 size:7467"} {"level":"info","ts":"2026-05-19T18:48:49.15888Z","caller":"traceutil/trace.go:171","msg":"trace[691601398] range","detail":"{range_begin:/registry/rolebindings/kube-system/; range_end:/registry/rolebindings/kube-system0; response_count:11; response_revision:1430; }","duration":"139.735005ms","start":"2026-05-19T18:48:49.019136Z","end":"2026-05-19T18:48:49.158871Z","steps":["trace[691601398] 'agreement among raft nodes before linearized reading' (duration: 139.609418ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:50.5416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.136608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-j4l6m\" ","response":"range_response_count:1 size:4901"} {"level":"info","ts":"2026-05-19T18:48:50.541705Z","caller":"traceutil/trace.go:171","msg":"trace[946600648] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-j4l6m; range_end:; response_count:1; response_revision:1434; }","duration":"100.249473ms","start":"2026-05-19T18:48:50.44143Z","end":"2026-05-19T18:48:50.54168Z","steps":["trace[946600648] 'range keys from in-memory index tree' (duration: 99.946998ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:50.541767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.553292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-xgn4j\" ","response":"range_response_count:1 size:4907"} {"level":"info","ts":"2026-05-19T18:48:50.541819Z","caller":"traceutil/trace.go:171","msg":"trace[935494194] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-xgn4j; range_end:; response_count:1; response_revision:1434; }","duration":"162.634526ms","start":"2026-05-19T18:48:50.37917Z","end":"2026-05-19T18:48:50.541804Z","steps":["trace[935494194] 'range keys from in-memory index tree' (duration: 162.339121ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:50.900256Z","caller":"traceutil/trace.go:171","msg":"trace[1945181104] linearizableReadLoop","detail":"{readStateIndex:1488; appliedIndex:1487; }","duration":"353.763516ms","start":"2026-05-19T18:48:50.546465Z","end":"2026-05-19T18:48:50.900228Z","steps":["trace[1945181104] 'read index received' (duration: 353.517973ms)","trace[1945181104] 'applied index is now lower than readState.Index' (duration: 243.953µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:50.900324Z","caller":"traceutil/trace.go:171","msg":"trace[617404950] transaction","detail":"{read_only:false; response_revision:1435; number_of_response:1; }","duration":"353.84434ms","start":"2026-05-19T18:48:50.546442Z","end":"2026-05-19T18:48:50.900287Z","steps":["trace[617404950] 'process raft request' (duration: 353.617668ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:50.900561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:48:50.546432Z","time spent":"353.973607ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:48:50.900678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.189319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-j4l6m\" ","response":"range_response_count:1 size:4901"} {"level":"info","ts":"2026-05-19T18:48:50.900767Z","caller":"traceutil/trace.go:171","msg":"trace[2082650010] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-j4l6m; range_end:; response_count:1; response_revision:1435; }","duration":"354.294955ms","start":"2026-05-19T18:48:50.546429Z","end":"2026-05-19T18:48:50.900724Z","steps":["trace[2082650010] 'agreement among raft nodes before linearized reading' (duration: 353.917634ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:50.900853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:48:50.546409Z","time spent":"354.422891ms","remote":"127.0.0.1:54768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":4925,"request content":"key:\"/registry/pods/kube-system/coredns-67659f764b-j4l6m\" "} {"level":"warn","ts":"2026-05-19T18:48:50.900979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.934846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-xgn4j\" ","response":"range_response_count:1 size:4907"} {"level":"warn","ts":"2026-05-19T18:48:50.901543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.040687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:48:50.901522Z","caller":"traceutil/trace.go:171","msg":"trace[1287165248] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-xgn4j; range_end:; response_count:1; response_revision:1435; }","duration":"279.532207ms","start":"2026-05-19T18:48:50.621973Z","end":"2026-05-19T18:48:50.901505Z","steps":["trace[1287165248] 'agreement among raft nodes before linearized reading' (duration: 278.748617ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:50.901679Z","caller":"traceutil/trace.go:171","msg":"trace[1472971386] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1435; }","duration":"258.212116ms","start":"2026-05-19T18:48:50.643421Z","end":"2026-05-19T18:48:50.901633Z","steps":["trace[1472971386] 'agreement among raft nodes before linearized reading' (duration: 257.373422ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:52.37219Z","caller":"traceutil/trace.go:171","msg":"trace[928684208] transaction","detail":"{read_only:false; response_revision:1438; number_of_response:1; }","duration":"108.048949ms","start":"2026-05-19T18:48:52.264112Z","end":"2026-05-19T18:48:52.372161Z","steps":["trace[928684208] 'process raft request' (duration: 107.844308ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:52.617371Z","caller":"traceutil/trace.go:171","msg":"trace[1690420282] linearizableReadLoop","detail":"{readStateIndex:1494; appliedIndex:1492; }","duration":"172.771206ms","start":"2026-05-19T18:48:52.444574Z","end":"2026-05-19T18:48:52.617345Z","steps":["trace[1690420282] 'read index received' (duration: 172.481301ms)","trace[1690420282] 'applied index is now lower than readState.Index' (duration: 288.245µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:52.617534Z","caller":"traceutil/trace.go:171","msg":"trace[1359472141] transaction","detail":"{read_only:false; response_revision:1441; number_of_response:1; }","duration":"198.576587ms","start":"2026-05-19T18:48:52.418941Z","end":"2026-05-19T18:48:52.617518Z","steps":["trace[1359472141] 'process raft request' (duration: 198.321364ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:52.6176Z","caller":"traceutil/trace.go:171","msg":"trace[1076287018] transaction","detail":"{read_only:false; response_revision:1440; number_of_response:1; }","duration":"239.828698ms","start":"2026-05-19T18:48:52.377743Z","end":"2026-05-19T18:48:52.617572Z","steps":["trace[1076287018] 'process raft request' (duration: 239.09908ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:52.617762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.027681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system:controller:token-cleaner\" ","response":"range_response_count:1 size:729"} {"level":"info","ts":"2026-05-19T18:48:52.617827Z","caller":"traceutil/trace.go:171","msg":"trace[112702144] range","detail":"{range_begin:/registry/rolebindings/kube-system/system:controller:token-cleaner; range_end:; response_count:1; response_revision:1441; }","duration":"118.103215ms","start":"2026-05-19T18:48:52.499709Z","end":"2026-05-19T18:48:52.617813Z","steps":["trace[112702144] 'agreement among raft nodes before linearized reading' (duration: 117.967837ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:52.617845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.20764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system:controller:cloud-provider\" ","response":"range_response_count:1 size:733"} {"level":"info","ts":"2026-05-19T18:48:52.617957Z","caller":"traceutil/trace.go:171","msg":"trace[147581134] range","detail":"{range_begin:/registry/rolebindings/kube-system/system:controller:cloud-provider; range_end:; response_count:1; response_revision:1441; }","duration":"173.371258ms","start":"2026-05-19T18:48:52.44456Z","end":"2026-05-19T18:48:52.617931Z","steps":["trace[147581134] 'agreement among raft nodes before linearized reading' (duration: 173.152907ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:54.534345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.914905ms","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-19T18:48:54.534426Z","caller":"traceutil/trace.go:171","msg":"trace[304831210] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1446; }","duration":"107.0087ms","start":"2026-05-19T18:48:54.427399Z","end":"2026-05-19T18:48:54.534408Z","steps":["trace[304831210] 'range keys from in-memory index tree' (duration: 106.766727ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:54.534778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.808458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:85 size:63190"} {"level":"info","ts":"2026-05-19T18:48:54.534858Z","caller":"traceutil/trace.go:171","msg":"trace[1170184410] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:85; response_revision:1446; }","duration":"102.916134ms","start":"2026-05-19T18:48:54.431924Z","end":"2026-05-19T18:48:54.53484Z","steps":["trace[1170184410] 'range keys from in-memory index tree' (duration: 102.378146ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:54.679054Z","caller":"traceutil/trace.go:171","msg":"trace[662044289] linearizableReadLoop","detail":"{readStateIndex:1501; appliedIndex:1500; }","duration":"135.105858ms","start":"2026-05-19T18:48:54.543923Z","end":"2026-05-19T18:48:54.679029Z","steps":["trace[662044289] 'read index received' (duration: 134.809532ms)","trace[662044289] 'applied index is now lower than readState.Index' (duration: 295.146µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:54.679174Z","caller":"traceutil/trace.go:171","msg":"trace[569776279] transaction","detail":"{read_only:false; response_revision:1447; number_of_response:1; }","duration":"140.773536ms","start":"2026-05-19T18:48:54.538365Z","end":"2026-05-19T18:48:54.679139Z","steps":["trace[569776279] 'process raft request' (duration: 140.469401ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:54.679246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.290497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T18:48:54.679295Z","caller":"traceutil/trace.go:171","msg":"trace[1275720554] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1447; }","duration":"135.386212ms","start":"2026-05-19T18:48:54.543895Z","end":"2026-05-19T18:48:54.679281Z","steps":["trace[1275720554] 'agreement among raft nodes before linearized reading' (duration: 135.288117ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:55.122005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.306656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-05-19T18:48:55.12209Z","caller":"traceutil/trace.go:171","msg":"trace[1246727154] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:1449; }","duration":"103.458623ms","start":"2026-05-19T18:48:55.018613Z","end":"2026-05-19T18:48:55.122072Z","steps":["trace[1246727154] 'range keys from in-memory index tree' (duration: 103.209291ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:56.556753Z","caller":"traceutil/trace.go:171","msg":"trace[542497780] linearizableReadLoop","detail":"{readStateIndex:1506; appliedIndex:1505; }","duration":"154.939658ms","start":"2026-05-19T18:48:56.401789Z","end":"2026-05-19T18:48:56.556728Z","steps":["trace[542497780] 'read index received' (duration: 154.756508ms)","trace[542497780] 'applied index is now lower than readState.Index' (duration: 182.05µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:48:56.556802Z","caller":"traceutil/trace.go:171","msg":"trace[1672146119] transaction","detail":"{read_only:false; response_revision:1452; number_of_response:1; }","duration":"157.064689ms","start":"2026-05-19T18:48:56.399716Z","end":"2026-05-19T18:48:56.556781Z","steps":["trace[1672146119] 'process raft request' (duration: 156.878649ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:56.556951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.11727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:1 size:205"} {"level":"info","ts":"2026-05-19T18:48:56.557007Z","caller":"traceutil/trace.go:171","msg":"trace[2126868422] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:1; response_revision:1452; }","duration":"138.210954ms","start":"2026-05-19T18:48:56.418782Z","end":"2026-05-19T18:48:56.556993Z","steps":["trace[2126868422] 'agreement among raft nodes before linearized reading' (duration: 138.085548ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:56.557013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.898508ms","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-19T18:48:56.557119Z","caller":"traceutil/trace.go:171","msg":"trace[2005547336] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1452; }","duration":"114.046117ms","start":"2026-05-19T18:48:56.443053Z","end":"2026-05-19T18:48:56.557099Z","steps":["trace[2005547336] 'agreement among raft nodes before linearized reading' (duration: 113.858897ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:56.557046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.224443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-05-19T18:48:56.557711Z","caller":"traceutil/trace.go:171","msg":"trace[1811936617] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:1452; }","duration":"155.885738ms","start":"2026-05-19T18:48:56.401768Z","end":"2026-05-19T18:48:56.557653Z","steps":["trace[1811936617] 'agreement among raft nodes before linearized reading' (duration: 155.062405ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:56.803858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.848032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:1 size:205"} {"level":"warn","ts":"2026-05-19T18:48:56.803968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.508762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-05-19T18:48:56.804032Z","caller":"traceutil/trace.go:171","msg":"trace[1488758064] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:1452; }","duration":"171.616317ms","start":"2026-05-19T18:48:56.632405Z","end":"2026-05-19T18:48:56.804022Z","steps":["trace[1488758064] 'range keys from in-memory index tree' (duration: 171.418746ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:56.80406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.448407ms","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-19T18:48:56.804152Z","caller":"traceutil/trace.go:171","msg":"trace[1288055642] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1452; }","duration":"121.586795ms","start":"2026-05-19T18:48:56.68254Z","end":"2026-05-19T18:48:56.804127Z","steps":["trace[1288055642] 'range keys from in-memory index tree' (duration: 121.196073ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:56.803876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.417275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:48:56.804304Z","caller":"traceutil/trace.go:171","msg":"trace[275135953] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1452; }","duration":"163.8969ms","start":"2026-05-19T18:48:56.640393Z","end":"2026-05-19T18:48:56.80429Z","steps":["trace[275135953] 'range keys from in-memory index tree' (duration: 163.326961ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:56.804506Z","caller":"traceutil/trace.go:171","msg":"trace[1213615171] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:1; response_revision:1452; }","duration":"168.987169ms","start":"2026-05-19T18:48:56.63495Z","end":"2026-05-19T18:48:56.803937Z","steps":["trace[1213615171] 'range keys from in-memory index tree' (duration: 168.744775ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:56.957701Z","caller":"traceutil/trace.go:171","msg":"trace[30203574] linearizableReadLoop","detail":"{readStateIndex:1508; appliedIndex:1506; }","duration":"149.451167ms","start":"2026-05-19T18:48:56.808221Z","end":"2026-05-19T18:48:56.957672Z","steps":["trace[30203574] 'read index received' (duration: 54.29787ms)","trace[30203574] 'applied index is now lower than readState.Index' (duration: 95.151897ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:48:56.957877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.633917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:1 size:205"} {"level":"info","ts":"2026-05-19T18:48:56.957844Z","caller":"traceutil/trace.go:171","msg":"trace[22671169] transaction","detail":"{read_only:false; response_revision:1454; number_of_response:1; }","duration":"150.6541ms","start":"2026-05-19T18:48:56.807154Z","end":"2026-05-19T18:48:56.957808Z","steps":["trace[22671169] 'process raft request' (duration: 143.982287ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:56.957919Z","caller":"traceutil/trace.go:171","msg":"trace[1438277664] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:1; response_revision:1454; }","duration":"149.732262ms","start":"2026-05-19T18:48:56.808176Z","end":"2026-05-19T18:48:56.957908Z","steps":["trace[1438277664] 'agreement among raft nodes before linearized reading' (duration: 149.631506ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:48:56.958391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.891516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:4 size:329960"} {"level":"info","ts":"2026-05-19T18:48:56.95847Z","caller":"traceutil/trace.go:171","msg":"trace[320537242] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1454; }","duration":"149.013503ms","start":"2026-05-19T18:48:56.809439Z","end":"2026-05-19T18:48:56.958453Z","steps":["trace[320537242] 'agreement among raft nodes before linearized reading' (duration: 148.523718ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:48:57.366496Z","caller":"traceutil/trace.go:171","msg":"trace[1435655976] transaction","detail":"{read_only:false; response_revision:1456; number_of_response:1; }","duration":"111.528216ms","start":"2026-05-19T18:48:57.254936Z","end":"2026-05-19T18:48:57.366464Z","steps":["trace[1435655976] 'process raft request' (duration: 111.383518ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:49:00.903933Z","caller":"traceutil/trace.go:171","msg":"trace[514438585] transaction","detail":"{read_only:false; response_revision:1465; number_of_response:1; }","duration":"277.163318ms","start":"2026-05-19T18:49:00.626734Z","end":"2026-05-19T18:49:00.903897Z","steps":["trace[514438585] 'process raft request' (duration: 276.978478ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:49:01.736643Z","caller":"traceutil/trace.go:171","msg":"trace[1026020825] transaction","detail":"{read_only:false; response_revision:1470; number_of_response:1; }","duration":"158.225548ms","start":"2026-05-19T18:49:01.578375Z","end":"2026-05-19T18:49:01.7366Z","steps":["trace[1026020825] 'process raft request' (duration: 158.029886ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:49:03.64037Z","caller":"traceutil/trace.go:171","msg":"trace[582704642] transaction","detail":"{read_only:false; response_revision:1476; number_of_response:1; }","duration":"141.548327ms","start":"2026-05-19T18:49:03.498778Z","end":"2026-05-19T18:49:03.640327Z","steps":["trace[582704642] 'process raft request' (duration: 141.301344ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:49:04.571263Z","caller":"traceutil/trace.go:171","msg":"trace[919786381] transaction","detail":"{read_only:false; response_revision:1478; number_of_response:1; }","duration":"137.508025ms","start":"2026-05-19T18:49:04.433723Z","end":"2026-05-19T18:49:04.571231Z","steps":["trace[919786381] 'process raft request' (duration: 137.318584ms)"],"step_count":1}