{"level":"warn","ts":"2026-04-14T13:04:04.189147Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-14T13:04:04.189252Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.109:2380","--initial-cluster=instance=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109: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-04-14T13:04:04.189325Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-14T13:04:04.189337Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-04-14T13:04:04.189353Z","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-04-14T13:04:04.190075Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]} {"level":"info","ts":"2026-04-14T13:04:04.190165Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.109: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-04-14T13:04:04.197295Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.072694ms"} {"level":"info","ts":"2026-04-14T13:04:04.203323Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"} {"level":"info","ts":"2026-04-14T13:04:04.203399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"} {"level":"info","ts":"2026-04-14T13:04:04.20344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"} {"level":"info","ts":"2026-04-14T13:04:04.203461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-14T13:04:04.203481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"} {"level":"info","ts":"2026-04-14T13:04:04.203526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"warn","ts":"2026-04-14T13:04:04.211296Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-14T13:04:04.213744Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-14T13:04:04.215843Z","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-04-14T13:04:04.218166Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-14T13:04:04.218683Z","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-04-14T13:04:04.218764Z","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-04-14T13:04:04.218781Z","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-04-14T13:04:04.218809Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-14T13:04:04.222102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"info","ts":"2026-04-14T13:04:04.222332Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-04-14T13:04:04.225894Z","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-04-14T13:04:04.225978Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-04-14T13:04:04.226023Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-04-14T13:04:04.226207Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-14T13:04:04.226245Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-14T13:04:04.404011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"} {"level":"info","ts":"2026-04-14T13:04:04.40411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"} {"level":"info","ts":"2026-04-14T13:04:04.404145Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"} {"level":"info","ts":"2026-04-14T13:04:04.404165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"} {"level":"info","ts":"2026-04-14T13:04:04.404173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-04-14T13:04:04.404187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"} {"level":"info","ts":"2026-04-14T13:04:04.404203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-04-14T13:04:04.414274Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T13:04:04.421333Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T13:04:04.421332Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.109:2379]}","request-path":"/0/members/d71a1778b31d4ce/attributes","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"} {"level":"info","ts":"2026-04-14T13:04:04.421478Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T13:04:04.421766Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-14T13:04:04.421832Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-14T13:04:04.425268Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-14T13:04:04.429462Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T13:04:04.429575Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T13:04:04.429615Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T13:04:04.429652Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"} {"level":"warn","ts":"2026-04-14T13:04:10.994377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.016639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T13:04:10.99447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.653367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-04-14T13:04:10.994516Z","caller":"traceutil/trace.go:171","msg":"trace[1522554004] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:0; response_revision:283; }","duration":"572.235924ms","start":"2026-04-14T13:04:10.422263Z","end":"2026-04-14T13:04:10.994499Z","steps":["trace[1522554004] 'range keys from in-memory index tree' (duration: 571.905356ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:10.994565Z","caller":"traceutil/trace.go:171","msg":"trace[1011209059] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:283; }","duration":"478.80908ms","start":"2026-04-14T13:04:10.51573Z","end":"2026-04-14T13:04:10.994539Z","steps":["trace[1011209059] 'range keys from in-memory index tree' (duration: 478.548633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:10.994569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:10.422232Z","time spent":"572.326417ms","remote":"127.0.0.1:43136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" "} {"level":"warn","ts":"2026-04-14T13:04:10.994611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:10.515708Z","time spent":"478.895022ms","remote":"127.0.0.1:43088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-04-14T13:04:10.994826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.7906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T13:04:10.994887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.590358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-14T13:04:10.994932Z","caller":"traceutil/trace.go:171","msg":"trace[1415608242] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:283; }","duration":"478.939634ms","start":"2026-04-14T13:04:10.515968Z","end":"2026-04-14T13:04:10.994908Z","steps":["trace[1415608242] 'range keys from in-memory index tree' (duration: 478.752839ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:10.994984Z","caller":"traceutil/trace.go:171","msg":"trace[2042731542] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:283; }","duration":"795.727312ms","start":"2026-04-14T13:04:10.199234Z","end":"2026-04-14T13:04:10.994961Z","steps":["trace[2042731542] 'range keys from in-memory index tree' (duration: 795.490195ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:10.994983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:10.515964Z","time spent":"479.009945ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"warn","ts":"2026-04-14T13:04:10.995029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:10.19921Z","time spent":"795.810283ms","remote":"127.0.0.1:42802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-14T13:04:10.997132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.709751ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T13:04:10.997196Z","caller":"traceutil/trace.go:171","msg":"trace[1321191639] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"480.960524ms","start":"2026-04-14T13:04:10.516222Z","end":"2026-04-14T13:04:10.997183Z","steps":["trace[1321191639] 'process raft request' (duration: 167.733256ms)","trace[1321191639] 'compare' (duration: 310.400297ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T13:04:10.997239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:10.516196Z","time spent":"481.023226ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T13:04:11.547371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.765192ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-04-14T13:04:11.54763Z","caller":"traceutil/trace.go:171","msg":"trace[1387520738] transaction","detail":"{read_only:false; number_of_response:0; response_revision:284; }","duration":"918.1015ms","start":"2026-04-14T13:04:10.629516Z","end":"2026-04-14T13:04:11.547618Z","steps":["trace[1387520738] 'process raft request' (duration: 918.001247ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:11.547725Z","caller":"traceutil/trace.go:171","msg":"trace[457234853] transaction","detail":"{read_only:false; number_of_response:0; response_revision:284; }","duration":"918.004017ms","start":"2026-04-14T13:04:10.629671Z","end":"2026-04-14T13:04:11.547675Z","steps":["trace[457234853] 'process raft request' (duration: 917.885384ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:11.547836Z","caller":"traceutil/trace.go:171","msg":"trace[1505210363] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"546.096094ms","start":"2026-04-14T13:04:11.00172Z","end":"2026-04-14T13:04:11.547816Z","steps":["trace[1505210363] 'process raft request' (duration: 546.050243ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:11.547817Z","caller":"traceutil/trace.go:171","msg":"trace[1267010405] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"916.693624ms","start":"2026-04-14T13:04:10.631075Z","end":"2026-04-14T13:04:11.547768Z","steps":["trace[1267010405] 'process raft request' (duration: 916.50427ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:11.547899Z","caller":"traceutil/trace.go:171","msg":"trace[1884498760] linearizableReadLoop","detail":"{readStateIndex:297; appliedIndex:291; }","duration":"783.285197ms","start":"2026-04-14T13:04:10.764599Z","end":"2026-04-14T13:04:11.547884Z","steps":["trace[1884498760] 'read index received' (duration: 483.92008ms)","trace[1884498760] 'applied index is now lower than readState.Index' (duration: 299.361557ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T13:04:11.547922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:11.001708Z","time spent":"546.183816ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T13:04:11.547969Z","caller":"traceutil/trace.go:171","msg":"trace[872756019] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"913.75836ms","start":"2026-04-14T13:04:10.634201Z","end":"2026-04-14T13:04:11.547959Z","steps":["trace[872756019] 'process raft request' (duration: 913.482283ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:11.548009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:10.634189Z","time spent":"913.804262ms","remote":"127.0.0.1:42888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T13:04:11.547994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:10.631066Z","time spent":"916.844799ms","remote":"127.0.0.1:42888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T13:04:11.548081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.480402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T13:04:11.548141Z","caller":"traceutil/trace.go:171","msg":"trace[1085858424] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:289; }","duration":"783.594435ms","start":"2026-04-14T13:04:10.76453Z","end":"2026-04-14T13:04:11.548125Z","steps":["trace[1085858424] 'agreement among raft nodes before linearized reading' (duration: 783.467102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:11.548202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:10.764503Z","time spent":"783.679177ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-14T13:04:11.548357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.119265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-14T13:04:11.548388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.895139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-04-14T13:04:11.548412Z","caller":"traceutil/trace.go:171","msg":"trace[1431086966] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:289; }","duration":"547.9381ms","start":"2026-04-14T13:04:11.000467Z","end":"2026-04-14T13:04:11.548405Z","steps":["trace[1431086966] 'agreement among raft nodes before linearized reading' (duration: 547.880309ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:11.548413Z","caller":"traceutil/trace.go:171","msg":"trace[145067536] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:289; }","duration":"708.214307ms","start":"2026-04-14T13:04:10.840188Z","end":"2026-04-14T13:04:11.548402Z","steps":["trace[145067536] 'agreement among raft nodes before linearized reading' (duration: 708.121585ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:11.548453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:10.840163Z","time spent":"708.282898ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T13:04:11.54846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.575496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-14T13:04:11.548487Z","caller":"traceutil/trace.go:171","msg":"trace[1893993749] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:289; }","duration":"386.660117ms","start":"2026-04-14T13:04:11.161822Z","end":"2026-04-14T13:04:11.548482Z","steps":["trace[1893993749] 'agreement among raft nodes before linearized reading' (duration: 386.617056ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:11.54848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.846302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/coredns\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T13:04:11.54851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:11.161781Z","time spent":"386.725589ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-14T13:04:11.548526Z","caller":"traceutil/trace.go:171","msg":"trace[239015167] range","detail":"{range_begin:/registry/configmaps/kube-system/coredns; range_end:; response_count:0; response_revision:289; }","duration":"544.919334ms","start":"2026-04-14T13:04:11.003594Z","end":"2026-04-14T13:04:11.548513Z","steps":["trace[239015167] 'agreement among raft nodes before linearized reading' (duration: 544.850032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:11.547846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:10.629664Z","time spent":"918.13743ms","remote":"127.0.0.1:42888","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T13:04:11.548562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.277299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"warn","ts":"2026-04-14T13:04:11.548575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:11.00358Z","time spent":"544.985595ms","remote":"127.0.0.1:42798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/configmaps/kube-system/coredns\" "} {"level":"info","ts":"2026-04-14T13:04:11.548594Z","caller":"traceutil/trace.go:171","msg":"trace[1923393851] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:289; }","duration":"548.348981ms","start":"2026-04-14T13:04:11.000237Z","end":"2026-04-14T13:04:11.548586Z","steps":["trace[1923393851] 'agreement among raft nodes before linearized reading' (duration: 548.29427ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:11.548148Z","caller":"traceutil/trace.go:171","msg":"trace[1587373918] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"915.761801ms","start":"2026-04-14T13:04:10.63238Z","end":"2026-04-14T13:04:11.548142Z","steps":["trace[1587373918] 'process raft request' (duration: 915.271519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:11.548627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:11.000214Z","time spent":"548.407462ms","remote":"127.0.0.1:43088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-04-14T13:04:11.548649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:10.63237Z","time spent":"916.262793ms","remote":"127.0.0.1:42888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T13:04:11.54776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:10.629486Z","time spent":"918.217193ms","remote":"127.0.0.1:42888","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T13:04:11.548779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"706.118964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-14T13:04:11.548813Z","caller":"traceutil/trace.go:171","msg":"trace[264386589] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:289; }","duration":"706.172195ms","start":"2026-04-14T13:04:10.842633Z","end":"2026-04-14T13:04:11.548805Z","steps":["trace[264386589] 'agreement among raft nodes before linearized reading' (duration: 706.117984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:11.548844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:10.842621Z","time spent":"706.218246ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-14T13:04:11.548428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:11.00046Z","time spent":"547.964621ms","remote":"127.0.0.1:42874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4040,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-14T13:04:11.548184Z","caller":"traceutil/trace.go:171","msg":"trace[1016463334] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"547.144291ms","start":"2026-04-14T13:04:11.001034Z","end":"2026-04-14T13:04:11.548178Z","steps":["trace[1016463334] 'process raft request' (duration: 546.686619ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:11.549028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:11.001017Z","time spent":"547.968931ms","remote":"127.0.0.1:42900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":209,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T13:04:11.549225Z","caller":"traceutil/trace.go:171","msg":"trace[892593580] transaction","detail":"{read_only:false; number_of_response:0; response_revision:284; }","duration":"924.578385ms","start":"2026-04-14T13:04:10.622992Z","end":"2026-04-14T13:04:11.547571Z","steps":["trace[892593580] 'process raft request' (duration: 625.544665ms)","trace[892593580] 'compare' (duration: 298.69409ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T13:04:11.549461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:10.622934Z","time spent":"926.42437ms","remote":"127.0.0.1:42874","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T13:04:11.721165Z","caller":"traceutil/trace.go:171","msg":"trace[1630627627] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"166.805192ms","start":"2026-04-14T13:04:11.554332Z","end":"2026-04-14T13:04:11.721137Z","steps":["trace[1630627627] 'process raft request' (duration: 166.146356ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:11.721292Z","caller":"traceutil/trace.go:171","msg":"trace[1746752236] linearizableReadLoop","detail":"{readStateIndex:301; appliedIndex:299; }","duration":"166.131776ms","start":"2026-04-14T13:04:11.55513Z","end":"2026-04-14T13:04:11.721262Z","steps":["trace[1746752236] 'read index received' (duration: 165.209912ms)","trace[1746752236] 'applied index is now lower than readState.Index' (duration: 920.704µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T13:04:11.721373Z","caller":"traceutil/trace.go:171","msg":"trace[2147073619] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"166.953047ms","start":"2026-04-14T13:04:11.554369Z","end":"2026-04-14T13:04:11.721322Z","steps":["trace[2147073619] 'process raft request' (duration: 166.71385ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:11.721538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.556433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-04-14T13:04:11.721575Z","caller":"traceutil/trace.go:171","msg":"trace[374160484] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:291; }","duration":"169.632205ms","start":"2026-04-14T13:04:11.551935Z","end":"2026-04-14T13:04:11.721567Z","steps":["trace[374160484] 'agreement among raft nodes before linearized reading' (duration: 169.4546ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:11.725951Z","caller":"traceutil/trace.go:171","msg":"trace[755515717] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"168.769712ms","start":"2026-04-14T13:04:11.557168Z","end":"2026-04-14T13:04:11.725938Z","steps":["trace[755515717] 'process raft request' (duration: 168.7018ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:11.725916Z","caller":"traceutil/trace.go:171","msg":"trace[1319867044] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"170.625139ms","start":"2026-04-14T13:04:11.555255Z","end":"2026-04-14T13:04:11.725881Z","steps":["trace[1319867044] 'process raft request' (duration: 170.423964ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:11.725981Z","caller":"traceutil/trace.go:171","msg":"trace[864209493] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"169.513141ms","start":"2026-04-14T13:04:11.556458Z","end":"2026-04-14T13:04:11.725971Z","steps":["trace[864209493] 'process raft request' (duration: 169.346646ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:11.726009Z","caller":"traceutil/trace.go:171","msg":"trace[295594985] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"169.219003ms","start":"2026-04-14T13:04:11.556746Z","end":"2026-04-14T13:04:11.725965Z","steps":["trace[295594985] 'process raft request' (duration: 169.0853ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:11.72603Z","caller":"traceutil/trace.go:171","msg":"trace[436907336] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"170.441175ms","start":"2026-04-14T13:04:11.555535Z","end":"2026-04-14T13:04:11.725976Z","steps":["trace[436907336] 'process raft request' (duration: 170.23186ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:11.726156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.807532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T13:04:11.726165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.802443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T13:04:11.726185Z","caller":"traceutil/trace.go:171","msg":"trace[509193957] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:296; }","duration":"164.844213ms","start":"2026-04-14T13:04:11.561332Z","end":"2026-04-14T13:04:11.726176Z","steps":["trace[509193957] 'agreement among raft nodes before linearized reading' (duration: 164.773601ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:11.726187Z","caller":"traceutil/trace.go:171","msg":"trace[216833185] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:0; response_revision:296; }","duration":"170.851425ms","start":"2026-04-14T13:04:11.555328Z","end":"2026-04-14T13:04:11.72618Z","steps":["trace[216833185] 'agreement among raft nodes before linearized reading' (duration: 170.813694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:11.72623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.124276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5897"} {"level":"info","ts":"2026-04-14T13:04:11.726251Z","caller":"traceutil/trace.go:171","msg":"trace[1866537979] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:296; }","duration":"168.162416ms","start":"2026-04-14T13:04:11.558083Z","end":"2026-04-14T13:04:11.726245Z","steps":["trace[1866537979] 'agreement among raft nodes before linearized reading' (duration: 168.117145ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:38.135043Z","caller":"traceutil/trace.go:171","msg":"trace[705914591] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"110.843245ms","start":"2026-04-14T13:04:38.02417Z","end":"2026-04-14T13:04:38.135013Z","steps":["trace[705914591] 'process raft request' (duration: 110.698531ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:38.144144Z","caller":"traceutil/trace.go:171","msg":"trace[822602759] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"114.028177ms","start":"2026-04-14T13:04:38.030094Z","end":"2026-04-14T13:04:38.144122Z","steps":["trace[822602759] 'process raft request' (duration: 113.839472ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:38.144269Z","caller":"traceutil/trace.go:171","msg":"trace[1165559975] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"114.020347ms","start":"2026-04-14T13:04:38.030203Z","end":"2026-04-14T13:04:38.144223Z","steps":["trace[1165559975] 'process raft request' (duration: 113.860433ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:38.144401Z","caller":"traceutil/trace.go:171","msg":"trace[897896088] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"104.68377ms","start":"2026-04-14T13:04:38.039655Z","end":"2026-04-14T13:04:38.144338Z","steps":["trace[897896088] 'process raft request' (duration: 104.452305ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:38.144456Z","caller":"traceutil/trace.go:171","msg":"trace[14000475] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"104.349263ms","start":"2026-04-14T13:04:38.040075Z","end":"2026-04-14T13:04:38.144424Z","steps":["trace[14000475] 'process raft request' (duration: 104.226359ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:38.144497Z","caller":"traceutil/trace.go:171","msg":"trace[101243491] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"104.66608ms","start":"2026-04-14T13:04:38.039803Z","end":"2026-04-14T13:04:38.144469Z","steps":["trace[101243491] 'process raft request' (duration: 104.470065ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:38.144566Z","caller":"traceutil/trace.go:171","msg":"trace[2108049290] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"103.075949ms","start":"2026-04-14T13:04:38.041447Z","end":"2026-04-14T13:04:38.144523Z","steps":["trace[2108049290] 'process raft request' (duration: 102.883744ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:38.144431Z","caller":"traceutil/trace.go:171","msg":"trace[806146789] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"104.67193ms","start":"2026-04-14T13:04:38.039719Z","end":"2026-04-14T13:04:38.144391Z","steps":["trace[806146789] 'process raft request' (duration: 104.523806ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:38.303527Z","caller":"traceutil/trace.go:171","msg":"trace[701711170] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"137.166002ms","start":"2026-04-14T13:04:38.166331Z","end":"2026-04-14T13:04:38.303497Z","steps":["trace[701711170] 'process raft request' (duration: 117.316099ms)","trace[701711170] 'compare' (duration: 19.521454ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T13:04:38.303653Z","caller":"traceutil/trace.go:171","msg":"trace[1371176636] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"135.030499ms","start":"2026-04-14T13:04:38.1686Z","end":"2026-04-14T13:04:38.303631Z","steps":["trace[1371176636] 'process raft request' (duration: 134.878985ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:38.303675Z","caller":"traceutil/trace.go:171","msg":"trace[650007963] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"134.588697ms","start":"2026-04-14T13:04:38.169056Z","end":"2026-04-14T13:04:38.303644Z","steps":["trace[650007963] 'process raft request' (duration: 134.501565ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:38.303646Z","caller":"traceutil/trace.go:171","msg":"trace[662339951] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"137.221134ms","start":"2026-04-14T13:04:38.166378Z","end":"2026-04-14T13:04:38.303599Z","steps":["trace[662339951] 'process raft request' (duration: 137.028288ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:38.303923Z","caller":"traceutil/trace.go:171","msg":"trace[1001636492] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"133.839818ms","start":"2026-04-14T13:04:38.170047Z","end":"2026-04-14T13:04:38.303886Z","steps":["trace[1001636492] 'process raft request' (duration: 133.556431ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:38.304152Z","caller":"traceutil/trace.go:171","msg":"trace[1183043915] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"130.854262ms","start":"2026-04-14T13:04:38.173286Z","end":"2026-04-14T13:04:38.30414Z","steps":["trace[1183043915] 'process raft request' (duration: 130.542615ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:38.304244Z","caller":"traceutil/trace.go:171","msg":"trace[1518024749] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"129.870728ms","start":"2026-04-14T13:04:38.174365Z","end":"2026-04-14T13:04:38.304235Z","steps":["trace[1518024749] 'process raft request' (duration: 129.602791ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:38.304259Z","caller":"traceutil/trace.go:171","msg":"trace[1646857680] transaction","detail":"{read_only:false; number_of_response:0; response_revision:542; }","duration":"127.691293ms","start":"2026-04-14T13:04:38.176552Z","end":"2026-04-14T13:04:38.304243Z","steps":["trace[1646857680] 'process raft request' (duration: 127.495788ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:38.304417Z","caller":"traceutil/trace.go:171","msg":"trace[1547017012] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"125.153899ms","start":"2026-04-14T13:04:38.179236Z","end":"2026-04-14T13:04:38.30439Z","steps":["trace[1547017012] 'process raft request' (duration: 124.849281ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:38.304488Z","caller":"traceutil/trace.go:171","msg":"trace[900887699] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"121.118626ms","start":"2026-04-14T13:04:38.183361Z","end":"2026-04-14T13:04:38.304479Z","steps":["trace[900887699] 'process raft request' (duration: 120.809948ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:45.046191Z","caller":"traceutil/trace.go:171","msg":"trace[2042689535] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"392.71677ms","start":"2026-04-14T13:04:44.653442Z","end":"2026-04-14T13:04:45.046158Z","steps":["trace[2042689535] 'read index received' (duration: 392.602107ms)","trace[2042689535] 'applied index is now lower than readState.Index' (duration: 113.293µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T13:04:45.04655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.761864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T13:04:45.046642Z","caller":"traceutil/trace.go:171","msg":"trace[834323612] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:628; }","duration":"349.961018ms","start":"2026-04-14T13:04:44.696665Z","end":"2026-04-14T13:04:45.046626Z","steps":["trace[834323612] 'agreement among raft nodes before linearized reading' (duration: 349.726782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:45.046648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.92845ms","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-04-14T13:04:45.046728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:44.696643Z","time spent":"350.069411ms","remote":"127.0.0.1:57004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-14T13:04:45.046799Z","caller":"traceutil/trace.go:171","msg":"trace[1135330776] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:628; }","duration":"211.184146ms","start":"2026-04-14T13:04:44.835595Z","end":"2026-04-14T13:04:45.046779Z","steps":["trace[1135330776] 'agreement among raft nodes before linearized reading' (duration: 210.804716ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:45.046892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.415472ms","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-04-14T13:04:45.04694Z","caller":"traceutil/trace.go:171","msg":"trace[1368712067] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:628; }","duration":"211.477053ms","start":"2026-04-14T13:04:44.835447Z","end":"2026-04-14T13:04:45.046924Z","steps":["trace[1368712067] 'agreement among raft nodes before linearized reading' (duration: 211.404512ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:45.047006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.017147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T13:04:45.047139Z","caller":"traceutil/trace.go:171","msg":"trace[1365567017] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:628; }","duration":"101.225332ms","start":"2026-04-14T13:04:44.945878Z","end":"2026-04-14T13:04:45.047103Z","steps":["trace[1365567017] 'agreement among raft nodes before linearized reading' (duration: 100.903564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:45.047176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.266593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T13:04:45.047239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.841331ms","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-04-14T13:04:45.047254Z","caller":"traceutil/trace.go:171","msg":"trace[1970743352] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:628; }","duration":"101.347655ms","start":"2026-04-14T13:04:44.945877Z","end":"2026-04-14T13:04:45.047225Z","steps":["trace[1970743352] 'agreement among raft nodes before linearized reading' (duration: 101.261703ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:45.047282Z","caller":"traceutil/trace.go:171","msg":"trace[1040311562] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:628; }","duration":"239.881962ms","start":"2026-04-14T13:04:44.80739Z","end":"2026-04-14T13:04:45.047272Z","steps":["trace[1040311562] 'agreement among raft nodes before linearized reading' (duration: 239.828901ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:45.046305Z","caller":"traceutil/trace.go:171","msg":"trace[176528820] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"445.815965ms","start":"2026-04-14T13:04:44.600441Z","end":"2026-04-14T13:04:45.046257Z","steps":["trace[176528820] 'process raft request' (duration: 445.492367ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:45.047452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.782901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T13:04:45.047505Z","caller":"traceutil/trace.go:171","msg":"trace[1453883463] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:628; }","duration":"277.875124ms","start":"2026-04-14T13:04:44.769622Z","end":"2026-04-14T13:04:45.047497Z","steps":["trace[1453883463] 'agreement among raft nodes before linearized reading' (duration: 277.804112ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:45.047566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:44.600406Z","time spent":"447.046867ms","remote":"127.0.0.1:43192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T13:04:45.047592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.367321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T13:04:45.047679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.606442ms","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-04-14T13:04:45.047716Z","caller":"traceutil/trace.go:171","msg":"trace[2131152916] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:628; }","duration":"278.700065ms","start":"2026-04-14T13:04:44.769002Z","end":"2026-04-14T13:04:45.047702Z","steps":["trace[2131152916] 'agreement among raft nodes before linearized reading' (duration: 278.648373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:45.047764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.994097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T13:04:45.047712Z","caller":"traceutil/trace.go:171","msg":"trace[1836052636] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:628; }","duration":"121.544426ms","start":"2026-04-14T13:04:44.926145Z","end":"2026-04-14T13:04:45.047689Z","steps":["trace[1836052636] 'agreement among raft nodes before linearized reading' (duration: 121.352122ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:45.047813Z","caller":"traceutil/trace.go:171","msg":"trace[1970072053] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:628; }","duration":"327.055188ms","start":"2026-04-14T13:04:44.720746Z","end":"2026-04-14T13:04:45.047802Z","steps":["trace[1970072053] 'agreement among raft nodes before linearized reading' (duration: 326.979946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:45.047789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.866208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T13:04:45.047857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.1153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T13:04:45.047896Z","caller":"traceutil/trace.go:171","msg":"trace[1167644744] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:628; }","duration":"327.152951ms","start":"2026-04-14T13:04:44.72073Z","end":"2026-04-14T13:04:45.047883Z","steps":["trace[1167644744] 'agreement among raft nodes before linearized reading' (duration: 327.09774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:45.04791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.877909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T13:04:45.04794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:44.720682Z","time spent":"327.245773ms","remote":"127.0.0.1:57020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-14T13:04:45.047955Z","caller":"traceutil/trace.go:171","msg":"trace[995111230] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:628; }","duration":"278.947231ms","start":"2026-04-14T13:04:44.768997Z","end":"2026-04-14T13:04:45.047944Z","steps":["trace[995111230] 'agreement among raft nodes before linearized reading' (duration: 278.885119ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:45.047973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.842524ms","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-04-14T13:04:45.048015Z","caller":"traceutil/trace.go:171","msg":"trace[1846679497] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:628; }","duration":"121.889225ms","start":"2026-04-14T13:04:44.926115Z","end":"2026-04-14T13:04:45.048004Z","steps":["trace[1846679497] 'agreement among raft nodes before linearized reading' (duration: 121.823754ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:45.04807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.221256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T13:04:45.048101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.290871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T13:04:45.048127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.913735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T13:04:45.048146Z","caller":"traceutil/trace.go:171","msg":"trace[2064950897] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:628; }","duration":"147.311308ms","start":"2026-04-14T13:04:44.900808Z","end":"2026-04-14T13:04:45.048119Z","steps":["trace[2064950897] 'agreement among raft nodes before linearized reading' (duration: 147.203965ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:45.048173Z","caller":"traceutil/trace.go:171","msg":"trace[927689272] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:628; }","duration":"296.967577ms","start":"2026-04-14T13:04:44.751192Z","end":"2026-04-14T13:04:45.04816Z","steps":["trace[927689272] 'agreement among raft nodes before linearized reading' (duration: 296.903066ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:45.048485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.600323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T13:04:45.048526Z","caller":"traceutil/trace.go:171","msg":"trace[1578848532] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:628; }","duration":"297.652554ms","start":"2026-04-14T13:04:44.750864Z","end":"2026-04-14T13:04:45.048517Z","steps":["trace[1578848532] 'agreement among raft nodes before linearized reading' (duration: 297.587322ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:45.047188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.731769ms","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-04-14T13:04:45.048633Z","caller":"traceutil/trace.go:171","msg":"trace[432042756] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:628; }","duration":"241.176825ms","start":"2026-04-14T13:04:44.807444Z","end":"2026-04-14T13:04:45.04862Z","steps":["trace[432042756] 'agreement among raft nodes before linearized reading' (duration: 239.714998ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:45.048684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.628537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T13:04:45.047904Z","caller":"traceutil/trace.go:171","msg":"trace[1098666298] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:628; }","duration":"148.998591ms","start":"2026-04-14T13:04:44.898879Z","end":"2026-04-14T13:04:45.047878Z","steps":["trace[1098666298] 'agreement among raft nodes before linearized reading' (duration: 148.843737ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:45.048751Z","caller":"traceutil/trace.go:171","msg":"trace[1630195571] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:628; }","duration":"149.761911ms","start":"2026-04-14T13:04:44.898977Z","end":"2026-04-14T13:04:45.048738Z","steps":["trace[1630195571] 'agreement among raft nodes before linearized reading' (duration: 149.131785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:45.047856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:44.720742Z","time spent":"327.10382ms","remote":"127.0.0.1:57020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"info","ts":"2026-04-14T13:04:45.048132Z","caller":"traceutil/trace.go:171","msg":"trace[1016902196] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:628; }","duration":"351.369693ms","start":"2026-04-14T13:04:44.696753Z","end":"2026-04-14T13:04:45.048123Z","steps":["trace[1016902196] 'agreement among raft nodes before linearized reading' (duration: 351.320602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:45.048956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.083584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T13:04:45.049012Z","caller":"traceutil/trace.go:171","msg":"trace[2023630980] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:628; }","duration":"298.168377ms","start":"2026-04-14T13:04:44.75083Z","end":"2026-04-14T13:04:45.048998Z","steps":["trace[2023630980] 'agreement among raft nodes before linearized reading' (duration: 298.081455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:45.049179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.622062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T13:04:45.049218Z","caller":"traceutil/trace.go:171","msg":"trace[951900376] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:628; }","duration":"327.672164ms","start":"2026-04-14T13:04:44.721536Z","end":"2026-04-14T13:04:45.049208Z","steps":["trace[951900376] 'agreement among raft nodes before linearized reading' (duration: 327.614622ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:45.049253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:44.72153Z","time spent":"327.711295ms","remote":"127.0.0.1:57020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-14T13:04:45.048965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:44.69672Z","time spent":"352.225565ms","remote":"127.0.0.1:57004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-14T13:04:45.046639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.813752ms","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-04-14T13:04:45.049746Z","caller":"traceutil/trace.go:171","msg":"trace[1480177483] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:628; }","duration":"104.022472ms","start":"2026-04-14T13:04:44.945712Z","end":"2026-04-14T13:04:45.049734Z","steps":["trace[1480177483] 'agreement among raft nodes before linearized reading' (duration: 100.781411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:45.049894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.72241ms","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":"info","ts":"2026-04-14T13:04:45.049936Z","caller":"traceutil/trace.go:171","msg":"trace[604491024] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:628; }","duration":"213.782612ms","start":"2026-04-14T13:04:44.836141Z","end":"2026-04-14T13:04:45.049924Z","steps":["trace[604491024] 'agreement among raft nodes before linearized reading' (duration: 213.722531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:45.051826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.374653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5kxf7\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-14T13:04:45.051879Z","caller":"traceutil/trace.go:171","msg":"trace[1128110907] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5kxf7; range_end:; response_count:1; response_revision:628; }","duration":"398.458756ms","start":"2026-04-14T13:04:44.653408Z","end":"2026-04-14T13:04:45.051867Z","steps":["trace[1128110907] 'agreement among raft nodes before linearized reading' (duration: 392.958577ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:45.052157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:44.653381Z","time spent":"398.764225ms","remote":"127.0.0.1:42888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-5kxf7\" "} {"level":"info","ts":"2026-04-14T13:04:45.331022Z","caller":"traceutil/trace.go:171","msg":"trace[693781695] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"265.250874ms","start":"2026-04-14T13:04:45.065742Z","end":"2026-04-14T13:04:45.330992Z","steps":["trace[693781695] 'process raft request' (duration: 259.195981ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:46.405088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.546155ms","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-04-14T13:04:46.405288Z","caller":"traceutil/trace.go:171","msg":"trace[1070063449] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:629; }","duration":"422.792172ms","start":"2026-04-14T13:04:45.982461Z","end":"2026-04-14T13:04:46.405253Z","steps":["trace[1070063449] 'range keys from in-memory index tree' (duration: 422.523835ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:04:46.406071Z","caller":"traceutil/trace.go:171","msg":"trace[1877424445] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"475.426145ms","start":"2026-04-14T13:04:45.930616Z","end":"2026-04-14T13:04:46.406042Z","steps":["trace[1877424445] 'read index received' (duration: 472.292876ms)","trace[1877424445] 'applied index is now lower than readState.Index' (duration: 3.132009ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T13:04:46.406196Z","caller":"traceutil/trace.go:171","msg":"trace[622556534] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"934.067655ms","start":"2026-04-14T13:04:45.472118Z","end":"2026-04-14T13:04:46.406186Z","steps":["trace[622556534] 'process raft request' (duration: 931.035308ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:46.406445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.514645ms","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-04-14T13:04:46.406443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.825394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-14T13:04:46.406457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.762946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-14T13:04:46.406504Z","caller":"traceutil/trace.go:171","msg":"trace[1304934368] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:630; }","duration":"456.610728ms","start":"2026-04-14T13:04:45.949876Z","end":"2026-04-14T13:04:46.406486Z","steps":["trace[1304934368] 'agreement among raft nodes before linearized reading' (duration: 456.432924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:46.406505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:45.472075Z","time spent":"934.144746ms","remote":"127.0.0.1:42786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T13:04:46.406507Z","caller":"traceutil/trace.go:171","msg":"trace[1180836609] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:630; }","duration":"475.947688ms","start":"2026-04-14T13:04:45.930544Z","end":"2026-04-14T13:04:46.406492Z","steps":["trace[1180836609] 'agreement among raft nodes before linearized reading' (duration: 475.744443ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:46.406597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:45.930519Z","time spent":"476.06514ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-14T13:04:46.40655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:45.94986Z","time spent":"456.678929ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-14T13:04:46.406659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.005632ms","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-04-14T13:04:46.406712Z","caller":"traceutil/trace.go:171","msg":"trace[93397863] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:630; }","duration":"454.077033ms","start":"2026-04-14T13:04:45.952621Z","end":"2026-04-14T13:04:46.406698Z","steps":["trace[93397863] 'agreement among raft nodes before linearized reading' (duration: 453.95239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:46.406752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:45.952605Z","time spent":"454.134265ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-14T13:04:46.406516Z","caller":"traceutil/trace.go:171","msg":"trace[1118624104] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:630; }","duration":"453.853258ms","start":"2026-04-14T13:04:45.952647Z","end":"2026-04-14T13:04:46.406501Z","steps":["trace[1118624104] 'agreement among raft nodes before linearized reading' (duration: 453.681734ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:04:46.407162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:04:45.952628Z","time spent":"454.165666ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-14T13:04:48.001431Z","caller":"traceutil/trace.go:171","msg":"trace[1743536396] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"171.281686ms","start":"2026-04-14T13:04:47.830118Z","end":"2026-04-14T13:04:48.0014Z","steps":["trace[1743536396] 'process raft request' (duration: 171.123962ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:05:01.979361Z","caller":"traceutil/trace.go:171","msg":"trace[1820973348] linearizableReadLoop","detail":"{readStateIndex:819; appliedIndex:818; }","duration":"274.073888ms","start":"2026-04-14T13:05:01.705256Z","end":"2026-04-14T13:05:01.97933Z","steps":["trace[1820973348] 'read index received' (duration: 273.76841ms)","trace[1820973348] 'applied index is now lower than readState.Index' (duration: 304.668µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T13:05:01.979629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.352254ms","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-04-14T13:05:01.979681Z","caller":"traceutil/trace.go:171","msg":"trace[1202521598] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:790; }","duration":"274.472167ms","start":"2026-04-14T13:05:01.705196Z","end":"2026-04-14T13:05:01.979668Z","steps":["trace[1202521598] 'agreement among raft nodes before linearized reading' (duration: 274.262162ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:05:01.979949Z","caller":"traceutil/trace.go:171","msg":"trace[759110] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"556.407473ms","start":"2026-04-14T13:05:01.423408Z","end":"2026-04-14T13:05:01.979816Z","steps":["trace[759110] 'process raft request' (duration: 555.716356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:05:01.980383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:05:01.423368Z","time spent":"556.785013ms","remote":"127.0.0.1:42888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T13:05:37.197435Z","caller":"traceutil/trace.go:171","msg":"trace[65286759] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"139.239889ms","start":"2026-04-14T13:05:37.058165Z","end":"2026-04-14T13:05:37.197405Z","steps":["trace[65286759] 'process raft request' (duration: 139.027964ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:05:55.180468Z","caller":"traceutil/trace.go:171","msg":"trace[1385585470] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"365.083165ms","start":"2026-04-14T13:05:54.815344Z","end":"2026-04-14T13:05:55.180427Z","steps":["trace[1385585470] 'process raft request' (duration: 365.034054ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:05:55.180559Z","caller":"traceutil/trace.go:171","msg":"trace[321492878] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"367.246341ms","start":"2026-04-14T13:05:54.813269Z","end":"2026-04-14T13:05:55.180515Z","steps":["trace[321492878] 'process raft request' (duration: 366.944303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:05:55.180678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:05:54.815332Z","time spent":"365.23911ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T13:05:55.180752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:05:54.813257Z","time spent":"367.384634ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T13:05:55.23187Z","caller":"traceutil/trace.go:171","msg":"trace[1067079480] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"376.950886ms","start":"2026-04-14T13:05:54.8549Z","end":"2026-04-14T13:05:55.231851Z","steps":["trace[1067079480] 'process raft request' (duration: 374.115834ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:05:55.231978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:05:54.854869Z","time spent":"377.050898ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T13:06:04.521784Z","caller":"traceutil/trace.go:171","msg":"trace[706812911] linearizableReadLoop","detail":"{readStateIndex:1142; appliedIndex:1141; }","duration":"182.961974ms","start":"2026-04-14T13:06:04.3388Z","end":"2026-04-14T13:06:04.521762Z","steps":["trace[706812911] 'read index received' (duration: 182.849141ms)","trace[706812911] 'applied index is now lower than readState.Index' (duration: 111.823µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T13:06:04.521971Z","caller":"traceutil/trace.go:171","msg":"trace[102881893] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"186.233607ms","start":"2026-04-14T13:06:04.335678Z","end":"2026-04-14T13:06:04.521912Z","steps":["trace[102881893] 'process raft request' (duration: 185.922019ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:04.521995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.16546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T13:06:04.522033Z","caller":"traceutil/trace.go:171","msg":"trace[2144831532] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1098; }","duration":"183.251371ms","start":"2026-04-14T13:06:04.33877Z","end":"2026-04-14T13:06:04.522021Z","steps":["trace[2144831532] 'agreement among raft nodes before linearized reading' (duration: 183.149859ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:04.522162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.334922ms","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-04-14T13:06:04.522237Z","caller":"traceutil/trace.go:171","msg":"trace[670043577] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1098; }","duration":"105.534087ms","start":"2026-04-14T13:06:04.416687Z","end":"2026-04-14T13:06:04.522222Z","steps":["trace[670043577] 'agreement among raft nodes before linearized reading' (duration: 105.260011ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:06:05.891677Z","caller":"traceutil/trace.go:171","msg":"trace[442614753] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"494.802915ms","start":"2026-04-14T13:06:05.396806Z","end":"2026-04-14T13:06:05.891609Z","steps":["trace[442614753] 'process raft request' (duration: 494.58652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:05.891897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:05.39677Z","time spent":"495.01281ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T13:06:05.892235Z","caller":"traceutil/trace.go:171","msg":"trace[295291145] linearizableReadLoop","detail":"{readStateIndex:1148; appliedIndex:1148; }","duration":"326.175744ms","start":"2026-04-14T13:06:05.566018Z","end":"2026-04-14T13:06:05.892194Z","steps":["trace[295291145] 'read index received' (duration: 325.569168ms)","trace[295291145] 'applied index is now lower than readState.Index' (duration: 603.325µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T13:06:05.892429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.394338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T13:06:05.893115Z","caller":"traceutil/trace.go:171","msg":"trace[1516877983] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1104; }","duration":"327.186598ms","start":"2026-04-14T13:06:05.565915Z","end":"2026-04-14T13:06:05.893101Z","steps":["trace[1516877983] 'agreement among raft nodes before linearized reading' (duration: 326.418919ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:05.893161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:05.565865Z","time spent":"327.284511ms","remote":"127.0.0.1:42686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-14T13:06:06.735592Z","caller":"traceutil/trace.go:171","msg":"trace[581755371] linearizableReadLoop","detail":"{readStateIndex:1149; appliedIndex:1148; }","duration":"124.602239ms","start":"2026-04-14T13:06:06.610967Z","end":"2026-04-14T13:06:06.73557Z","steps":["trace[581755371] 'read index received' (duration: 124.307432ms)","trace[581755371] 'applied index is now lower than readState.Index' (duration: 294.037µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T13:06:06.735694Z","caller":"traceutil/trace.go:171","msg":"trace[1898958098] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"192.614108ms","start":"2026-04-14T13:06:06.543041Z","end":"2026-04-14T13:06:06.735655Z","steps":["trace[1898958098] 'process raft request' (duration: 192.315061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:06.736455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.456721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T13:06:06.736588Z","caller":"traceutil/trace.go:171","msg":"trace[1475760617] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1105; }","duration":"125.606415ms","start":"2026-04-14T13:06:06.61095Z","end":"2026-04-14T13:06:06.736556Z","steps":["trace[1475760617] 'agreement among raft nodes before linearized reading' (duration: 124.755753ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:06:16.827849Z","caller":"traceutil/trace.go:171","msg":"trace[852655941] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"126.45946ms","start":"2026-04-14T13:06:16.70133Z","end":"2026-04-14T13:06:16.82779Z","steps":["trace[852655941] 'process raft request' (duration: 83.177569ms)","trace[852655941] 'compare' (duration: 43.013255ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T13:06:17.05334Z","caller":"traceutil/trace.go:171","msg":"trace[1797800229] transaction","detail":"{read_only:false; response_revision:1143; number_of_response:1; }","duration":"217.813936ms","start":"2026-04-14T13:06:16.835491Z","end":"2026-04-14T13:06:17.053305Z","steps":["trace[1797800229] 'process raft request' (duration: 121.65326ms)","trace[1797800229] 'compare' (duration: 95.751516ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T13:06:17.05339Z","caller":"traceutil/trace.go:171","msg":"trace[234412484] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"217.429997ms","start":"2026-04-14T13:06:16.835927Z","end":"2026-04-14T13:06:17.053357Z","steps":["trace[234412484] 'process raft request' (duration: 217.360005ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:06:17.053524Z","caller":"traceutil/trace.go:171","msg":"trace[813251313] transaction","detail":"{read_only:false; response_revision:1144; number_of_response:1; }","duration":"217.916809ms","start":"2026-04-14T13:06:16.835579Z","end":"2026-04-14T13:06:17.053496Z","steps":["trace[813251313] 'process raft request' (duration: 217.619342ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:06:17.175354Z","caller":"traceutil/trace.go:171","msg":"trace[1435084792] linearizableReadLoop","detail":"{readStateIndex:1193; appliedIndex:1192; }","duration":"104.400525ms","start":"2026-04-14T13:06:17.070911Z","end":"2026-04-14T13:06:17.175312Z","steps":["trace[1435084792] 'read index received' (duration: 102.882297ms)","trace[1435084792] 'applied index is now lower than readState.Index' (duration: 1.516328ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T13:06:17.175391Z","caller":"traceutil/trace.go:171","msg":"trace[1535108730] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"115.383163ms","start":"2026-04-14T13:06:17.059971Z","end":"2026-04-14T13:06:17.175354Z","steps":["trace[1535108730] 'process raft request' (duration: 114.077539ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:17.175787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.836796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-14T13:06:17.175891Z","caller":"traceutil/trace.go:171","msg":"trace[1010385787] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1146; }","duration":"105.010011ms","start":"2026-04-14T13:06:17.070863Z","end":"2026-04-14T13:06:17.175873Z","steps":["trace[1010385787] 'agreement among raft nodes before linearized reading' (duration: 104.58207ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:06:20.417648Z","caller":"traceutil/trace.go:171","msg":"trace[205345034] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"466.073821ms","start":"2026-04-14T13:06:19.951549Z","end":"2026-04-14T13:06:20.417623Z","steps":["trace[205345034] 'process raft request' (duration: 465.891576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:20.417939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:19.951523Z","time spent":"466.251575ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T13:06:21.01569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.194499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T13:06:21.0158Z","caller":"traceutil/trace.go:171","msg":"trace[1317616614] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1203; }","duration":"450.381183ms","start":"2026-04-14T13:06:20.565396Z","end":"2026-04-14T13:06:21.015777Z","steps":["trace[1317616614] 'range keys from in-memory index tree' (duration: 450.080996ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:21.015879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:20.565376Z","time spent":"450.475176ms","remote":"127.0.0.1:42686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-14T13:06:33.807079Z","caller":"traceutil/trace.go:171","msg":"trace[100256668] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"188.999678ms","start":"2026-04-14T13:06:33.618041Z","end":"2026-04-14T13:06:33.807041Z","steps":["trace[100256668] 'process raft request' (duration: 112.124899ms)","trace[100256668] 'compare' (duration: 76.605182ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T13:06:33.8073Z","caller":"traceutil/trace.go:171","msg":"trace[954091020] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"187.997154ms","start":"2026-04-14T13:06:33.619256Z","end":"2026-04-14T13:06:33.807254Z","steps":["trace[954091020] 'process raft request' (duration: 187.727387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:34.059658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.807553ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-14T13:06:35.443209Z","caller":"traceutil/trace.go:171","msg":"trace[57052630] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"298.622936ms","start":"2026-04-14T13:06:35.144555Z","end":"2026-04-14T13:06:35.443178Z","steps":["trace[57052630] 'process raft request' (duration: 298.03362ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:06:35.838292Z","caller":"traceutil/trace.go:171","msg":"trace[711432040] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"391.096179ms","start":"2026-04-14T13:06:35.447162Z","end":"2026-04-14T13:06:35.838259Z","steps":["trace[711432040] 'process raft request' (duration: 390.898493ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:35.838481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:35.447147Z","time spent":"391.235313ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T13:06:35.838911Z","caller":"traceutil/trace.go:171","msg":"trace[1419691146] linearizableReadLoop","detail":"{readStateIndex:1303; appliedIndex:1303; }","duration":"274.358733ms","start":"2026-04-14T13:06:35.564534Z","end":"2026-04-14T13:06:35.838892Z","steps":["trace[1419691146] 'read index received' (duration: 274.351242ms)","trace[1419691146] 'applied index is now lower than readState.Index' (duration: 5.151µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T13:06:35.839218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.687932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T13:06:35.839264Z","caller":"traceutil/trace.go:171","msg":"trace[1570164807] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1251; }","duration":"274.774894ms","start":"2026-04-14T13:06:35.564476Z","end":"2026-04-14T13:06:35.839251Z","steps":["trace[1570164807] 'agreement among raft nodes before linearized reading' (duration: 274.704862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:35.840378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.066559ms","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-04-14T13:06:35.840425Z","caller":"traceutil/trace.go:171","msg":"trace[2104985122] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1251; }","duration":"271.141522ms","start":"2026-04-14T13:06:35.569272Z","end":"2026-04-14T13:06:35.840413Z","steps":["trace[2104985122] 'agreement among raft nodes before linearized reading' (duration: 269.709386ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:06:36.65557Z","caller":"traceutil/trace.go:171","msg":"trace[1200462224] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"102.839304ms","start":"2026-04-14T13:06:36.552709Z","end":"2026-04-14T13:06:36.655548Z","steps":["trace[1200462224] 'process raft request' (duration: 102.724272ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:06:40.98241Z","caller":"traceutil/trace.go:171","msg":"trace[1182715136] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"309.528541ms","start":"2026-04-14T13:06:40.672844Z","end":"2026-04-14T13:06:40.982373Z","steps":["trace[1182715136] 'process raft request' (duration: 309.276765ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:40.982657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:40.672812Z","time spent":"309.705446ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T13:06:42.61625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.000694ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T13:06:42.616333Z","caller":"traceutil/trace.go:171","msg":"trace[102560078] linearizableReadLoop","detail":"{readStateIndex:1357; appliedIndex:1356; }","duration":"749.672087ms","start":"2026-04-14T13:06:41.866649Z","end":"2026-04-14T13:06:42.616321Z","steps":["trace[102560078] 'read index received' (duration: 326.475519ms)","trace[102560078] 'applied index is now lower than readState.Index' (duration: 423.195978ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T13:06:42.616395Z","caller":"traceutil/trace.go:171","msg":"trace[857023331] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"803.266359ms","start":"2026-04-14T13:06:41.813123Z","end":"2026-04-14T13:06:42.616389Z","steps":["trace[857023331] 'process raft request' (duration: 380.05597ms)","trace[857023331] 'compare' (duration: 422.751558ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T13:06:42.616437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:41.813101Z","time spent":"803.319901ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T13:06:42.616639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.404245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-14T13:06:42.616708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.11546ms","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-04-14T13:06:42.616728Z","caller":"traceutil/trace.go:171","msg":"trace[696130810] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1304; }","duration":"695.175381ms","start":"2026-04-14T13:06:41.921547Z","end":"2026-04-14T13:06:42.616722Z","steps":["trace[696130810] 'agreement among raft nodes before linearized reading' (duration: 695.088389ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:42.616759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:41.921511Z","time spent":"695.242073ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T13:06:42.6168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.230153ms","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-04-14T13:06:42.616836Z","caller":"traceutil/trace.go:171","msg":"trace[1828666269] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1304; }","duration":"695.317595ms","start":"2026-04-14T13:06:41.92151Z","end":"2026-04-14T13:06:42.616828Z","steps":["trace[1828666269] 'agreement among raft nodes before linearized reading' (duration: 695.232453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:42.616867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:41.92148Z","time spent":"695.380227ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-14T13:06:42.61691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.275152ms","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-04-14T13:06:42.616934Z","caller":"traceutil/trace.go:171","msg":"trace[670209581] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1304; }","duration":"750.342483ms","start":"2026-04-14T13:06:41.866585Z","end":"2026-04-14T13:06:42.616928Z","steps":["trace[670209581] 'agreement among raft nodes before linearized reading' (duration: 750.287302ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:42.616949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:41.866557Z","time spent":"750.388365ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-14T13:06:42.616718Z","caller":"traceutil/trace.go:171","msg":"trace[1410901290] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1304; }","duration":"729.493147ms","start":"2026-04-14T13:06:41.887208Z","end":"2026-04-14T13:06:42.616701Z","steps":["trace[1410901290] 'agreement among raft nodes before linearized reading' (duration: 729.301422ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:42.617019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:41.887146Z","time spent":"729.868927ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-14T13:06:42.971371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.379328ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T13:06:42.971566Z","caller":"traceutil/trace.go:171","msg":"trace[1888280850] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"350.267879ms","start":"2026-04-14T13:06:42.621263Z","end":"2026-04-14T13:06:42.971531Z","steps":["trace[1888280850] 'process raft request' (duration: 227.596163ms)","trace[1888280850] 'compare' (duration: 122.229245ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T13:06:42.97166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:42.621253Z","time spent":"350.361531ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T13:06:43.022465Z","caller":"traceutil/trace.go:171","msg":"trace[1841655249] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"400.144837ms","start":"2026-04-14T13:06:42.62229Z","end":"2026-04-14T13:06:43.022435Z","steps":["trace[1841655249] 'process raft request' (duration: 399.936282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:43.022717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:42.622268Z","time spent":"400.283511ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T13:06:43.022734Z","caller":"traceutil/trace.go:171","msg":"trace[433022848] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"400.306861ms","start":"2026-04-14T13:06:42.622399Z","end":"2026-04-14T13:06:43.022706Z","steps":["trace[433022848] 'process raft request' (duration: 399.984413ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:06:43.022932Z","caller":"traceutil/trace.go:171","msg":"trace[901361090] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"399.352406ms","start":"2026-04-14T13:06:42.623561Z","end":"2026-04-14T13:06:43.022914Z","steps":["trace[901361090] 'process raft request' (duration: 399.062789ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:43.023024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:42.623554Z","time spent":"399.429738ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T13:06:43.022887Z","caller":"traceutil/trace.go:171","msg":"trace[276323435] linearizableReadLoop","detail":"{readStateIndex:1361; appliedIndex:1357; }","duration":"309.605662ms","start":"2026-04-14T13:06:42.713251Z","end":"2026-04-14T13:06:43.022856Z","steps":["trace[276323435] 'read index received' (duration: 135.624642ms)","trace[276323435] 'applied index is now lower than readState.Index' (duration: 173.97949ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T13:06:43.023059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.784427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T13:06:43.023096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:42.622364Z","time spent":"400.447035ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T13:06:43.023116Z","caller":"traceutil/trace.go:171","msg":"trace[1550725864] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1308; }","duration":"309.92997ms","start":"2026-04-14T13:06:42.713173Z","end":"2026-04-14T13:06:43.023103Z","steps":["trace[1550725864] 'agreement among raft nodes before linearized reading' (duration: 309.804897ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:43.023183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:42.713142Z","time spent":"310.007592ms","remote":"127.0.0.1:42830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-04-14T13:06:44.216835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.564857ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-04-14T13:06:44.796095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.601509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T13:06:44.796201Z","caller":"traceutil/trace.go:171","msg":"trace[2075225256] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1311; }","duration":"230.773583ms","start":"2026-04-14T13:06:44.565403Z","end":"2026-04-14T13:06:44.796177Z","steps":["trace[2075225256] 'range keys from in-memory index tree' (duration: 230.457905ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:44.79617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.701352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T13:06:44.796292Z","caller":"traceutil/trace.go:171","msg":"trace[43923779] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1311; }","duration":"232.922297ms","start":"2026-04-14T13:06:44.563341Z","end":"2026-04-14T13:06:44.796264Z","steps":["trace[43923779] 'count revisions from in-memory index tree' (duration: 232.558998ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:06:44.975993Z","caller":"traceutil/trace.go:171","msg":"trace[1559397491] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"133.549469ms","start":"2026-04-14T13:06:44.842414Z","end":"2026-04-14T13:06:44.975963Z","steps":["trace[1559397491] 'process raft request' (duration: 133.353864ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:45.267979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.96493ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T13:06:45.268131Z","caller":"traceutil/trace.go:171","msg":"trace[1273319857] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"236.037607ms","start":"2026-04-14T13:06:45.032066Z","end":"2026-04-14T13:06:45.268104Z","steps":["trace[1273319857] 'process raft request' (duration: 124.839631ms)","trace[1273319857] 'compare' (duration: 110.824026ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T13:06:45.268768Z","caller":"traceutil/trace.go:171","msg":"trace[1964707102] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"236.245571ms","start":"2026-04-14T13:06:45.032503Z","end":"2026-04-14T13:06:45.268749Z","steps":["trace[1964707102] 'process raft request' (duration: 236.077247ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:06:45.268929Z","caller":"traceutil/trace.go:171","msg":"trace[2031544457] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"236.377934ms","start":"2026-04-14T13:06:45.032537Z","end":"2026-04-14T13:06:45.268915Z","steps":["trace[2031544457] 'process raft request' (duration: 236.156679ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:06:45.268919Z","caller":"traceutil/trace.go:171","msg":"trace[1776003587] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"233.775779ms","start":"2026-04-14T13:06:45.035123Z","end":"2026-04-14T13:06:45.268899Z","steps":["trace[1776003587] 'process raft request' (duration: 233.693707ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:06:48.128475Z","caller":"traceutil/trace.go:171","msg":"trace[276605695] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"504.586803ms","start":"2026-04-14T13:06:47.623864Z","end":"2026-04-14T13:06:48.128451Z","steps":["trace[276605695] 'process raft request' (duration: 504.403628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:48.128632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:47.623831Z","time spent":"504.719025ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T13:06:48.129671Z","caller":"traceutil/trace.go:171","msg":"trace[1685440512] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"502.477889ms","start":"2026-04-14T13:06:47.627161Z","end":"2026-04-14T13:06:48.129639Z","steps":["trace[1685440512] 'process raft request' (duration: 502.331395ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:48.129927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:47.627146Z","time spent":"502.643073ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T13:06:48.490892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.496663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T13:06:48.491088Z","caller":"traceutil/trace.go:171","msg":"trace[372460349] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1334; }","duration":"277.798709ms","start":"2026-04-14T13:06:48.213258Z","end":"2026-04-14T13:06:48.491057Z","steps":["trace[372460349] 'count revisions from in-memory index tree' (duration: 277.234635ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:48.90973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.708605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T13:06:48.909826Z","caller":"traceutil/trace.go:171","msg":"trace[555814430] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:0; response_revision:1344; }","duration":"177.880569ms","start":"2026-04-14T13:06:48.731923Z","end":"2026-04-14T13:06:48.909804Z","steps":["trace[555814430] 'range keys from in-memory index tree' (duration: 177.553911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:49.686059Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367006258525786,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-14T13:06:49.958846Z","caller":"traceutil/trace.go:171","msg":"trace[2130440625] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"874.725312ms","start":"2026-04-14T13:06:49.084086Z","end":"2026-04-14T13:06:49.958811Z","steps":["trace[2130440625] 'process raft request' (duration: 874.487566ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:49.959065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:49.08404Z","time spent":"874.911597ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T13:06:50.011186Z","caller":"traceutil/trace.go:171","msg":"trace[270992008] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"728.607265ms","start":"2026-04-14T13:06:49.282546Z","end":"2026-04-14T13:06:50.011153Z","steps":["trace[270992008] 'process raft request' (duration: 728.360609ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:06:50.011458Z","caller":"traceutil/trace.go:171","msg":"trace[205846630] linearizableReadLoop","detail":"{readStateIndex:1405; appliedIndex:1403; }","duration":"826.092505ms","start":"2026-04-14T13:06:49.18532Z","end":"2026-04-14T13:06:50.011413Z","steps":["trace[205846630] 'read index received' (duration: 773.238861ms)","trace[205846630] 'applied index is now lower than readState.Index' (duration: 52.849324ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T13:06:50.011521Z","caller":"traceutil/trace.go:171","msg":"trace[1887570748] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"163.858425ms","start":"2026-04-14T13:06:49.847586Z","end":"2026-04-14T13:06:50.011444Z","steps":["trace[1887570748] 'process raft request' (duration: 163.515906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:50.011634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:49.282515Z","time spent":"728.760859ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T13:06:50.011678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"826.295591ms","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-04-14T13:06:50.011779Z","caller":"traceutil/trace.go:171","msg":"trace[1558421613] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1351; }","duration":"826.497165ms","start":"2026-04-14T13:06:49.185257Z","end":"2026-04-14T13:06:50.011754Z","steps":["trace[1558421613] 'agreement among raft nodes before linearized reading' (duration: 826.27137ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:50.011838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:49.185229Z","time spent":"826.595228ms","remote":"127.0.0.1:57064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-14T13:06:50.011896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"789.00215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-876dq\" ","response":"range_response_count:1 size:12642"} {"level":"info","ts":"2026-04-14T13:06:50.011967Z","caller":"traceutil/trace.go:171","msg":"trace[2088080470] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-876dq; range_end:; response_count:1; response_revision:1351; }","duration":"789.141533ms","start":"2026-04-14T13:06:49.222804Z","end":"2026-04-14T13:06:50.011945Z","steps":["trace[2088080470] 'agreement among raft nodes before linearized reading' (duration: 788.834296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:50.011992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.023596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-14T13:06:50.012022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:49.222779Z","time spent":"789.231866ms","remote":"127.0.0.1:42888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":12665,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-876dq\" "} {"level":"warn","ts":"2026-04-14T13:06:50.012251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.127893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-14T13:06:50.012304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.487238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-04-14T13:06:50.012349Z","caller":"traceutil/trace.go:171","msg":"trace[1665070118] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1351; }","duration":"626.637802ms","start":"2026-04-14T13:06:49.385701Z","end":"2026-04-14T13:06:50.012338Z","steps":["trace[1665070118] 'agreement among raft nodes before linearized reading' (duration: 626.496238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:50.011897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.820516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T13:06:50.012444Z","caller":"traceutil/trace.go:171","msg":"trace[597972389] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1351; }","duration":"493.41358ms","start":"2026-04-14T13:06:49.519012Z","end":"2026-04-14T13:06:50.012425Z","steps":["trace[597972389] 'agreement among raft nodes before linearized reading' (duration: 492.824655ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:50.012454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.695828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T13:06:50.012507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:49.51899Z","time spent":"493.492183ms","remote":"127.0.0.1:42846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"info","ts":"2026-04-14T13:06:50.012513Z","caller":"traceutil/trace.go:171","msg":"trace[1327064092] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1351; }","duration":"447.79529ms","start":"2026-04-14T13:06:49.564695Z","end":"2026-04-14T13:06:50.01249Z","steps":["trace[1327064092] 'agreement among raft nodes before linearized reading' (duration: 447.718068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:50.012561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:49.564665Z","time spent":"447.882612ms","remote":"127.0.0.1:42686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-14T13:06:50.012763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.716352ms","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-04-14T13:06:50.012802Z","caller":"traceutil/trace.go:171","msg":"trace[1670814546] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1351; }","duration":"729.781984ms","start":"2026-04-14T13:06:49.283011Z","end":"2026-04-14T13:06:50.012793Z","steps":["trace[1670814546] 'agreement among raft nodes before linearized reading' (duration: 729.659161ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:50.012836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:49.283001Z","time spent":"729.828365ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-14T13:06:50.012833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.848375ms","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-04-14T13:06:50.012882Z","caller":"traceutil/trace.go:171","msg":"trace[1754400621] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1351; }","duration":"727.913837ms","start":"2026-04-14T13:06:49.284957Z","end":"2026-04-14T13:06:50.012871Z","steps":["trace[1754400621] 'agreement among raft nodes before linearized reading' (duration: 727.690092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:50.012919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:49.284942Z","time spent":"727.969848ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-14T13:06:50.012923Z","caller":"traceutil/trace.go:171","msg":"trace[1752926599] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1351; }","duration":"257.081627ms","start":"2026-04-14T13:06:49.754955Z","end":"2026-04-14T13:06:50.012036Z","steps":["trace[1752926599] 'agreement among raft nodes before linearized reading' (duration: 257.000085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:50.013193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:49.385678Z","time spent":"627.504754ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-14T13:06:50.01318Z","caller":"traceutil/trace.go:171","msg":"trace[92087164] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1351; }","duration":"728.252326ms","start":"2026-04-14T13:06:49.284043Z","end":"2026-04-14T13:06:50.012296Z","steps":["trace[92087164] 'agreement among raft nodes before linearized reading' (duration: 728.054101ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:50.013894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:49.284002Z","time spent":"729.870918ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-14T13:06:54.709291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.444971ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-14T13:06:54.709616Z","caller":"traceutil/trace.go:171","msg":"trace[726285899] linearizableReadLoop","detail":"{readStateIndex:1427; appliedIndex:1426; }","duration":"1.054615242s","start":"2026-04-14T13:06:53.65498Z","end":"2026-04-14T13:06:54.709595Z","steps":["trace[726285899] 'read index received' (duration: 432.900593ms)","trace[726285899] 'applied index is now lower than readState.Index' (duration: 621.713478ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T13:06:54.709897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.054901588s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-04-14T13:06:54.709946Z","caller":"traceutil/trace.go:171","msg":"trace[829410362] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1371; }","duration":"1.05495708s","start":"2026-04-14T13:06:53.654973Z","end":"2026-04-14T13:06:54.70993Z","steps":["trace[829410362] 'agreement among raft nodes before linearized reading' (duration: 1.054794946s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:54.710227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.624035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T13:06:54.711039Z","caller":"traceutil/trace.go:171","msg":"trace[393089686] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1372; }","duration":"146.470856ms","start":"2026-04-14T13:06:54.564555Z","end":"2026-04-14T13:06:54.711026Z","steps":["trace[393089686] 'agreement among raft nodes before linearized reading' (duration: 145.618365ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:54.710313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.53043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-14T13:06:54.71114Z","caller":"traceutil/trace.go:171","msg":"trace[526448613] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1372; }","duration":"671.385652ms","start":"2026-04-14T13:06:54.039742Z","end":"2026-04-14T13:06:54.711127Z","steps":["trace[526448613] 'agreement among raft nodes before linearized reading' (duration: 670.489298ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:54.711186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:54.039729Z","time spent":"671.445404ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-14T13:06:54.710406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.689414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-14T13:06:54.711376Z","caller":"traceutil/trace.go:171","msg":"trace[739829616] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1372; }","duration":"671.67967ms","start":"2026-04-14T13:06:54.039686Z","end":"2026-04-14T13:06:54.711366Z","steps":["trace[739829616] 'agreement among raft nodes before linearized reading' (duration: 670.660963ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:54.711409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:54.039675Z","time spent":"671.72413ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-14T13:06:54.71036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.23456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-14T13:06:54.711511Z","caller":"traceutil/trace.go:171","msg":"trace[377011296] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1372; }","duration":"556.430371ms","start":"2026-04-14T13:06:54.155063Z","end":"2026-04-14T13:06:54.711493Z","steps":["trace[377011296] 'agreement among raft nodes before linearized reading' (duration: 555.186589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:54.71155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:54.155041Z","time spent":"556.497053ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-14T13:06:54.710488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.785793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-14T13:06:54.711644Z","caller":"traceutil/trace.go:171","msg":"trace[450131552] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1372; }","duration":"676.989443ms","start":"2026-04-14T13:06:54.034645Z","end":"2026-04-14T13:06:54.711634Z","steps":["trace[450131552] 'agreement among raft nodes before linearized reading' (duration: 675.785532ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:54.711678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:54.03462Z","time spent":"677.049645ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-14T13:06:54.71054Z","caller":"traceutil/trace.go:171","msg":"trace[427985057] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"684.928683ms","start":"2026-04-14T13:06:54.025594Z","end":"2026-04-14T13:06:54.710522Z","steps":["trace[427985057] 'process raft request' (duration: 683.812345ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:54.711827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:54.025571Z","time spent":"686.192046ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T13:06:54.710337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.069833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-14T13:06:54.711948Z","caller":"traceutil/trace.go:171","msg":"trace[775145645] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1372; }","duration":"735.746207ms","start":"2026-04-14T13:06:53.976186Z","end":"2026-04-14T13:06:54.711932Z","steps":["trace[775145645] 'agreement among raft nodes before linearized reading' (duration: 733.89939ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:54.711989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:53.976166Z","time spent":"735.812508ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-14T13:06:54.710642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.705558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T13:06:54.712119Z","caller":"traceutil/trace.go:171","msg":"trace[2082398236] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1372; }","duration":"111.225287ms","start":"2026-04-14T13:06:54.600882Z","end":"2026-04-14T13:06:54.712107Z","steps":["trace[2082398236] 'agreement among raft nodes before linearized reading' (duration: 109.704538ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:06:54.709995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:06:53.654918Z","time spent":"1.055063162s","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-14T13:07:10.048757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.505924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-14T13:07:10.048824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.806008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T13:07:10.04912Z","caller":"traceutil/trace.go:171","msg":"trace[917501061] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1445; }","duration":"138.123246ms","start":"2026-04-14T13:07:09.910943Z","end":"2026-04-14T13:07:10.049066Z","steps":["trace[917501061] 'count revisions from in-memory index tree' (duration: 137.649005ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:07:10.048934Z","caller":"traceutil/trace.go:171","msg":"trace[330824239] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1445; }","duration":"153.808431ms","start":"2026-04-14T13:07:09.895105Z","end":"2026-04-14T13:07:10.048913Z","steps":["trace[330824239] 'count revisions from in-memory index tree' (duration: 153.291508ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:07:11.076515Z","caller":"traceutil/trace.go:171","msg":"trace[1464228492] linearizableReadLoop","detail":"{readStateIndex:1508; appliedIndex:1507; }","duration":"177.833867ms","start":"2026-04-14T13:07:10.89865Z","end":"2026-04-14T13:07:11.076484Z","steps":["trace[1464228492] 'read index received' (duration: 137.865718ms)","trace[1464228492] 'applied index is now lower than readState.Index' (duration: 39.956938ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T13:07:11.076551Z","caller":"traceutil/trace.go:171","msg":"trace[775915890] transaction","detail":"{read_only:false; response_revision:1449; number_of_response:1; }","duration":"178.232757ms","start":"2026-04-14T13:07:10.89827Z","end":"2026-04-14T13:07:11.076503Z","steps":["trace[775915890] 'process raft request' (duration: 138.30092ms)","trace[775915890] 'compare' (duration: 39.63671ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T13:07:11.076729Z","caller":"traceutil/trace.go:171","msg":"trace[808129213] transaction","detail":"{read_only:false; response_revision:1450; number_of_response:1; }","duration":"178.078434ms","start":"2026-04-14T13:07:10.898637Z","end":"2026-04-14T13:07:11.076715Z","steps":["trace[808129213] 'process raft request' (duration: 177.793986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:07:11.076939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.119605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T13:07:11.077067Z","caller":"traceutil/trace.go:171","msg":"trace[1605311493] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1450; }","duration":"178.426183ms","start":"2026-04-14T13:07:10.898595Z","end":"2026-04-14T13:07:11.077021Z","steps":["trace[1605311493] 'agreement among raft nodes before linearized reading' (duration: 177.995311ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:07:11.077256Z","caller":"traceutil/trace.go:171","msg":"trace[362478057] transaction","detail":"{read_only:false; response_revision:1451; number_of_response:1; }","duration":"178.519065ms","start":"2026-04-14T13:07:10.898718Z","end":"2026-04-14T13:07:11.077237Z","steps":["trace[362478057] 'process raft request' (duration: 177.94944ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:07:11.077669Z","caller":"traceutil/trace.go:171","msg":"trace[1808065206] transaction","detail":"{read_only:false; response_revision:1452; number_of_response:1; }","duration":"178.816573ms","start":"2026-04-14T13:07:10.898833Z","end":"2026-04-14T13:07:11.07765Z","steps":["trace[1808065206] 'process raft request' (duration: 178.155316ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:07:11.07833Z","caller":"traceutil/trace.go:171","msg":"trace[1253551031] transaction","detail":"{read_only:false; response_revision:1453; number_of_response:1; }","duration":"179.488989ms","start":"2026-04-14T13:07:10.89882Z","end":"2026-04-14T13:07:11.07831Z","steps":["trace[1253551031] 'process raft request' (duration: 178.636928ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:07:13.257471Z","caller":"traceutil/trace.go:171","msg":"trace[1252855146] transaction","detail":"{read_only:false; response_revision:1457; number_of_response:1; }","duration":"171.472826ms","start":"2026-04-14T13:07:13.085963Z","end":"2026-04-14T13:07:13.257436Z","steps":["trace[1252855146] 'process raft request' (duration: 171.041086ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:07:13.481203Z","caller":"traceutil/trace.go:171","msg":"trace[485226268] transaction","detail":"{read_only:false; response_revision:1458; number_of_response:1; }","duration":"394.628828ms","start":"2026-04-14T13:07:13.086516Z","end":"2026-04-14T13:07:13.481145Z","steps":["trace[485226268] 'process raft request' (duration: 384.322688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:07:13.482099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.222949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-04-14T13:07:13.482206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:07:13.086481Z","time spent":"395.607782ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T13:07:13.482252Z","caller":"traceutil/trace.go:171","msg":"trace[1649665164] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1461; }","duration":"295.454464ms","start":"2026-04-14T13:07:13.186768Z","end":"2026-04-14T13:07:13.482222Z","steps":["trace[1649665164] 'agreement among raft nodes before linearized reading' (duration: 295.144247ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:07:13.481306Z","caller":"traceutil/trace.go:171","msg":"trace[1879209109] transaction","detail":"{read_only:false; response_revision:1459; number_of_response:1; }","duration":"394.180477ms","start":"2026-04-14T13:07:13.087075Z","end":"2026-04-14T13:07:13.481256Z","steps":["trace[1879209109] 'process raft request' (duration: 393.957292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:07:13.482652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:07:13.087064Z","time spent":"395.484109ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T13:07:13.481763Z","caller":"traceutil/trace.go:171","msg":"trace[1463594125] transaction","detail":"{read_only:false; response_revision:1460; number_of_response:1; }","duration":"394.014313ms","start":"2026-04-14T13:07:13.087704Z","end":"2026-04-14T13:07:13.481718Z","steps":["trace[1463594125] 'process raft request' (duration: 393.4984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:07:13.482905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:07:13.087693Z","time spent":"395.096439ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T13:07:13.48187Z","caller":"traceutil/trace.go:171","msg":"trace[1328763607] linearizableReadLoop","detail":"{readStateIndex:1520; appliedIndex:1515; }","duration":"295.009844ms","start":"2026-04-14T13:07:13.186839Z","end":"2026-04-14T13:07:13.481849Z","steps":["trace[1328763607] 'read index received' (duration: 70.236072ms)","trace[1328763607] 'applied index is now lower than readState.Index' (duration: 224.772092ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T13:07:13.481974Z","caller":"traceutil/trace.go:171","msg":"trace[1549985364] transaction","detail":"{read_only:false; response_revision:1461; number_of_response:1; }","duration":"393.880809ms","start":"2026-04-14T13:07:13.088058Z","end":"2026-04-14T13:07:13.481939Z","steps":["trace[1549985364] 'process raft request' (duration: 393.656364ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T13:07:13.483071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T13:07:13.088049Z","time spent":"394.949036ms","remote":"127.0.0.1:42960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T13:07:13.483405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.198665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-04-14T13:07:13.483488Z","caller":"traceutil/trace.go:171","msg":"trace[1040144525] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1461; }","duration":"235.41726ms","start":"2026-04-14T13:07:13.248055Z","end":"2026-04-14T13:07:13.483472Z","steps":["trace[1040144525] 'agreement among raft nodes before linearized reading' (duration: 235.110073ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:08:14.053832Z","caller":"traceutil/trace.go:171","msg":"trace[837481427] transaction","detail":"{read_only:false; response_revision:1737; number_of_response:1; }","duration":"220.452954ms","start":"2026-04-14T13:08:13.833325Z","end":"2026-04-14T13:08:14.053778Z","steps":["trace[837481427] 'process raft request' (duration: 219.594373ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:08:14.054072Z","caller":"traceutil/trace.go:171","msg":"trace[1266285407] transaction","detail":"{read_only:false; response_revision:1740; number_of_response:1; }","duration":"219.942301ms","start":"2026-04-14T13:08:13.83412Z","end":"2026-04-14T13:08:14.054062Z","steps":["trace[1266285407] 'process raft request' (duration: 219.784877ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:08:14.054134Z","caller":"traceutil/trace.go:171","msg":"trace[723769501] transaction","detail":"{read_only:false; response_revision:1739; number_of_response:1; }","duration":"220.240509ms","start":"2026-04-14T13:08:13.833847Z","end":"2026-04-14T13:08:14.054087Z","steps":["trace[723769501] 'process raft request' (duration: 219.908181ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:08:14.054408Z","caller":"traceutil/trace.go:171","msg":"trace[36970535] transaction","detail":"{read_only:false; response_revision:1738; number_of_response:1; }","duration":"220.663509ms","start":"2026-04-14T13:08:13.833674Z","end":"2026-04-14T13:08:14.054338Z","steps":["trace[36970535] 'process raft request' (duration: 219.969032ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T13:08:25.405367Z","caller":"traceutil/trace.go:171","msg":"trace[1759655295] transaction","detail":"{read_only:false; response_revision:1789; number_of_response:1; }","duration":"105.885683ms","start":"2026-04-14T13:08:25.29945Z","end":"2026-04-14T13:08:25.405335Z","steps":["trace[1759655295] 'process raft request' (duration: 47.717764ms)","trace[1759655295] 'compare' (duration: 58.034275ms)"],"step_count":2}