{"level":"warn","ts":"2026-06-09T01:04:26.803189Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T01:04:26.803322Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.53: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.53:2380","--initial-cluster=instance=https://199.204.45.53:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.53:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.53:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-09T01:04:26.803438Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T01:04:26.803464Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-06-09T01:04:26.803503Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-09T01:04:26.804469Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"]} {"level":"info","ts":"2026-06-09T01:04:26.804567Z","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.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.53:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-09T01:04:26.808558Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.718694ms"} {"level":"info","ts":"2026-06-09T01:04:26.814804Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c47ca1a7b1fe506b","cluster-id":"95bd21e158fabf07"} {"level":"info","ts":"2026-06-09T01:04:26.814868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=()"} {"level":"info","ts":"2026-06-09T01:04:26.81489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 0"} {"level":"info","ts":"2026-06-09T01:04:26.814901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c47ca1a7b1fe506b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-09T01:04:26.814913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 1"} {"level":"info","ts":"2026-06-09T01:04:26.814944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"warn","ts":"2026-06-09T01:04:26.82263Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-09T01:04:26.8239Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-09T01:04:26.824969Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-09T01:04:26.827711Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c47ca1a7b1fe506b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-09T01:04:26.827983Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-09T01:04:26.828124Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-09T01:04:26.828162Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-09T01:04:26.828095Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c47ca1a7b1fe506b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-09T01:04:26.828943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"info","ts":"2026-06-09T01:04:26.829061Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"c47ca1a7b1fe506b","added-peer-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-06-09T01:04:26.832172Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-09T01:04:26.832369Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-06-09T01:04:26.832405Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-06-09T01:04:26.832478Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c47ca1a7b1fe506b","initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-09T01:04:26.832591Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-09T01:04:27.515634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b is starting a new election at term 1"} {"level":"info","ts":"2026-06-09T01:04:27.515694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became pre-candidate at term 1"} {"level":"info","ts":"2026-06-09T01:04:27.515736Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgPreVoteResp from c47ca1a7b1fe506b at term 1"} {"level":"info","ts":"2026-06-09T01:04:27.515763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became candidate at term 2"} {"level":"info","ts":"2026-06-09T01:04:27.515778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgVoteResp from c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-06-09T01:04:27.515799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became leader at term 2"} {"level":"info","ts":"2026-06-09T01:04:27.515816Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c47ca1a7b1fe506b elected leader c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-06-09T01:04:27.517601Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T01:04:27.517818Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T01:04:27.51789Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T01:04:27.518429Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-09T01:04:27.518647Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-09T01:04:27.519294Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T01:04:27.519413Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T01:04:27.519449Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T01:04:27.520834Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.53:2379"} {"level":"info","ts":"2026-06-09T01:04:27.517507Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c47ca1a7b1fe506b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.53:2379]}","request-path":"/0/members/c47ca1a7b1fe506b/attributes","cluster-id":"95bd21e158fabf07","publish-timeout":"7s"} {"level":"info","ts":"2026-06-09T01:04:27.522874Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-06-09T01:04:29.173189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.382123ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-06-09T01:04:29.173291Z","caller":"traceutil/trace.go:171","msg":"trace[199970788] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"391.048066ms","start":"2026-06-09T01:04:28.78223Z","end":"2026-06-09T01:04:29.173278Z","steps":["trace[199970788] 'read index received' (duration: 9.277679ms)","trace[199970788] 'applied index is now lower than readState.Index' (duration: 381.769527ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:04:29.173358Z","caller":"traceutil/trace.go:171","msg":"trace[793053406] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"399.200858ms","start":"2026-06-09T01:04:28.774119Z","end":"2026-06-09T01:04:29.17332Z","steps":["trace[793053406] 'process raft request' (duration: 111.256692ms)","trace[793053406] 'compare' (duration: 287.202841ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:04:29.173437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.212097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T01:04:29.173463Z","caller":"traceutil/trace.go:171","msg":"trace[1343267885] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:3; }","duration":"391.261747ms","start":"2026-06-09T01:04:28.782193Z","end":"2026-06-09T01:04:29.173455Z","steps":["trace[1343267885] 'agreement among raft nodes before linearized reading' (duration: 391.149456ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.173488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:28.78218Z","time spent":"391.301687ms","remote":"127.0.0.1:50646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":28,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-06-09T01:04:29.173546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:28.774101Z","time spent":"399.348039ms","remote":"127.0.0.1:50344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T01:04:29.176196Z","caller":"traceutil/trace.go:171","msg":"trace[1451003927] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"337.185231ms","start":"2026-06-09T01:04:28.838964Z","end":"2026-06-09T01:04:29.176149Z","steps":["trace[1451003927] 'process raft request' (duration: 336.90826ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:29.176297Z","caller":"traceutil/trace.go:171","msg":"trace[991781307] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"324.755202ms","start":"2026-06-09T01:04:28.851526Z","end":"2026-06-09T01:04:29.176281Z","steps":["trace[991781307] 'process raft request' (duration: 324.637961ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.176345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:28.838944Z","time spent":"337.332102ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:29.176386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:28.851512Z","time spent":"324.839532ms","remote":"127.0.0.1:50456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:29.176498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.3298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T01:04:29.176625Z","caller":"traceutil/trace.go:171","msg":"trace[1793164141] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"333.017305ms","start":"2026-06-09T01:04:28.843562Z","end":"2026-06-09T01:04:29.176579Z","steps":["trace[1793164141] 'process raft request' (duration: 332.399601ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:29.176625Z","caller":"traceutil/trace.go:171","msg":"trace[453282357] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"357.44087ms","start":"2026-06-09T01:04:28.819117Z","end":"2026-06-09T01:04:29.176557Z","steps":["trace[453282357] 'agreement among raft nodes before linearized reading' (duration: 357.133899ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.176707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:28.843544Z","time spent":"333.111035ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:29.176763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:28.819104Z","time spent":"357.621611ms","remote":"127.0.0.1:50408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-06-09T01:04:29.176843Z","caller":"traceutil/trace.go:171","msg":"trace[964233532] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"333.170065ms","start":"2026-06-09T01:04:28.843663Z","end":"2026-06-09T01:04:29.176833Z","steps":["trace[964233532] 'process raft request' (duration: 332.34571ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.176869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.0724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-09T01:04:29.176911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:28.843631Z","time spent":"333.251295ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:04:29.177018Z","caller":"traceutil/trace.go:171","msg":"trace[800844197] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"320.923668ms","start":"2026-06-09T01:04:28.856084Z","end":"2026-06-09T01:04:29.177007Z","steps":["trace[800844197] 'process raft request' (duration: 320.110822ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:29.177042Z","caller":"traceutil/trace.go:171","msg":"trace[1099684591] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"333.301336ms","start":"2026-06-09T01:04:28.843728Z","end":"2026-06-09T01:04:29.17703Z","steps":["trace[1099684591] 'process raft request' (duration: 332.30802ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.177087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:28.84371Z","time spent":"333.357696ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:29.177143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.188638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T01:04:29.177177Z","caller":"traceutil/trace.go:171","msg":"trace[723143779] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:11; }","duration":"274.257658ms","start":"2026-06-09T01:04:28.902911Z","end":"2026-06-09T01:04:29.177168Z","steps":["trace[723143779] 'agreement among raft nodes before linearized reading' (duration: 274.210438ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:29.177213Z","caller":"traceutil/trace.go:171","msg":"trace[701591498] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"333.274746ms","start":"2026-06-09T01:04:28.843928Z","end":"2026-06-09T01:04:29.177203Z","steps":["trace[701591498] 'process raft request' (duration: 332.188149ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.177267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:28.843921Z","time spent":"333.322686ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:29.177087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:28.85607Z","time spent":"320.984998ms","remote":"127.0.0.1:50508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:29.177311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.016777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-09T01:04:29.177216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.933379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T01:04:29.17735Z","caller":"traceutil/trace.go:171","msg":"trace[1904975030] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"333.351786ms","start":"2026-06-09T01:04:28.843987Z","end":"2026-06-09T01:04:29.177339Z","steps":["trace[1904975030] 'process raft request' (duration: 332.153238ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:29.177371Z","caller":"traceutil/trace.go:171","msg":"trace[815771658] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"338.095537ms","start":"2026-06-09T01:04:28.839262Z","end":"2026-06-09T01:04:29.177357Z","steps":["trace[815771658] 'agreement among raft nodes before linearized reading' (duration: 337.990286ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:29.177381Z","caller":"traceutil/trace.go:171","msg":"trace[1957232777] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"340.1404ms","start":"2026-06-09T01:04:28.837225Z","end":"2026-06-09T01:04:29.177366Z","steps":["trace[1957232777] 'agreement among raft nodes before linearized reading' (duration: 339.928639ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:29.176913Z","caller":"traceutil/trace.go:171","msg":"trace[644455970] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"287.17314ms","start":"2026-06-09T01:04:28.889726Z","end":"2026-06-09T01:04:29.176899Z","steps":["trace[644455970] 'agreement among raft nodes before linearized reading' (duration: 287.10031ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.177466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:28.837204Z","time spent":"340.250611ms","remote":"127.0.0.1:50408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-09T01:04:29.177499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:28.839254Z","time spent":"338.231818ms","remote":"127.0.0.1:50372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-06-09T01:04:29.177402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:28.843973Z","time spent":"333.405586ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:29.177133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.780326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.53\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T01:04:29.178082Z","caller":"traceutil/trace.go:171","msg":"trace[1851936741] range","detail":"{range_begin:/registry/masterleases/199.204.45.53; range_end:; response_count:0; response_revision:11; }","duration":"338.699491ms","start":"2026-06-09T01:04:28.83931Z","end":"2026-06-09T01:04:29.178009Z","steps":["trace[1851936741] 'agreement among raft nodes before linearized reading' (duration: 337.778936ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.178181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:28.839296Z","time spent":"338.856982ms","remote":"127.0.0.1:50310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.204.45.53\" "} {"level":"warn","ts":"2026-06-09T01:04:29.506574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.943819ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-09T01:04:29.506698Z","caller":"traceutil/trace.go:171","msg":"trace[524246266] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"324.694514ms","start":"2026-06-09T01:04:29.181986Z","end":"2026-06-09T01:04:29.506681Z","steps":["trace[524246266] 'process raft request' (duration: 96.557904ms)","trace[524246266] 'compare' (duration: 227.723298ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:04:29.50688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.181947Z","time spent":"324.856995ms","remote":"127.0.0.1:50408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:04:29.516298Z","caller":"traceutil/trace.go:171","msg":"trace[1745088113] transaction","detail":"{read_only:false; number_of_response:0; response_revision:14; }","duration":"332.511504ms","start":"2026-06-09T01:04:29.183765Z","end":"2026-06-09T01:04:29.516277Z","steps":["trace[1745088113] 'process raft request' (duration: 332.439974ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:29.516399Z","caller":"traceutil/trace.go:171","msg":"trace[210166341] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"333.73162ms","start":"2026-06-09T01:04:29.182645Z","end":"2026-06-09T01:04:29.516377Z","steps":["trace[210166341] 'process raft request' (duration: 333.422259ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:29.516508Z","caller":"traceutil/trace.go:171","msg":"trace[472409935] linearizableReadLoop","detail":"{readStateIndex:24; appliedIndex:14; }","duration":"282.779847ms","start":"2026-06-09T01:04:29.2337Z","end":"2026-06-09T01:04:29.51648Z","steps":["trace[472409935] 'read index received' (duration: 44.928335ms)","trace[472409935] 'applied index is now lower than readState.Index' (duration: 237.850342ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:04:29.516499Z","caller":"traceutil/trace.go:171","msg":"trace[1883448270] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"332.498503ms","start":"2026-06-09T01:04:29.183867Z","end":"2026-06-09T01:04:29.516366Z","steps":["trace[1883448270] 'process raft request' (duration: 332.359073ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.516552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.18263Z","time spent":"333.868451ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:29.516575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.183751Z","time spent":"332.612584ms","remote":"127.0.0.1:50408","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:04:29.516619Z","caller":"traceutil/trace.go:171","msg":"trace[1938084273] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"332.688735ms","start":"2026-06-09T01:04:29.183919Z","end":"2026-06-09T01:04:29.516607Z","steps":["trace[1938084273] 'process raft request' (duration: 332.359913ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.516675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.183863Z","time spent":"332.740255ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:29.516725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.183908Z","time spent":"332.739155ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:04:29.516815Z","caller":"traceutil/trace.go:171","msg":"trace[1366325525] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"333.952802ms","start":"2026-06-09T01:04:29.182848Z","end":"2026-06-09T01:04:29.516801Z","steps":["trace[1366325525] 'process raft request' (duration: 333.325198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.516885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.18283Z","time spent":"334.020822ms","remote":"127.0.0.1:50646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:04:29.516984Z","caller":"traceutil/trace.go:171","msg":"trace[573158822] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"332.836295ms","start":"2026-06-09T01:04:29.184134Z","end":"2026-06-09T01:04:29.51697Z","steps":["trace[573158822] 'process raft request' (duration: 332.177661ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.517041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.18412Z","time spent":"332.895835ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:29.51708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.368362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-06-09T01:04:29.517077Z","caller":"traceutil/trace.go:171","msg":"trace[1832854550] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"332.09229ms","start":"2026-06-09T01:04:29.184907Z","end":"2026-06-09T01:04:29.517Z","steps":["trace[1832854550] 'process raft request' (duration: 331.455916ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:29.51719Z","caller":"traceutil/trace.go:171","msg":"trace[1936756497] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"332.944366ms","start":"2026-06-09T01:04:29.184234Z","end":"2026-06-09T01:04:29.517178Z","steps":["trace[1936756497] 'process raft request' (duration: 332.10872ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.517276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.184219Z","time spent":"333.025966ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:29.51738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.405541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-06-09T01:04:29.517416Z","caller":"traceutil/trace.go:171","msg":"trace[727148840] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"110.461122ms","start":"2026-06-09T01:04:29.406945Z","end":"2026-06-09T01:04:29.517406Z","steps":["trace[727148840] 'agreement among raft nodes before linearized reading' (duration: 110.398522ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.517415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.217903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T01:04:29.517448Z","caller":"traceutil/trace.go:171","msg":"trace[183692443] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:20; }","duration":"134.270994ms","start":"2026-06-09T01:04:29.383167Z","end":"2026-06-09T01:04:29.517438Z","steps":["trace[183692443] 'agreement among raft nodes before linearized reading' (duration: 134.226483ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:29.517463Z","caller":"traceutil/trace.go:171","msg":"trace[626516946] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"277.464693ms","start":"2026-06-09T01:04:29.23968Z","end":"2026-06-09T01:04:29.517145Z","steps":["trace[626516946] 'agreement among raft nodes before linearized reading' (duration: 277.236562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.517471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.761624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T01:04:29.517504Z","caller":"traceutil/trace.go:171","msg":"trace[583969297] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:20; }","duration":"283.827354ms","start":"2026-06-09T01:04:29.233668Z","end":"2026-06-09T01:04:29.517495Z","steps":["trace[583969297] 'agreement among raft nodes before linearized reading' (duration: 283.503272ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.517591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.184896Z","time spent":"332.286872ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:04:29.517147Z","caller":"traceutil/trace.go:171","msg":"trace[1226873628] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"330.116427ms","start":"2026-06-09T01:04:29.187015Z","end":"2026-06-09T01:04:29.517131Z","steps":["trace[1226873628] 'process raft request' (duration: 329.374203ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.517733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.187Z","time spent":"330.680602ms","remote":"127.0.0.1:50456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3478,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:04:29.823047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.651985ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-09T01:04:29.823239Z","caller":"traceutil/trace.go:171","msg":"trace[304263836] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"304.170283ms","start":"2026-06-09T01:04:29.519043Z","end":"2026-06-09T01:04:29.823214Z","steps":["trace[304263836] 'process raft request' (duration: 122.238606ms)","trace[304263836] 'compare' (duration: 181.448134ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:04:29.823362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.519022Z","time spent":"304.313443ms","remote":"127.0.0.1:50408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:04:29.83195Z","caller":"traceutil/trace.go:171","msg":"trace[44048762] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"310.01613ms","start":"2026-06-09T01:04:29.521905Z","end":"2026-06-09T01:04:29.831921Z","steps":["trace[44048762] 'process raft request' (duration: 309.884289ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:29.832027Z","caller":"traceutil/trace.go:171","msg":"trace[1929610119] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"312.590476ms","start":"2026-06-09T01:04:29.519399Z","end":"2026-06-09T01:04:29.831989Z","steps":["trace[1929610119] 'process raft request' (duration: 312.196614ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.832122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.521899Z","time spent":"310.136671ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:29.832156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.519378Z","time spent":"312.728887ms","remote":"127.0.0.1:50396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":357,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:29.832187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.309328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T01:04:29.832319Z","caller":"traceutil/trace.go:171","msg":"trace[1709753011] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:29; }","duration":"311.49075ms","start":"2026-06-09T01:04:29.520814Z","end":"2026-06-09T01:04:29.832305Z","steps":["trace[1709753011] 'agreement among raft nodes before linearized reading' (duration: 311.272118ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.832371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.520797Z","time spent":"311.56171ms","remote":"127.0.0.1:50424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"info","ts":"2026-06-09T01:04:29.832369Z","caller":"traceutil/trace.go:171","msg":"trace[881552529] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"310.694974ms","start":"2026-06-09T01:04:29.52165Z","end":"2026-06-09T01:04:29.832345Z","steps":["trace[881552529] 'process raft request' (duration: 310.09168ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.832507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.521633Z","time spent":"310.811296ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:04:29.832614Z","caller":"traceutil/trace.go:171","msg":"trace[13563123] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"310.162542ms","start":"2026-06-09T01:04:29.522438Z","end":"2026-06-09T01:04:29.832601Z","steps":["trace[13563123] 'process raft request' (duration: 309.508187ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:29.832716Z","caller":"traceutil/trace.go:171","msg":"trace[1782727632] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"310.138482ms","start":"2026-06-09T01:04:29.522531Z","end":"2026-06-09T01:04:29.83267Z","steps":["trace[1782727632] 'process raft request' (duration: 309.441667ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.832749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.522429Z","time spent":"310.226142ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":956,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:29.832783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.522517Z","time spent":"310.230643ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:04:29.832798Z","caller":"traceutil/trace.go:171","msg":"trace[1972007112] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"310.881816ms","start":"2026-06-09T01:04:29.5219Z","end":"2026-06-09T01:04:29.832782Z","steps":["trace[1972007112] 'process raft request' (duration: 309.938899ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:29.832035Z","caller":"traceutil/trace.go:171","msg":"trace[1820086495] linearizableReadLoop","detail":"{readStateIndex:26; appliedIndex:24; }","duration":"311.155397ms","start":"2026-06-09T01:04:29.520855Z","end":"2026-06-09T01:04:29.83201Z","steps":["trace[1820086495] 'read index received' (duration: 120.539106ms)","trace[1820086495] 'applied index is now lower than readState.Index' (duration: 190.615191ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:04:29.832849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.521875Z","time spent":"310.948596ms","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:04:29.832917Z","caller":"traceutil/trace.go:171","msg":"trace[1825417684] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"310.934867ms","start":"2026-06-09T01:04:29.521967Z","end":"2026-06-09T01:04:29.832901Z","steps":["trace[1825417684] 'process raft request' (duration: 309.94021ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.832942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.831386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T01:04:29.832964Z","caller":"traceutil/trace.go:171","msg":"trace[575894450] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:29; }","duration":"310.870636ms","start":"2026-06-09T01:04:29.522087Z","end":"2026-06-09T01:04:29.832958Z","steps":["trace[575894450] 'agreement among raft nodes before linearized reading' (duration: 310.830436ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.832989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.522078Z","time spent":"310.906656ms","remote":"127.0.0.1:50396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":28,"request content":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" "} {"level":"warn","ts":"2026-06-09T01:04:29.832996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.52196Z","time spent":"310.991057ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":947,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:29.833091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.182484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T01:04:29.832754Z","caller":"traceutil/trace.go:171","msg":"trace[1168192365] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"310.776306ms","start":"2026-06-09T01:04:29.521964Z","end":"2026-06-09T01:04:29.83274Z","steps":["trace[1168192365] 'process raft request' (duration: 309.91198ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:29.833118Z","caller":"traceutil/trace.go:171","msg":"trace[915927614] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:29; }","duration":"260.227025ms","start":"2026-06-09T01:04:29.572881Z","end":"2026-06-09T01:04:29.833108Z","steps":["trace[915927614] 'agreement among raft nodes before linearized reading' (duration: 260.194144ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:29.833156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.521957Z","time spent":"311.173928ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:30.350729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.552222ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-09T01:04:30.350935Z","caller":"traceutil/trace.go:171","msg":"trace[558570679] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"513.427626ms","start":"2026-06-09T01:04:29.837468Z","end":"2026-06-09T01:04:30.350896Z","steps":["trace[558570679] 'process raft request' (duration: 121.626913ms)","trace[558570679] 'compare' (duration: 391.391631ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:04:30.351087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.837454Z","time spent":"513.569487ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:04:30.351085Z","caller":"traceutil/trace.go:171","msg":"trace[953832204] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"513.528287ms","start":"2026-06-09T01:04:29.837482Z","end":"2026-06-09T01:04:30.351011Z","steps":["trace[953832204] 'process raft request' (duration: 513.342696ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:30.351279Z","caller":"traceutil/trace.go:171","msg":"trace[274112299] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"513.036233ms","start":"2026-06-09T01:04:29.838233Z","end":"2026-06-09T01:04:30.351269Z","steps":["trace[274112299] 'process raft request' (duration: 512.758112ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:30.351346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.838223Z","time spent":"513.086744ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":926,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:04:30.351546Z","caller":"traceutil/trace.go:171","msg":"trace[215637410] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"513.973749ms","start":"2026-06-09T01:04:29.837562Z","end":"2026-06-09T01:04:30.351536Z","steps":["trace[215637410] 'process raft request' (duration: 513.356915ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:30.351599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.837547Z","time spent":"514.030569ms","remote":"127.0.0.1:50628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:30.351617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.837472Z","time spent":"513.663568ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":983,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:04:30.351711Z","caller":"traceutil/trace.go:171","msg":"trace[262028519] linearizableReadLoop","detail":"{readStateIndex:42; appliedIndex:33; }","duration":"512.589232ms","start":"2026-06-09T01:04:29.839081Z","end":"2026-06-09T01:04:30.35167Z","steps":["trace[262028519] 'read index received' (duration: 6.247601ms)","trace[262028519] 'applied index is now lower than readState.Index' (duration: 506.340781ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:04:30.351821Z","caller":"traceutil/trace.go:171","msg":"trace[718771374] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"513.462456ms","start":"2026-06-09T01:04:29.838349Z","end":"2026-06-09T01:04:30.351812Z","steps":["trace[718771374] 'process raft request' (duration: 512.736221ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:30.351875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.838343Z","time spent":"513.511337ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":713,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:04:30.352023Z","caller":"traceutil/trace.go:171","msg":"trace[888332327] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"513.750028ms","start":"2026-06-09T01:04:29.838264Z","end":"2026-06-09T01:04:30.352014Z","steps":["trace[888332327] 'process raft request' (duration: 512.754841ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:30.352069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.838254Z","time spent":"513.795478ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:04:30.352123Z","caller":"traceutil/trace.go:171","msg":"trace[1831031110] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"513.378396ms","start":"2026-06-09T01:04:29.838731Z","end":"2026-06-09T01:04:30.35211Z","steps":["trace[1831031110] 'process raft request' (duration: 512.840302ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:30.352227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.838723Z","time spent":"513.465077ms","remote":"127.0.0.1:50396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3004,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:30.352361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.866411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/default/\" range_end:\"/registry/resourcequotas/default0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T01:04:30.35235Z","caller":"traceutil/trace.go:171","msg":"trace[1989988991] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"513.488896ms","start":"2026-06-09T01:04:29.838835Z","end":"2026-06-09T01:04:30.352324Z","steps":["trace[1989988991] 'process raft request' (duration: 512.803432ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:30.352402Z","caller":"traceutil/trace.go:171","msg":"trace[180891933] range","detail":"{range_begin:/registry/resourcequotas/default/; range_end:/registry/resourcequotas/default0; response_count:0; response_revision:38; }","duration":"504.912502ms","start":"2026-06-09T01:04:29.84748Z","end":"2026-06-09T01:04:30.352392Z","steps":["trace[180891933] 'agreement among raft nodes before linearized reading' (duration: 504.758071ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:30.352413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.385672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-09T01:04:30.352444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.847453Z","time spent":"504.979112ms","remote":"127.0.0.1:50372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/default/\" range_end:\"/registry/resourcequotas/default0\" "} {"level":"warn","ts":"2026-06-09T01:04:30.352448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.357506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T01:04:30.352461Z","caller":"traceutil/trace.go:171","msg":"trace[1251777274] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:38; }","duration":"168.509892ms","start":"2026-06-09T01:04:30.183934Z","end":"2026-06-09T01:04:30.352444Z","steps":["trace[1251777274] 'agreement among raft nodes before linearized reading' (duration: 168.412151ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:30.352488Z","caller":"traceutil/trace.go:171","msg":"trace[1735212486] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:38; }","duration":"513.414606ms","start":"2026-06-09T01:04:29.839062Z","end":"2026-06-09T01:04:30.352477Z","steps":["trace[1735212486] 'agreement among raft nodes before linearized reading' (duration: 513.183995ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:30.352486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.838829Z","time spent":"513.586547ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:30.352534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.839054Z","time spent":"513.465606ms","remote":"127.0.0.1:50612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/system:aggregate-to-admin\" "} {"level":"warn","ts":"2026-06-09T01:04:30.352552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.537795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T01:04:30.352643Z","caller":"traceutil/trace.go:171","msg":"trace[1714000489] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:38; }","duration":"464.658106ms","start":"2026-06-09T01:04:29.887953Z","end":"2026-06-09T01:04:30.352612Z","steps":["trace[1714000489] 'agreement among raft nodes before linearized reading' (duration: 464.531075ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:30.352738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:29.887934Z","time spent":"464.794897ms","remote":"127.0.0.1:50408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-06-09T01:04:30.941305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.698518ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-09T01:04:30.941665Z","caller":"traceutil/trace.go:171","msg":"trace[256618417] linearizableReadLoop","detail":"{readStateIndex:45; appliedIndex:43; }","duration":"570.540548ms","start":"2026-06-09T01:04:30.371105Z","end":"2026-06-09T01:04:30.941646Z","steps":["trace[256618417] 'read index received' (duration: 347.768093ms)","trace[256618417] 'applied index is now lower than readState.Index' (duration: 222.770945ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:04:30.941683Z","caller":"traceutil/trace.go:171","msg":"trace[374462524] transaction","detail":"{read_only:false; response_revision:40; number_of_response:1; }","duration":"585.883225ms","start":"2026-06-09T01:04:30.355758Z","end":"2026-06-09T01:04:30.941641Z","steps":["trace[374462524] 'process raft request' (duration: 363.16311ms)","trace[374462524] 'compare' (duration: 221.550547ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:04:30.942958Z","caller":"traceutil/trace.go:171","msg":"trace[851236419] transaction","detail":"{read_only:false; response_revision:42; number_of_response:1; }","duration":"568.622085ms","start":"2026-06-09T01:04:30.374152Z","end":"2026-06-09T01:04:30.942774Z","steps":["trace[851236419] 'process raft request' (duration: 567.383687ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:30.943244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:30.374127Z","time spent":"569.022358ms","remote":"127.0.0.1:50628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:04:30.943797Z","caller":"traceutil/trace.go:171","msg":"trace[1209737276] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"585.313401ms","start":"2026-06-09T01:04:30.356313Z","end":"2026-06-09T01:04:30.941627Z","steps":["trace[1209737276] 'process raft request' (duration: 585.15457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:30.94321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:30.355742Z","time spent":"586.763812ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":711,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:30.944096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:30.356304Z","time spent":"587.573664ms","remote":"127.0.0.1:50780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:30.944371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.872204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T01:04:30.944465Z","caller":"traceutil/trace.go:171","msg":"trace[1953191251] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:0; response_revision:42; }","duration":"588.981085ms","start":"2026-06-09T01:04:30.355451Z","end":"2026-06-09T01:04:30.944432Z","steps":["trace[1953191251] 'agreement among raft nodes before linearized reading' (duration: 587.135643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:30.944516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:30.355445Z","time spent":"589.059855ms","remote":"127.0.0.1:50612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/admin\" "} {"level":"warn","ts":"2026-06-09T01:04:30.944979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:30.408263Z","time spent":"536.711455ms","remote":"127.0.0.1:50356","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-09T01:04:31.371533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.565346ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-09T01:04:31.371711Z","caller":"traceutil/trace.go:171","msg":"trace[965251127] transaction","detail":"{read_only:false; response_revision:43; number_of_response:1; }","duration":"460.612458ms","start":"2026-06-09T01:04:30.911058Z","end":"2026-06-09T01:04:31.37167Z","steps":["trace[965251127] 'process raft request' (duration: 326.78763ms)","trace[965251127] 'compare' (duration: 133.236524ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:04:31.371873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:30.911033Z","time spent":"460.756388ms","remote":"127.0.0.1:50462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:04:31.371841Z","caller":"traceutil/trace.go:171","msg":"trace[1739122666] linearizableReadLoop","detail":"{readStateIndex:48; appliedIndex:47; }","duration":"429.364221ms","start":"2026-06-09T01:04:30.942427Z","end":"2026-06-09T01:04:31.371792Z","steps":["trace[1739122666] 'read index received' (duration: 295.374452ms)","trace[1739122666] 'applied index is now lower than readState.Index' (duration: 133.980369ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:04:31.372184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.599407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T01:04:31.372239Z","caller":"traceutil/trace.go:171","msg":"trace[1195461358] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:45; }","duration":"587.741139ms","start":"2026-06-09T01:04:30.784482Z","end":"2026-06-09T01:04:31.372223Z","steps":["trace[1195461358] 'agreement among raft nodes before linearized reading' (duration: 587.517447ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:31.372282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:30.78445Z","time spent":"587.823609ms","remote":"127.0.0.1:50248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T01:04:31.372473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.989531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-09T01:04:31.372532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.810819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T01:04:31.372607Z","caller":"traceutil/trace.go:171","msg":"trace[1124185067] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:46; }","duration":"423.166293ms","start":"2026-06-09T01:04:30.94942Z","end":"2026-06-09T01:04:31.372586Z","steps":["trace[1124185067] 'agreement among raft nodes before linearized reading' (duration: 422.88333ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:31.372773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:30.949405Z","time spent":"423.321684ms","remote":"127.0.0.1:50612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/system:aggregate-to-edit\" "} {"level":"warn","ts":"2026-06-09T01:04:31.372779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"870.369802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T01:04:31.372825Z","caller":"traceutil/trace.go:171","msg":"trace[932501825] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:46; }","duration":"870.415922ms","start":"2026-06-09T01:04:30.502397Z","end":"2026-06-09T01:04:31.372813Z","steps":["trace[932501825] 'agreement among raft nodes before linearized reading' (duration: 869.774497ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:31.372801Z","caller":"traceutil/trace.go:171","msg":"trace[1291155488] transaction","detail":"{read_only:false; response_revision:46; number_of_response:1; }","duration":"379.146434ms","start":"2026-06-09T01:04:30.993632Z","end":"2026-06-09T01:04:31.372779Z","steps":["trace[1291155488] 'process raft request' (duration: 378.382419ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:31.372735Z","caller":"traceutil/trace.go:171","msg":"trace[7716361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:46; }","duration":"870.05005ms","start":"2026-06-09T01:04:30.502658Z","end":"2026-06-09T01:04:31.372708Z","steps":["trace[7716361] 'agreement among raft nodes before linearized reading' (duration: 869.550897ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:31.37303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:30.993615Z","time spent":"379.377915ms","remote":"127.0.0.1:50462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3453,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:04:31.373059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:30.50264Z","time spent":"870.343382ms","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-09T01:04:31.372865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:30.502333Z","time spent":"870.523623ms","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-09T01:04:31.373063Z","caller":"traceutil/trace.go:171","msg":"trace[248904600] transaction","detail":"{read_only:false; response_revision:45; number_of_response:1; }","duration":"421.597201ms","start":"2026-06-09T01:04:30.950583Z","end":"2026-06-09T01:04:31.37218Z","steps":["trace[248904600] 'process raft request' (duration: 421.192499ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:31.373255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:30.950549Z","time spent":"422.643888ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":715,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:04:31.373699Z","caller":"traceutil/trace.go:171","msg":"trace[1312695165] transaction","detail":"{read_only:false; response_revision:44; number_of_response:1; }","duration":"424.940822ms","start":"2026-06-09T01:04:30.947066Z","end":"2026-06-09T01:04:31.372007Z","steps":["trace[1312695165] 'process raft request' (duration: 424.586611ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:31.373836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:30.947048Z","time spent":"426.712414ms","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":636,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:04:31.574752Z","caller":"traceutil/trace.go:171","msg":"trace[475444227] linearizableReadLoop","detail":"{readStateIndex:54; appliedIndex:52; }","duration":"159.952682ms","start":"2026-06-09T01:04:31.414775Z","end":"2026-06-09T01:04:31.574728Z","steps":["trace[475444227] 'read index received' (duration: 142.893415ms)","trace[475444227] 'applied index is now lower than readState.Index' (duration: 17.057777ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:04:31.574893Z","caller":"traceutil/trace.go:171","msg":"trace[1939766539] transaction","detail":"{read_only:false; response_revision:49; number_of_response:1; }","duration":"196.106927ms","start":"2026-06-09T01:04:31.378746Z","end":"2026-06-09T01:04:31.574853Z","steps":["trace[1939766539] 'process raft request' (duration: 195.930906ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:31.574994Z","caller":"traceutil/trace.go:171","msg":"trace[2031054022] transaction","detail":"{read_only:false; response_revision:48; number_of_response:1; }","duration":"196.243548ms","start":"2026-06-09T01:04:31.378655Z","end":"2026-06-09T01:04:31.574898Z","steps":["trace[2031054022] 'process raft request' (duration: 179.107201ms)","trace[2031054022] 'compare' (duration: 16.758835ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:04:31.575145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.653851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18b7441c454f4f6b\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-09T01:04:31.575172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.879082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-06-09T01:04:31.575205Z","caller":"traceutil/trace.go:171","msg":"trace[964753923] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:49; }","duration":"156.950042ms","start":"2026-06-09T01:04:31.418245Z","end":"2026-06-09T01:04:31.575196Z","steps":["trace[964753923] 'agreement among raft nodes before linearized reading' (duration: 156.795511ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:31.575177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.04064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/view\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T01:04:31.575199Z","caller":"traceutil/trace.go:171","msg":"trace[1423031873] range","detail":"{range_begin:/registry/events/default/instance.18b7441c454f4f6b; range_end:; response_count:0; response_revision:49; }","duration":"196.748171ms","start":"2026-06-09T01:04:31.378439Z","end":"2026-06-09T01:04:31.575187Z","steps":["trace[1423031873] 'agreement among raft nodes before linearized reading' (duration: 196.427659ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:31.575278Z","caller":"traceutil/trace.go:171","msg":"trace[1403778859] range","detail":"{range_begin:/registry/clusterroles/view; range_end:; response_count:0; response_revision:49; }","duration":"158.18273ms","start":"2026-06-09T01:04:31.41707Z","end":"2026-06-09T01:04:31.575252Z","steps":["trace[1403778859] 'agreement among raft nodes before linearized reading' (duration: 157.958399ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:32.925244Z","caller":"traceutil/trace.go:171","msg":"trace[955564525] transaction","detail":"{read_only:false; response_revision:184; number_of_response:1; }","duration":"106.430381ms","start":"2026-06-09T01:04:32.81878Z","end":"2026-06-09T01:04:32.92521Z","steps":["trace[955564525] 'process raft request' (duration: 89.966919ms)","trace[955564525] 'compare' (duration: 16.303102ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:04:33.364734Z","caller":"traceutil/trace.go:171","msg":"trace[1990225397] linearizableReadLoop","detail":"{readStateIndex:200; appliedIndex:199; }","duration":"204.013838ms","start":"2026-06-09T01:04:33.160644Z","end":"2026-06-09T01:04:33.364658Z","steps":["trace[1990225397] 'read index received' (duration: 134.213029ms)","trace[1990225397] 'applied index is now lower than readState.Index' (duration: 69.799609ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:04:33.364959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.280671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:deployment-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:04:33.365009Z","caller":"traceutil/trace.go:171","msg":"trace[1380957347] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:deployment-controller; range_end:; response_count:0; response_revision:194; }","duration":"204.391181ms","start":"2026-06-09T01:04:33.160601Z","end":"2026-06-09T01:04:33.364992Z","steps":["trace[1380957347] 'agreement among raft nodes before linearized reading' (duration: 204.2443ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:33.36509Z","caller":"traceutil/trace.go:171","msg":"trace[735130464] transaction","detail":"{read_only:false; response_revision:194; number_of_response:1; }","duration":"205.85323ms","start":"2026-06-09T01:04:33.159069Z","end":"2026-06-09T01:04:33.364923Z","steps":["trace[735130464] 'process raft request' (duration: 135.813718ms)","trace[735130464] 'compare' (duration: 69.529088ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:04:33.563328Z","caller":"traceutil/trace.go:171","msg":"trace[556494471] transaction","detail":"{read_only:false; response_revision:196; number_of_response:1; }","duration":"140.061074ms","start":"2026-06-09T01:04:33.423236Z","end":"2026-06-09T01:04:33.563297Z","steps":["trace[556494471] 'process raft request' (duration: 128.333472ms)","trace[556494471] 'compare' (duration: 11.170489ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:04:33.715378Z","caller":"traceutil/trace.go:171","msg":"trace[1420825348] transaction","detail":"{read_only:false; response_revision:199; number_of_response:1; }","duration":"115.912026ms","start":"2026-06-09T01:04:33.599437Z","end":"2026-06-09T01:04:33.715349Z","steps":["trace[1420825348] 'process raft request' (duration: 68.774984ms)","trace[1420825348] 'compare' (duration: 46.81874ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:04:33.715633Z","caller":"traceutil/trace.go:171","msg":"trace[1128280422] linearizableReadLoop","detail":"{readStateIndex:206; appliedIndex:204; }","duration":"108.047536ms","start":"2026-06-09T01:04:33.607436Z","end":"2026-06-09T01:04:33.715484Z","steps":["trace[1128280422] 'read index received' (duration: 60.803845ms)","trace[1128280422] 'applied index is now lower than readState.Index' (duration: 47.242051ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:04:33.715644Z","caller":"traceutil/trace.go:171","msg":"trace[1574776575] transaction","detail":"{read_only:false; response_revision:200; number_of_response:1; }","duration":"115.503523ms","start":"2026-06-09T01:04:33.600034Z","end":"2026-06-09T01:04:33.715538Z","steps":["trace[1574776575] 'process raft request' (duration: 115.239011ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:33.715817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.353398ms","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-06-09T01:04:33.716029Z","caller":"traceutil/trace.go:171","msg":"trace[510216647] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:200; }","duration":"108.542559ms","start":"2026-06-09T01:04:33.60742Z","end":"2026-06-09T01:04:33.715962Z","steps":["trace[510216647] 'agreement among raft nodes before linearized reading' (duration: 108.231337ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:36.208453Z","caller":"traceutil/trace.go:171","msg":"trace[773334130] linearizableReadLoop","detail":"{readStateIndex:280; appliedIndex:279; }","duration":"156.377185ms","start":"2026-06-09T01:04:36.052054Z","end":"2026-06-09T01:04:36.208431Z","steps":["trace[773334130] 'read index received' (duration: 153.069145ms)","trace[773334130] 'applied index is now lower than readState.Index' (duration: 3.30506ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:04:36.208507Z","caller":"traceutil/trace.go:171","msg":"trace[437331941] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"157.941555ms","start":"2026-06-09T01:04:36.050531Z","end":"2026-06-09T01:04:36.208472Z","steps":["trace[437331941] 'process raft request' (duration: 154.388193ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:36.208651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.169106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-06-09T01:04:36.208733Z","caller":"traceutil/trace.go:171","msg":"trace[1922206115] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:273; }","duration":"158.277767ms","start":"2026-06-09T01:04:36.050441Z","end":"2026-06-09T01:04:36.208719Z","steps":["trace[1922206115] 'agreement among raft nodes before linearized reading' (duration: 158.107436ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:36.218323Z","caller":"traceutil/trace.go:171","msg":"trace[1577029626] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"161.077414ms","start":"2026-06-09T01:04:36.057212Z","end":"2026-06-09T01:04:36.21829Z","steps":["trace[1577029626] 'process raft request' (duration: 160.755171ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:36.218568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.553646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T01:04:36.218604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.938761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4016"} {"level":"info","ts":"2026-06-09T01:04:36.218623Z","caller":"traceutil/trace.go:171","msg":"trace[1190530851] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:275; }","duration":"113.652437ms","start":"2026-06-09T01:04:36.104955Z","end":"2026-06-09T01:04:36.218608Z","steps":["trace[1190530851] 'agreement among raft nodes before linearized reading' (duration: 113.535886ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:36.218655Z","caller":"traceutil/trace.go:171","msg":"trace[345631571] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:275; }","duration":"164.023562ms","start":"2026-06-09T01:04:36.054618Z","end":"2026-06-09T01:04:36.218641Z","steps":["trace[345631571] 'agreement among raft nodes before linearized reading' (duration: 163.911921ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:50.228473Z","caller":"traceutil/trace.go:171","msg":"trace[1956862643] linearizableReadLoop","detail":"{readStateIndex:440; appliedIndex:439; }","duration":"362.874625ms","start":"2026-06-09T01:04:49.865575Z","end":"2026-06-09T01:04:50.228449Z","steps":["trace[1956862643] 'read index received' (duration: 362.737974ms)","trace[1956862643] 'applied index is now lower than readState.Index' (duration: 135.641µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:04:50.228587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.997585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-09T01:04:50.228568Z","caller":"traceutil/trace.go:171","msg":"trace[1628985388] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"379.74451ms","start":"2026-06-09T01:04:49.848785Z","end":"2026-06-09T01:04:50.22853Z","steps":["trace[1628985388] 'process raft request' (duration: 379.548119ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:50.228612Z","caller":"traceutil/trace.go:171","msg":"trace[1985026660] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:421; }","duration":"363.068596ms","start":"2026-06-09T01:04:49.865535Z","end":"2026-06-09T01:04:50.228604Z","steps":["trace[1985026660] 'agreement among raft nodes before linearized reading' (duration: 363.007626ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:50.228755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:49.865516Z","time spent":"363.230577ms","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-09T01:04:50.228813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:49.848758Z","time spent":"379.896141ms","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:04:50.737851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.48023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-09T01:04:50.737939Z","caller":"traceutil/trace.go:171","msg":"trace[1618838552] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:422; }","duration":"303.64749ms","start":"2026-06-09T01:04:50.434273Z","end":"2026-06-09T01:04:50.737921Z","steps":["trace[1618838552] 'range keys from in-memory index tree' (duration: 303.382288ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:50.737988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:50.434251Z","time spent":"303.72623ms","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-09T01:04:50.737959Z","caller":"traceutil/trace.go:171","msg":"trace[1303347852] linearizableReadLoop","detail":"{readStateIndex:442; appliedIndex:441; }","duration":"234.517784ms","start":"2026-06-09T01:04:50.503395Z","end":"2026-06-09T01:04:50.737913Z","steps":["trace[1303347852] 'read index received' (duration: 231.699888ms)","trace[1303347852] 'applied index is now lower than readState.Index' (duration: 2.816726ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:04:50.738122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.700515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:04:50.738169Z","caller":"traceutil/trace.go:171","msg":"trace[1105460815] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:423; }","duration":"234.805405ms","start":"2026-06-09T01:04:50.503347Z","end":"2026-06-09T01:04:50.738152Z","steps":["trace[1105460815] 'agreement among raft nodes before linearized reading' (duration: 234.706535ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:50.738248Z","caller":"traceutil/trace.go:171","msg":"trace[972708908] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"302.888546ms","start":"2026-06-09T01:04:50.435307Z","end":"2026-06-09T01:04:50.738196Z","steps":["trace[972708908] 'process raft request' (duration: 299.927799ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:50.738456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:50.435264Z","time spent":"303.091606ms","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T01:04:50.987667Z","caller":"traceutil/trace.go:171","msg":"trace[298615677] linearizableReadLoop","detail":"{readStateIndex:443; appliedIndex:442; }","duration":"146.169808ms","start":"2026-06-09T01:04:50.84147Z","end":"2026-06-09T01:04:50.98764Z","steps":["trace[298615677] 'read index received' (duration: 109.363972ms)","trace[298615677] 'applied index is now lower than readState.Index' (duration: 36.804726ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:04:50.98774Z","caller":"traceutil/trace.go:171","msg":"trace[464920694] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"245.541695ms","start":"2026-06-09T01:04:50.742163Z","end":"2026-06-09T01:04:50.987704Z","steps":["trace[464920694] 'process raft request' (duration: 208.656348ms)","trace[464920694] 'compare' (duration: 36.676296ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:04:50.987834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.324549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-09T01:04:50.987874Z","caller":"traceutil/trace.go:171","msg":"trace[715895346] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:424; }","duration":"146.441389ms","start":"2026-06-09T01:04:50.841423Z","end":"2026-06-09T01:04:50.987864Z","steps":["trace[715895346] 'agreement among raft nodes before linearized reading' (duration: 146.330829ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:53.205104Z","caller":"traceutil/trace.go:171","msg":"trace[2138601329] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"145.223483ms","start":"2026-06-09T01:04:53.05982Z","end":"2026-06-09T01:04:53.205043Z","steps":["trace[2138601329] 'process raft request' (duration: 57.411217ms)","trace[2138601329] 'compare' (duration: 87.660205ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:04:59.226866Z","caller":"traceutil/trace.go:171","msg":"trace[1673453623] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"142.44961ms","start":"2026-06-09T01:04:59.084386Z","end":"2026-06-09T01:04:59.226835Z","steps":["trace[1673453623] 'process raft request' (duration: 142.278779ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:05:10.581078Z","caller":"traceutil/trace.go:171","msg":"trace[5989378] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"102.042237ms","start":"2026-06-09T01:05:10.479018Z","end":"2026-06-09T01:05:10.581061Z","steps":["trace[5989378] 'process raft request' (duration: 88.623262ms)","trace[5989378] 'compare' (duration: 13.330193ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:05:10.581483Z","caller":"traceutil/trace.go:171","msg":"trace[2129478906] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"100.099559ms","start":"2026-06-09T01:05:10.481373Z","end":"2026-06-09T01:05:10.581473Z","steps":["trace[2129478906] 'process raft request' (duration: 99.804551ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:05:10.581585Z","caller":"traceutil/trace.go:171","msg":"trace[457106569] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"100.086099ms","start":"2026-06-09T01:05:10.481481Z","end":"2026-06-09T01:05:10.581567Z","steps":["trace[457106569] 'process raft request' (duration: 99.817651ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:05:10.765848Z","caller":"traceutil/trace.go:171","msg":"trace[1395007162] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"101.231607ms","start":"2026-06-09T01:05:10.664588Z","end":"2026-06-09T01:05:10.76582Z","steps":["trace[1395007162] 'process raft request' (duration: 92.410007ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:11.55071Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794899798134670305,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T01:05:11.61676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.243595ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:05:11.616893Z","caller":"traceutil/trace.go:171","msg":"trace[1586205865] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:581; }","duration":"378.40207ms","start":"2026-06-09T01:05:11.238473Z","end":"2026-06-09T01:05:11.616875Z","steps":["trace[1586205865] 'range keys from in-memory index tree' (duration: 378.222235ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:05:11.617032Z","caller":"traceutil/trace.go:171","msg":"trace[286368016] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"710.421134ms","start":"2026-06-09T01:05:10.906587Z","end":"2026-06-09T01:05:11.617008Z","steps":["trace[286368016] 'process raft request' (duration: 690.201643ms)","trace[286368016] 'compare' (duration: 20.025476ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:05:11.617554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:10.906561Z","time spent":"710.917677ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80688,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T01:05:11.617774Z","caller":"traceutil/trace.go:171","msg":"trace[1148044753] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"701.620754ms","start":"2026-06-09T01:05:10.916135Z","end":"2026-06-09T01:05:11.617756Z","steps":["trace[1148044753] 'process raft request' (duration: 701.224644ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:11.617841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:10.916115Z","time spent":"701.699386ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":73770,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:05:11.617885Z","caller":"traceutil/trace.go:171","msg":"trace[2124777111] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"674.075105ms","start":"2026-06-09T01:05:10.94378Z","end":"2026-06-09T01:05:11.617855Z","steps":["trace[2124777111] 'process raft request' (duration: 673.753857ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:05:11.618176Z","caller":"traceutil/trace.go:171","msg":"trace[12805348] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:610; }","duration":"568.297247ms","start":"2026-06-09T01:05:11.049863Z","end":"2026-06-09T01:05:11.61816Z","steps":["trace[12805348] 'read index received' (duration: 547.02009ms)","trace[12805348] 'applied index is now lower than readState.Index' (duration: 21.276197ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:05:11.618239Z","caller":"traceutil/trace.go:171","msg":"trace[1036710057] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"154.09138ms","start":"2026-06-09T01:05:11.464137Z","end":"2026-06-09T01:05:11.618228Z","steps":["trace[1036710057] 'process raft request' (duration: 153.649259ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:11.618236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:10.943747Z","time spent":"674.404492ms","remote":"127.0.0.1:50326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:05:11.618337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.324141ms","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-06-09T01:05:11.618405Z","caller":"traceutil/trace.go:171","msg":"trace[1055217428] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"550.410593ms","start":"2026-06-09T01:05:11.067977Z","end":"2026-06-09T01:05:11.618387Z","steps":["trace[1055217428] 'agreement among raft nodes before linearized reading' (duration: 550.292201ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:11.618403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.439953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T01:05:11.618453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:11.067971Z","time spent":"550.468025ms","remote":"127.0.0.1:48816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-06-09T01:05:11.618463Z","caller":"traceutil/trace.go:171","msg":"trace[98832692] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:585; }","duration":"460.535285ms","start":"2026-06-09T01:05:11.157913Z","end":"2026-06-09T01:05:11.618448Z","steps":["trace[98832692] 'agreement among raft nodes before linearized reading' (duration: 460.442573ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:11.618498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.631475ms","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-06-09T01:05:11.618516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:11.157884Z","time spent":"460.613467ms","remote":"127.0.0.1:48844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-09T01:05:11.618558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.622751ms","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-06-09T01:05:11.618582Z","caller":"traceutil/trace.go:171","msg":"trace[1150202745] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"568.718997ms","start":"2026-06-09T01:05:11.049816Z","end":"2026-06-09T01:05:11.618535Z","steps":["trace[1150202745] 'agreement among raft nodes before linearized reading' (duration: 568.626625ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:11.618646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.717419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T01:05:11.618647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.377558ms","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-06-09T01:05:11.618678Z","caller":"traceutil/trace.go:171","msg":"trace[1455827967] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:585; }","duration":"460.784121ms","start":"2026-06-09T01:05:11.157886Z","end":"2026-06-09T01:05:11.61867Z","steps":["trace[1455827967] 'agreement among raft nodes before linearized reading' (duration: 460.73381ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:05:11.618685Z","caller":"traceutil/trace.go:171","msg":"trace[931647299] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:585; }","duration":"516.524723ms","start":"2026-06-09T01:05:11.102149Z","end":"2026-06-09T01:05:11.618674Z","steps":["trace[931647299] 'agreement among raft nodes before linearized reading' (duration: 516.459722ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:11.618711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:11.157863Z","time spent":"460.839953ms","remote":"127.0.0.1:48844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"warn","ts":"2026-06-09T01:05:11.618715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:11.102135Z","time spent":"516.572354ms","remote":"127.0.0.1:48820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-09T01:05:11.618755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.117993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:05:11.618803Z","caller":"traceutil/trace.go:171","msg":"trace[1851860660] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"117.185614ms","start":"2026-06-09T01:05:11.501605Z","end":"2026-06-09T01:05:11.618791Z","steps":["trace[1851860660] 'agreement among raft nodes before linearized reading' (duration: 117.121263ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:11.618844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.826967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T01:05:11.618856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.687898ms","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-06-09T01:05:11.618901Z","caller":"traceutil/trace.go:171","msg":"trace[360914496] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:585; }","duration":"516.750429ms","start":"2026-06-09T01:05:11.102134Z","end":"2026-06-09T01:05:11.618884Z","steps":["trace[360914496] 'agreement among raft nodes before linearized reading' (duration: 516.696827ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:11.618942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:11.102118Z","time spent":"516.813431ms","remote":"127.0.0.1:48820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-06-09T01:05:11.619044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.507221ms","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-06-09T01:05:11.619053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.420582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:05:11.619099Z","caller":"traceutil/trace.go:171","msg":"trace[1042890290] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:585; }","duration":"460.491374ms","start":"2026-06-09T01:05:11.158599Z","end":"2026-06-09T01:05:11.619091Z","steps":["trace[1042890290] 'agreement among raft nodes before linearized reading' (duration: 460.429033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:11.619099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.975237ms","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-06-09T01:05:11.619125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:11.158591Z","time spent":"460.526885ms","remote":"127.0.0.1:48844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"info","ts":"2026-06-09T01:05:11.6186Z","caller":"traceutil/trace.go:171","msg":"trace[1959169350] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:585; }","duration":"488.679813ms","start":"2026-06-09T01:05:11.12991Z","end":"2026-06-09T01:05:11.61859Z","steps":["trace[1959169350] 'agreement among raft nodes before linearized reading' (duration: 488.618672ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:11.618904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.286673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T01:05:11.619251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.852937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:05:11.619283Z","caller":"traceutil/trace.go:171","msg":"trace[1210328872] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:585; }","duration":"444.900818ms","start":"2026-06-09T01:05:11.174374Z","end":"2026-06-09T01:05:11.619275Z","steps":["trace[1210328872] 'agreement among raft nodes before linearized reading' (duration: 444.854177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:11.619317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:11.174366Z","time spent":"444.94255ms","remote":"127.0.0.1:48856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-06-09T01:05:11.61934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.004656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-09T01:05:11.619376Z","caller":"traceutil/trace.go:171","msg":"trace[59299565] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:585; }","duration":"323.061698ms","start":"2026-06-09T01:05:11.296306Z","end":"2026-06-09T01:05:11.619368Z","steps":["trace[59299565] 'agreement among raft nodes before linearized reading' (duration: 322.945705ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:11.619416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:11.296287Z","time spent":"323.122639ms","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-09T01:05:11.618906Z","caller":"traceutil/trace.go:171","msg":"trace[394860781] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:585; }","duration":"488.855258ms","start":"2026-06-09T01:05:11.130008Z","end":"2026-06-09T01:05:11.618863Z","steps":["trace[394860781] 'agreement among raft nodes before linearized reading' (duration: 488.811616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:11.619521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:11.129997Z","time spent":"489.505354ms","remote":"127.0.0.1:48828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-09T01:05:11.619489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.53854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T01:05:11.619062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.109465ms","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-06-09T01:05:11.619591Z","caller":"traceutil/trace.go:171","msg":"trace[1006131430] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"550.654579ms","start":"2026-06-09T01:05:11.068918Z","end":"2026-06-09T01:05:11.619572Z","steps":["trace[1006131430] 'agreement among raft nodes before linearized reading' (duration: 550.121226ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:05:11.6196Z","caller":"traceutil/trace.go:171","msg":"trace[1994839772] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:585; }","duration":"444.654633ms","start":"2026-06-09T01:05:11.174909Z","end":"2026-06-09T01:05:11.619563Z","steps":["trace[1994839772] 'agreement among raft nodes before linearized reading' (duration: 444.458088ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:11.61966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:11.068913Z","time spent":"550.728551ms","remote":"127.0.0.1:48812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-06-09T01:05:11.619729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:11.174887Z","time spent":"444.793676ms","remote":"127.0.0.1:48856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"info","ts":"2026-06-09T01:05:11.619275Z","caller":"traceutil/trace.go:171","msg":"trace[1983624130] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:585; }","duration":"488.672772ms","start":"2026-06-09T01:05:11.130586Z","end":"2026-06-09T01:05:11.619258Z","steps":["trace[1983624130] 'agreement among raft nodes before linearized reading' (duration: 488.20414ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:05:11.619128Z","caller":"traceutil/trace.go:171","msg":"trace[1551236337] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"551.040509ms","start":"2026-06-09T01:05:11.06808Z","end":"2026-06-09T01:05:11.61912Z","steps":["trace[1551236337] 'agreement among raft nodes before linearized reading' (duration: 551.001658ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:11.622025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:11.13058Z","time spent":"491.418371ms","remote":"127.0.0.1:48820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-06-09T01:05:11.622081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:11.068058Z","time spent":"553.963902ms","remote":"127.0.0.1:48816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-06-09T01:05:11.619097Z","caller":"traceutil/trace.go:171","msg":"trace[856698111] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:585; }","duration":"319.588232ms","start":"2026-06-09T01:05:11.299496Z","end":"2026-06-09T01:05:11.619084Z","steps":["trace[856698111] 'agreement among raft nodes before linearized reading' (duration: 319.451629ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:11.622447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:11.29947Z","time spent":"322.957406ms","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-09T01:05:11.6187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:11.0498Z","time spent":"568.85943ms","remote":"127.0.0.1:48812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-09T01:05:11.618404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.495382ms","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-06-09T01:05:11.622702Z","caller":"traceutil/trace.go:171","msg":"trace[1219848082] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"572.87473ms","start":"2026-06-09T01:05:11.049813Z","end":"2026-06-09T01:05:11.622688Z","steps":["trace[1219848082] 'agreement among raft nodes before linearized reading' (duration: 568.44575ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:11.622752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:11.049792Z","time spent":"572.946081ms","remote":"127.0.0.1:48812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-06-09T01:05:11.619215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:11.129902Z","time spent":"489.293019ms","remote":"127.0.0.1:48828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-06-09T01:05:11.619232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.784366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:05:11.623111Z","caller":"traceutil/trace.go:171","msg":"trace[289202983] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:585; }","duration":"448.677693ms","start":"2026-06-09T01:05:11.174409Z","end":"2026-06-09T01:05:11.623086Z","steps":["trace[289202983] 'agreement among raft nodes before linearized reading' (duration: 444.803306ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:11.623264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:11.174404Z","time spent":"448.841116ms","remote":"127.0.0.1:48856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"info","ts":"2026-06-09T01:05:14.768183Z","caller":"traceutil/trace.go:171","msg":"trace[778165945] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"124.719931ms","start":"2026-06-09T01:05:14.643425Z","end":"2026-06-09T01:05:14.768145Z","steps":["trace[778165945] 'process raft request' (duration: 121.525264ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:05:17.642774Z","caller":"traceutil/trace.go:171","msg":"trace[1063916577] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:665; }","duration":"139.335515ms","start":"2026-06-09T01:05:17.503413Z","end":"2026-06-09T01:05:17.642749Z","steps":["trace[1063916577] 'read index received' (duration: 138.518386ms)","trace[1063916577] 'applied index is now lower than readState.Index' (duration: 816.169µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:05:17.64299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.56257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:05:17.643053Z","caller":"traceutil/trace.go:171","msg":"trace[697944605] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"139.688543ms","start":"2026-06-09T01:05:17.503353Z","end":"2026-06-09T01:05:17.643042Z","steps":["trace[697944605] 'agreement among raft nodes before linearized reading' (duration: 139.56465ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:05:17.643075Z","caller":"traceutil/trace.go:171","msg":"trace[1612646615] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"241.697781ms","start":"2026-06-09T01:05:17.401316Z","end":"2026-06-09T01:05:17.643013Z","steps":["trace[1612646615] 'process raft request' (duration: 240.892542ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:05:17.765691Z","caller":"traceutil/trace.go:171","msg":"trace[1780112340] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:666; }","duration":"106.128034ms","start":"2026-06-09T01:05:17.659529Z","end":"2026-06-09T01:05:17.765657Z","steps":["trace[1780112340] 'read index received' (duration: 17.350092ms)","trace[1780112340] 'applied index is now lower than readState.Index' (duration: 88.775122ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:05:17.765746Z","caller":"traceutil/trace.go:171","msg":"trace[1473829815] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"105.909029ms","start":"2026-06-09T01:05:17.659796Z","end":"2026-06-09T01:05:17.765705Z","steps":["trace[1473829815] 'process raft request' (duration: 17.049986ms)","trace[1473829815] 'compare' (duration: 88.518054ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:05:17.765927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.363749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-09T01:05:17.765968Z","caller":"traceutil/trace.go:171","msg":"trace[462740389] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:638; }","duration":"106.468811ms","start":"2026-06-09T01:05:17.659488Z","end":"2026-06-09T01:05:17.765957Z","steps":["trace[462740389] 'agreement among raft nodes before linearized reading' (duration: 106.283107ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:18.691019Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794899798134670434,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T01:05:19.191796Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794899798134670434,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T01:05:19.692271Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794899798134670434,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T01:05:19.812949Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.639332613s","expected-duration":"1s"} {"level":"info","ts":"2026-06-09T01:05:19.814309Z","caller":"traceutil/trace.go:171","msg":"trace[1579894255] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"1.646284832s","start":"2026-06-09T01:05:18.167996Z","end":"2026-06-09T01:05:19.814281Z","steps":["trace[1579894255] 'process raft request' (duration: 1.645661598s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:19.814474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:18.167971Z","time spent":"1.646406164s","remote":"127.0.0.1:50380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:05:20.277525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.190674ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-09T01:05:20.2776Z","caller":"traceutil/trace.go:171","msg":"trace[429223176] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:672; }","duration":"2.087489906s","start":"2026-06-09T01:05:18.190097Z","end":"2026-06-09T01:05:20.277586Z","steps":["trace[429223176] 'read index received' (duration: 1.623324064s)","trace[429223176] 'applied index is now lower than readState.Index' (duration: 464.164992ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:05:20.277874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.087745951s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zsqpm\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-09T01:05:20.27797Z","caller":"traceutil/trace.go:171","msg":"trace[1088071265] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zsqpm; range_end:; response_count:1; response_revision:643; }","duration":"2.087869145s","start":"2026-06-09T01:05:18.190074Z","end":"2026-06-09T01:05:20.277943Z","steps":["trace[1088071265] 'agreement among raft nodes before linearized reading' (duration: 2.087556358s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:20.278027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:18.19006Z","time spent":"2.087954276s","remote":"127.0.0.1:50462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-zsqpm\" "} {"level":"warn","ts":"2026-06-09T01:05:20.778221Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794899798134670438,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-09T01:05:20.806203Z","caller":"traceutil/trace.go:171","msg":"trace[1405336681] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"934.378109ms","start":"2026-06-09T01:05:19.871802Z","end":"2026-06-09T01:05:20.80618Z","steps":["trace[1405336681] 'process raft request' (duration: 934.222415ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:20.806335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:19.871783Z","time spent":"934.492441ms","remote":"127.0.0.1:50498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:05:20.880482Z","caller":"traceutil/trace.go:171","msg":"trace[926817056] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:674; }","duration":"602.843884ms","start":"2026-06-09T01:05:20.277614Z","end":"2026-06-09T01:05:20.880458Z","steps":["trace[926817056] 'read index received' (duration: 528.442791ms)","trace[926817056] 'applied index is now lower than readState.Index' (duration: 74.400143ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:05:20.880746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.378282337s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T01:05:20.880896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.387048304s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-09T01:05:20.880938Z","caller":"traceutil/trace.go:171","msg":"trace[802745566] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:645; }","duration":"2.387131376s","start":"2026-06-09T01:05:18.493795Z","end":"2026-06-09T01:05:20.880926Z","steps":["trace[802745566] 'agreement among raft nodes before linearized reading' (duration: 2.386999503s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:20.880971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:18.493771Z","time spent":"2.387192527s","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-09T01:05:20.881042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.392960009s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-09T01:05:20.881099Z","caller":"traceutil/trace.go:171","msg":"trace[2004293053] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:645; }","duration":"2.393054521s","start":"2026-06-09T01:05:18.488027Z","end":"2026-06-09T01:05:20.881082Z","steps":["trace[2004293053] 'agreement among raft nodes before linearized reading' (duration: 2.392899528s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:20.881156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:18.488006Z","time spent":"2.393138964s","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-09T01:05:20.881158Z","caller":"traceutil/trace.go:171","msg":"trace[1899256125] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"590.455216ms","start":"2026-06-09T01:05:20.290625Z","end":"2026-06-09T01:05:20.88108Z","steps":["trace[1899256125] 'process raft request' (duration: 589.704169ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:20.881381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:20.290581Z","time spent":"590.696901ms","remote":"127.0.0.1:50462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:05:20.881415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.111940015s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-09T01:05:20.881495Z","caller":"traceutil/trace.go:171","msg":"trace[1358801450] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:645; }","duration":"1.112091909s","start":"2026-06-09T01:05:19.769381Z","end":"2026-06-09T01:05:20.881473Z","steps":["trace[1358801450] 'agreement among raft nodes before linearized reading' (duration: 1.111906975s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:20.881539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:19.76936Z","time spent":"1.11216905s","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-09T01:05:20.881701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.103874422s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-09T01:05:20.881768Z","caller":"traceutil/trace.go:171","msg":"trace[423361111] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:645; }","duration":"1.103969664s","start":"2026-06-09T01:05:19.77778Z","end":"2026-06-09T01:05:20.88175Z","steps":["trace[423361111] 'agreement among raft nodes before linearized reading' (duration: 1.10380835s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:20.881811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:19.777758Z","time spent":"1.104043966s","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-09T01:05:20.882795Z","caller":"traceutil/trace.go:171","msg":"trace[247842052] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"1.378404821s","start":"2026-06-09T01:05:19.502403Z","end":"2026-06-09T01:05:20.880808Z","steps":["trace[247842052] 'agreement among raft nodes before linearized reading' (duration: 1.378240277s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:20.88289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:19.502381Z","time spent":"1.380490777s","remote":"127.0.0.1:50248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T01:05:21.390786Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794899798134670443,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T01:05:21.891233Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794899798134670443,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T01:05:22.391639Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794899798134670443,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T01:05:22.444762Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.557737898s","expected-duration":"1s"} {"level":"info","ts":"2026-06-09T01:05:22.445111Z","caller":"traceutil/trace.go:171","msg":"trace[1177272783] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"1.558210798s","start":"2026-06-09T01:05:20.886877Z","end":"2026-06-09T01:05:22.445088Z","steps":["trace[1177272783] 'process raft request' (duration: 1.558089506s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:22.445246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:20.886865Z","time spent":"1.558313451s","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:05:22.584053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.771132ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T01:05:22.584367Z","caller":"traceutil/trace.go:171","msg":"trace[280924593] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:676; }","duration":"1.694411205s","start":"2026-06-09T01:05:20.889934Z","end":"2026-06-09T01:05:22.584345Z","steps":["trace[280924593] 'read index received' (duration: 1.55512363s)","trace[280924593] 'applied index is now lower than readState.Index' (duration: 139.286365ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:05:22.584465Z","caller":"traceutil/trace.go:171","msg":"trace[1730465800] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"1.697321671s","start":"2026-06-09T01:05:20.887124Z","end":"2026-06-09T01:05:22.584445Z","steps":["trace[1730465800] 'process raft request' (duration: 1.697040505s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:22.58457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:20.887096Z","time spent":"1.697414983s","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T01:05:22.584668Z","caller":"traceutil/trace.go:171","msg":"trace[2135341736] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"599.92705ms","start":"2026-06-09T01:05:21.984724Z","end":"2026-06-09T01:05:22.584651Z","steps":["trace[2135341736] 'process raft request' (duration: 599.567252ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:22.584919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.694951028s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:05:22.585002Z","caller":"traceutil/trace.go:171","msg":"trace[1267535565] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"1.697289181s","start":"2026-06-09T01:05:20.887695Z","end":"2026-06-09T01:05:22.584984Z","steps":["trace[1267535565] 'process raft request' (duration: 1.696541234s)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:05:22.585015Z","caller":"traceutil/trace.go:171","msg":"trace[1713667203] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:650; }","duration":"1.69507228s","start":"2026-06-09T01:05:20.889919Z","end":"2026-06-09T01:05:22.584991Z","steps":["trace[1713667203] 'agreement among raft nodes before linearized reading' (duration: 1.694850125s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:22.584999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.691680685s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T01:05:22.585072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:20.88991Z","time spent":"1.695154183s","remote":"127.0.0.1:50248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T01:05:22.585103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:20.887685Z","time spent":"1.697367732s","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T01:05:22.585145Z","caller":"traceutil/trace.go:171","msg":"trace[1875746670] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:650; }","duration":"1.691797487s","start":"2026-06-09T01:05:20.893289Z","end":"2026-06-09T01:05:22.585086Z","steps":["trace[1875746670] 'agreement among raft nodes before linearized reading' (duration: 1.691659084s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:22.585241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:20.893284Z","time spent":"1.691905769s","remote":"127.0.0.1:50424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" "} {"level":"info","ts":"2026-06-09T01:05:22.584921Z","caller":"traceutil/trace.go:171","msg":"trace[1530465206] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"1.697793322s","start":"2026-06-09T01:05:20.887092Z","end":"2026-06-09T01:05:22.584885Z","steps":["trace[1530465206] 'process raft request' (duration: 1.589095259s)","trace[1530465206] 'compare' (duration: 107.625879ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:05:22.586184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:20.887081Z","time spent":"1.699039068s","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:05:22.586343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:21.9847Z","time spent":"601.441315ms","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T01:05:23.348642Z","caller":"traceutil/trace.go:171","msg":"trace[1544661480] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"129.660175ms","start":"2026-06-09T01:05:23.218962Z","end":"2026-06-09T01:05:23.348622Z","steps":["trace[1544661480] 'process raft request' (duration: 129.526723ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:36.614152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.653317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:05:36.614315Z","caller":"traceutil/trace.go:171","msg":"trace[639667118] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:791; }","duration":"109.911523ms","start":"2026-06-09T01:05:36.504371Z","end":"2026-06-09T01:05:36.614282Z","steps":["trace[639667118] 'range keys from in-memory index tree' (duration: 109.477904ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:36.614295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.43553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-09T01:05:36.614427Z","caller":"traceutil/trace.go:171","msg":"trace[2093030264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:791; }","duration":"102.646894ms","start":"2026-06-09T01:05:36.511751Z","end":"2026-06-09T01:05:36.614398Z","steps":["trace[2093030264] 'range keys from in-memory index tree' (duration: 102.192363ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:38.00223Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794899798134670741,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-09T01:05:38.003808Z","caller":"traceutil/trace.go:171","msg":"trace[1102284353] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"681.347777ms","start":"2026-06-09T01:05:37.32243Z","end":"2026-06-09T01:05:38.003777Z","steps":["trace[1102284353] 'process raft request' (duration: 681.187984ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:38.003994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:37.322409Z","time spent":"681.47094ms","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T01:05:38.221603Z","caller":"traceutil/trace.go:171","msg":"trace[1904024706] linearizableReadLoop","detail":"{readStateIndex:833; appliedIndex:831; }","duration":"720.047309ms","start":"2026-06-09T01:05:37.501529Z","end":"2026-06-09T01:05:38.221576Z","steps":["trace[1904024706] 'read index received' (duration: 502.177354ms)","trace[1904024706] 'applied index is now lower than readState.Index' (duration: 217.869135ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:05:38.221855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.306314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:05:38.221935Z","caller":"traceutil/trace.go:171","msg":"trace[967387634] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:797; }","duration":"720.429406ms","start":"2026-06-09T01:05:37.501488Z","end":"2026-06-09T01:05:38.221917Z","steps":["trace[967387634] 'agreement among raft nodes before linearized reading' (duration: 720.305484ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:38.221987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:37.501466Z","time spent":"720.508008ms","remote":"127.0.0.1:50248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T01:05:38.221877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.944818ms","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-06-09T01:05:38.221972Z","caller":"traceutil/trace.go:171","msg":"trace[146422614] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"316.672344ms","start":"2026-06-09T01:05:37.905112Z","end":"2026-06-09T01:05:38.221784Z","steps":["trace[146422614] 'process raft request' (duration: 279.434356ms)","trace[146422614] 'compare' (duration: 36.896412ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:05:38.222089Z","caller":"traceutil/trace.go:171","msg":"trace[1235488198] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:797; }","duration":"337.202422ms","start":"2026-06-09T01:05:37.884862Z","end":"2026-06-09T01:05:38.222064Z","steps":["trace[1235488198] 'agreement among raft nodes before linearized reading' (duration: 336.952328ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:38.222181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:37.884841Z","time spent":"337.306135ms","remote":"127.0.0.1:50426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-06-09T01:05:38.22226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:37.905093Z","time spent":"317.039091ms","remote":"127.0.0.1:50456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4904,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T01:05:41.666781Z","caller":"traceutil/trace.go:171","msg":"trace[831780389] linearizableReadLoop","detail":"{readStateIndex:858; appliedIndex:857; }","duration":"228.262169ms","start":"2026-06-09T01:05:41.438494Z","end":"2026-06-09T01:05:41.666757Z","steps":["trace[831780389] 'read index received' (duration: 228.105476ms)","trace[831780389] 'applied index is now lower than readState.Index' (duration: 155.203µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:05:41.666839Z","caller":"traceutil/trace.go:171","msg":"trace[136659395] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"345.625238ms","start":"2026-06-09T01:05:41.321181Z","end":"2026-06-09T01:05:41.666806Z","steps":["trace[136659395] 'process raft request' (duration: 345.402174ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:41.667172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.471063ms","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":"warn","ts":"2026-06-09T01:05:41.66718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:05:41.32116Z","time spent":"345.929814ms","remote":"127.0.0.1:50462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4024,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T01:05:41.667233Z","caller":"traceutil/trace.go:171","msg":"trace[731612990] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:821; }","duration":"228.567325ms","start":"2026-06-09T01:05:41.43865Z","end":"2026-06-09T01:05:41.667218Z","steps":["trace[731612990] 'agreement among raft nodes before linearized reading' (duration: 228.457682ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:41.667421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.774166ms","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-06-09T01:05:41.66747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.196324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T01:05:41.6675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.221471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:05:41.667542Z","caller":"traceutil/trace.go:171","msg":"trace[1830209019] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:821; }","duration":"112.299617ms","start":"2026-06-09T01:05:41.555226Z","end":"2026-06-09T01:05:41.667525Z","steps":["trace[1830209019] 'agreement among raft nodes before linearized reading' (duration: 112.185465ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:05:41.66755Z","caller":"traceutil/trace.go:171","msg":"trace[1563201894] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:821; }","duration":"165.301082ms","start":"2026-06-09T01:05:41.50223Z","end":"2026-06-09T01:05:41.667531Z","steps":["trace[1563201894] 'agreement among raft nodes before linearized reading' (duration: 165.242241ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:05:41.667498Z","caller":"traceutil/trace.go:171","msg":"trace[296441346] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:821; }","duration":"112.892638ms","start":"2026-06-09T01:05:41.554595Z","end":"2026-06-09T01:05:41.667488Z","steps":["trace[296441346] 'agreement among raft nodes before linearized reading' (duration: 112.798666ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:41.667405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.551832ms","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-06-09T01:05:41.667685Z","caller":"traceutil/trace.go:171","msg":"trace[657874690] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:821; }","duration":"112.903627ms","start":"2026-06-09T01:05:41.554773Z","end":"2026-06-09T01:05:41.667676Z","steps":["trace[657874690] 'agreement among raft nodes before linearized reading' (duration: 112.568371ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:41.667809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.951723ms","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":"info","ts":"2026-06-09T01:05:41.66809Z","caller":"traceutil/trace.go:171","msg":"trace[1776864018] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:821; }","duration":"229.460931ms","start":"2026-06-09T01:05:41.438429Z","end":"2026-06-09T01:05:41.66789Z","steps":["trace[1776864018] 'agreement among raft nodes before linearized reading' (duration: 228.903011ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:05:55.887754Z","caller":"traceutil/trace.go:171","msg":"trace[1540664998] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"101.590062ms","start":"2026-06-09T01:05:55.786126Z","end":"2026-06-09T01:05:55.887716Z","steps":["trace[1540664998] 'process raft request' (duration: 101.332779ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:05:56.62687Z","caller":"traceutil/trace.go:171","msg":"trace[1997059472] linearizableReadLoop","detail":"{readStateIndex:1025; appliedIndex:1024; }","duration":"169.309078ms","start":"2026-06-09T01:05:56.457533Z","end":"2026-06-09T01:05:56.626843Z","steps":["trace[1997059472] 'read index received' (duration: 169.184116ms)","trace[1997059472] 'applied index is now lower than readState.Index' (duration: 123.652µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:05:56.627106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.559672ms","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-06-09T01:05:56.627164Z","caller":"traceutil/trace.go:171","msg":"trace[1681411762] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:985; }","duration":"169.669124ms","start":"2026-06-09T01:05:56.457483Z","end":"2026-06-09T01:05:56.627152Z","steps":["trace[1681411762] 'agreement among raft nodes before linearized reading' (duration: 169.486021ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:05:56.627459Z","caller":"traceutil/trace.go:171","msg":"trace[1069765039] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"236.126193ms","start":"2026-06-09T01:05:56.39079Z","end":"2026-06-09T01:05:56.626916Z","steps":["trace[1069765039] 'process raft request' (duration: 235.88553ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:05:56.630268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.924954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:05:56.630325Z","caller":"traceutil/trace.go:171","msg":"trace[710415315] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:986; }","duration":"129.010636ms","start":"2026-06-09T01:05:56.501301Z","end":"2026-06-09T01:05:56.630312Z","steps":["trace[710415315] 'agreement among raft nodes before linearized reading' (duration: 128.909544ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:05:56.630491Z","caller":"traceutil/trace.go:171","msg":"trace[1272302802] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"133.874734ms","start":"2026-06-09T01:05:56.496584Z","end":"2026-06-09T01:05:56.630458Z","steps":["trace[1272302802] 'process raft request' (duration: 133.523788ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:06:03.079695Z","caller":"traceutil/trace.go:171","msg":"trace[1080116569] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"212.887749ms","start":"2026-06-09T01:06:02.86678Z","end":"2026-06-09T01:06:03.079667Z","steps":["trace[1080116569] 'process raft request' (duration: 212.740637ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:06:03.093799Z","caller":"traceutil/trace.go:171","msg":"trace[1594200041] linearizableReadLoop","detail":"{readStateIndex:1057; appliedIndex:1055; }","duration":"219.263554ms","start":"2026-06-09T01:06:02.874524Z","end":"2026-06-09T01:06:03.093788Z","steps":["trace[1594200041] 'read index received' (duration: 205.02159ms)","trace[1594200041] 'applied index is now lower than readState.Index' (duration: 14.241424ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:06:03.093867Z","caller":"traceutil/trace.go:171","msg":"trace[1740867552] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"225.070002ms","start":"2026-06-09T01:06:02.86877Z","end":"2026-06-09T01:06:03.09384Z","steps":["trace[1740867552] 'process raft request' (duration: 224.96776ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:06:03.093944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.392226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-09T01:06:03.093982Z","caller":"traceutil/trace.go:171","msg":"trace[621552129] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1016; }","duration":"219.472407ms","start":"2026-06-09T01:06:02.874499Z","end":"2026-06-09T01:06:03.093972Z","steps":["trace[621552129] 'agreement among raft nodes before linearized reading' (duration: 219.332505ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:06:14.883789Z","caller":"traceutil/trace.go:171","msg":"trace[610557751] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"167.715356ms","start":"2026-06-09T01:06:14.715987Z","end":"2026-06-09T01:06:14.883702Z","steps":["trace[610557751] 'process raft request' (duration: 167.530704ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:06:15.214192Z","caller":"traceutil/trace.go:171","msg":"trace[1692061191] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"106.801575ms","start":"2026-06-09T01:06:15.10737Z","end":"2026-06-09T01:06:15.214171Z","steps":["trace[1692061191] 'process raft request' (duration: 106.626042ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:06:15.438665Z","caller":"traceutil/trace.go:171","msg":"trace[2108450215] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"169.345263ms","start":"2026-06-09T01:06:15.269275Z","end":"2026-06-09T01:06:15.43862Z","steps":["trace[2108450215] 'process raft request' (duration: 129.937933ms)","trace[2108450215] 'compare' (duration: 39.269709ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:06:25.042872Z","caller":"traceutil/trace.go:171","msg":"trace[1705646302] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"113.589759ms","start":"2026-06-09T01:06:24.929232Z","end":"2026-06-09T01:06:25.042822Z","steps":["trace[1705646302] 'process raft request' (duration: 79.667065ms)","trace[1705646302] 'compare' (duration: 33.788462ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:06:31.080822Z","caller":"traceutil/trace.go:171","msg":"trace[975769546] linearizableReadLoop","detail":"{readStateIndex:1157; appliedIndex:1156; }","duration":"113.339398ms","start":"2026-06-09T01:06:30.967457Z","end":"2026-06-09T01:06:31.080797Z","steps":["trace[975769546] 'read index received' (duration: 113.196586ms)","trace[975769546] 'applied index is now lower than readState.Index' (duration: 141.642µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:06:31.080966Z","caller":"traceutil/trace.go:171","msg":"trace[371234268] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"128.053979ms","start":"2026-06-09T01:06:30.952877Z","end":"2026-06-09T01:06:31.080931Z","steps":["trace[371234268] 'process raft request' (duration: 127.727816ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:06:31.081121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.639831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-09T01:06:31.081192Z","caller":"traceutil/trace.go:171","msg":"trace[873959158] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1110; }","duration":"113.746162ms","start":"2026-06-09T01:06:30.967426Z","end":"2026-06-09T01:06:31.081172Z","steps":["trace[873959158] 'agreement among raft nodes before linearized reading' (duration: 113.478179ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:06:31.361329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.285554ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:06:31.361435Z","caller":"traceutil/trace.go:171","msg":"trace[2132221090] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1111; }","duration":"122.403345ms","start":"2026-06-09T01:06:31.239016Z","end":"2026-06-09T01:06:31.361419Z","steps":["trace[2132221090] 'range keys from in-memory index tree' (duration: 122.273544ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:06:31.361887Z","caller":"traceutil/trace.go:171","msg":"trace[300189665] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"254.834054ms","start":"2026-06-09T01:06:31.107038Z","end":"2026-06-09T01:06:31.361872Z","steps":["trace[300189665] 'process raft request' (duration: 237.814575ms)","trace[300189665] 'compare' (duration: 16.384112ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:07:21.52333Z","caller":"traceutil/trace.go:171","msg":"trace[2020484168] linearizableReadLoop","detail":"{readStateIndex:1344; appliedIndex:1343; }","duration":"108.973157ms","start":"2026-06-09T01:07:21.414337Z","end":"2026-06-09T01:07:21.52331Z","steps":["trace[2020484168] 'read index received' (duration: 108.831795ms)","trace[2020484168] 'applied index is now lower than readState.Index' (duration: 140.242µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:07:21.523387Z","caller":"traceutil/trace.go:171","msg":"trace[935843567] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"135.775624ms","start":"2026-06-09T01:07:21.38758Z","end":"2026-06-09T01:07:21.523355Z","steps":["trace[935843567] 'process raft request' (duration: 135.604122ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:07:21.523538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.160298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:07:21.523642Z","caller":"traceutil/trace.go:171","msg":"trace[228924459] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1286; }","duration":"109.313409ms","start":"2026-06-09T01:07:21.414305Z","end":"2026-06-09T01:07:21.523618Z","steps":["trace[228924459] 'agreement among raft nodes before linearized reading' (duration: 109.124908ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:07:43.924163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.399719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-09T01:07:43.92425Z","caller":"traceutil/trace.go:171","msg":"trace[1682249528] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1392; }","duration":"137.52359ms","start":"2026-06-09T01:07:43.786705Z","end":"2026-06-09T01:07:43.924229Z","steps":["trace[1682249528] 'agreement among raft nodes before linearized reading' (duration: 87.005208ms)","trace[1682249528] 'range keys from in-memory index tree' (duration: 50.33308ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:07:43.924486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.58148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-09T01:07:43.924547Z","caller":"traceutil/trace.go:171","msg":"trace[899919086] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1392; }","duration":"128.63433ms","start":"2026-06-09T01:07:43.795892Z","end":"2026-06-09T01:07:43.924526Z","steps":["trace[899919086] 'agreement among raft nodes before linearized reading' (duration: 77.792476ms)","trace[899919086] 'range keys from in-memory index tree' (duration: 50.671143ms)"],"step_count":2}