{"level":"warn","ts":"2026-07-22T22:08:39.884054Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-22T22:08:39.88415Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.222: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.222:2380","--initial-cluster=instance=https://199.204.45.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.222: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-07-22T22:08:39.88422Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-22T22:08:39.884233Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-07-22T22:08:39.884258Z","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-07-22T22:08:39.884917Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"]} {"level":"info","ts":"2026-07-22T22:08:39.88499Z","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.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.222: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-07-22T22:08:39.888195Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.999732ms"} {"level":"info","ts":"2026-07-22T22:08:39.895781Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"380f6760faea5f9e","cluster-id":"b87e8aca83a17eab"} {"level":"info","ts":"2026-07-22T22:08:39.895892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=()"} {"level":"info","ts":"2026-07-22T22:08:39.895926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 0"} {"level":"info","ts":"2026-07-22T22:08:39.895953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 380f6760faea5f9e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-22T22:08:39.895971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 1"} {"level":"info","ts":"2026-07-22T22:08:39.896023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"warn","ts":"2026-07-22T22:08:39.900293Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-22T22:08:39.9014Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-22T22:08:39.902288Z","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-07-22T22:08:39.904417Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"380f6760faea5f9e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-22T22:08:39.904517Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"380f6760faea5f9e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-22T22:08:39.905319Z","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-07-22T22:08:39.905534Z","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-07-22T22:08:39.905567Z","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-07-22T22:08:39.909493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"info","ts":"2026-07-22T22:08:39.909606Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","added-peer-id":"380f6760faea5f9e","added-peer-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-07-22T22:08:39.910811Z","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-07-22T22:08:39.910941Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"380f6760faea5f9e","initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-22T22:08:39.910963Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-22T22:08:39.911046Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-07-22T22:08:39.911058Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-07-22T22:08:39.996708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e is starting a new election at term 1"} {"level":"info","ts":"2026-07-22T22:08:39.996784Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became pre-candidate at term 1"} {"level":"info","ts":"2026-07-22T22:08:39.996836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgPreVoteResp from 380f6760faea5f9e at term 1"} {"level":"info","ts":"2026-07-22T22:08:39.996865Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became candidate at term 2"} {"level":"info","ts":"2026-07-22T22:08:39.996878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgVoteResp from 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-07-22T22:08:39.996901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became leader at term 2"} {"level":"info","ts":"2026-07-22T22:08:39.996925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 380f6760faea5f9e elected leader 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-07-22T22:08:39.997818Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-22T22:08:39.997979Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"380f6760faea5f9e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.222:2379]}","request-path":"/0/members/380f6760faea5f9e/attributes","cluster-id":"b87e8aca83a17eab","publish-timeout":"7s"} {"level":"info","ts":"2026-07-22T22:08:39.997973Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-22T22:08:39.998086Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-22T22:08:39.998315Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-22T22:08:39.998376Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-22T22:08:39.998816Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","cluster-version":"3.5"} {"level":"info","ts":"2026-07-22T22:08:39.998923Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-22T22:08:39.998958Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-22T22:08:39.999964Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.222:2379"} {"level":"info","ts":"2026-07-22T22:08:40.001697Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-07-22T22:08:42.890836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"939.936221ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-22T22:08:42.8915Z","caller":"traceutil/trace.go:171","msg":"trace[1326756465] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"1.063128222s","start":"2026-07-22T22:08:41.828301Z","end":"2026-07-22T22:08:42.891429Z","steps":["trace[1326756465] 'process raft request' (duration: 1.062673361s)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:08:42.89168Z","caller":"traceutil/trace.go:171","msg":"trace[1714766185] transaction","detail":"{read_only:false; number_of_response:0; response_revision:13; }","duration":"1.063275106s","start":"2026-07-22T22:08:41.828371Z","end":"2026-07-22T22:08:42.891646Z","steps":["trace[1714766185] 'process raft request' (duration: 1.062918327s)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:42.891795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:41.828341Z","time spent":"1.063405549s","remote":"127.0.0.1:59500","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-22T22:08:42.891804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:41.828283Z","time spent":"1.063323107s","remote":"127.0.0.1:59500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-22T22:08:42.89194Z","caller":"traceutil/trace.go:171","msg":"trace[868970969] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"1.060363075s","start":"2026-07-22T22:08:41.831543Z","end":"2026-07-22T22:08:42.891906Z","steps":["trace[868970969] 'process raft request' (duration: 1.060004946s)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:08:42.891948Z","caller":"traceutil/trace.go:171","msg":"trace[744287921] linearizableReadLoop","detail":"{readStateIndex:17; appliedIndex:14; }","duration":"1.060739665s","start":"2026-07-22T22:08:41.831193Z","end":"2026-07-22T22:08:42.891933Z","steps":["trace[744287921] 'read index received' (duration: 119.028611ms)","trace[744287921] 'applied index is now lower than readState.Index' (duration: 941.709914ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:08:42.892113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:41.83153Z","time spent":"1.060498239s","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-22T22:08:42.892178Z","caller":"traceutil/trace.go:171","msg":"trace[187229747] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"1.060937699s","start":"2026-07-22T22:08:41.831228Z","end":"2026-07-22T22:08:42.892166Z","steps":["trace[187229747] 'process raft request' (duration: 1.060159891s)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:08:42.892207Z","caller":"traceutil/trace.go:171","msg":"trace[1904654419] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"1.060606951s","start":"2026-07-22T22:08:41.831588Z","end":"2026-07-22T22:08:42.892195Z","steps":["trace[1904654419] 'process raft request' (duration: 1.059982326s)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:42.892246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:41.831219Z","time spent":"1.060999861s","remote":"127.0.0.1:40852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-22T22:08:42.892329Z","caller":"traceutil/trace.go:171","msg":"trace[789830786] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"1.060863377s","start":"2026-07-22T22:08:41.831457Z","end":"2026-07-22T22:08:42.89232Z","steps":["trace[789830786] 'process raft request' (duration: 1.060053867s)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:42.892396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:41.831451Z","time spent":"1.060921409s","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-22T22:08:42.892721Z","caller":"traceutil/trace.go:171","msg":"trace[2056297752] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"1.060853217s","start":"2026-07-22T22:08:41.831839Z","end":"2026-07-22T22:08:42.892692Z","steps":["trace[2056297752] 'process raft request' (duration: 1.059778311s)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:08:42.892767Z","caller":"traceutil/trace.go:171","msg":"trace[1320529980] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"1.061127584s","start":"2026-07-22T22:08:41.831626Z","end":"2026-07-22T22:08:42.892754Z","steps":["trace[1320529980] 'process raft request' (duration: 1.059965685s)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:42.892791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.061526874s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-07-22T22:08:42.892341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:41.831583Z","time spent":"1.060708033s","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-22T22:08:42.893528Z","caller":"traceutil/trace.go:171","msg":"trace[1413384591] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"1.062351404s","start":"2026-07-22T22:08:41.831157Z","end":"2026-07-22T22:08:42.893508Z","steps":["trace[1413384591] 'agreement among raft nodes before linearized reading' (duration: 1.061447892s)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:42.893811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:41.831137Z","time spent":"1.06264156s","remote":"127.0.0.1:59500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-22T22:08:42.892919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.061547504s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-l5c6z\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-07-22T22:08:42.893945Z","caller":"traceutil/trace.go:171","msg":"trace[1835517578] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-l5c6z; range_end:; response_count:1; response_revision:20; }","duration":"1.062582789s","start":"2026-07-22T22:08:41.831338Z","end":"2026-07-22T22:08:42.893921Z","steps":["trace[1835517578] 'agreement among raft nodes before linearized reading' (duration: 1.061535863s)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:42.892962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.46236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-22T22:08:42.892937Z","caller":"traceutil/trace.go:171","msg":"trace[112556906] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"1.056650866s","start":"2026-07-22T22:08:41.836275Z","end":"2026-07-22T22:08:42.892926Z","steps":["trace[112556906] 'process raft request' (duration: 1.055563549s)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:42.892994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.75828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-22T22:08:42.892967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:41.831829Z","time spent":"1.060951109s","remote":"127.0.0.1:40798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-22T22:08:42.893034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.007776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-22T22:08:42.893069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.040167697s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-07-22T22:08:42.891296Z","caller":"traceutil/trace.go:171","msg":"trace[1649179778] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"1.088104098s","start":"2026-07-22T22:08:41.803036Z","end":"2026-07-22T22:08:42.891141Z","steps":["trace[1649179778] 'process raft request' (duration: 147.147482ms)","trace[1649179778] 'compare' (duration: 939.805008ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:08:42.894127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:41.831332Z","time spent":"1.062692751s","remote":"127.0.0.1:59646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":884,"request content":"key:\"/registry/certificatesigningrequests/csr-l5c6z\" "} {"level":"warn","ts":"2026-07-22T22:08:42.894268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:41.803027Z","time spent":"1.091145271s","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-22T22:08:42.894409Z","caller":"traceutil/trace.go:171","msg":"trace[1441366310] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"1.041526639s","start":"2026-07-22T22:08:41.852872Z","end":"2026-07-22T22:08:42.894399Z","steps":["trace[1441366310] 'agreement among raft nodes before linearized reading' (duration: 1.040176577s)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:42.894461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:41.85286Z","time spent":"1.041587201s","remote":"127.0.0.1:59500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-07-22T22:08:42.894287Z","caller":"traceutil/trace.go:171","msg":"trace[1799800424] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:20; }","duration":"214.088072ms","start":"2026-07-22T22:08:42.680188Z","end":"2026-07-22T22:08:42.894276Z","steps":["trace[1799800424] 'agreement among raft nodes before linearized reading' (duration: 212.787431ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:42.894444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:41.836263Z","time spent":"1.057834884s","remote":"127.0.0.1:59550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3479,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-22T22:08:42.89411Z","caller":"traceutil/trace.go:171","msg":"trace[1114257094] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20; }","duration":"191.599398ms","start":"2026-07-22T22:08:42.702455Z","end":"2026-07-22T22:08:42.894054Z","steps":["trace[1114257094] 'agreement among raft nodes before linearized reading' (duration: 190.481891ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:08:42.894654Z","caller":"traceutil/trace.go:171","msg":"trace[1096777355] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:20; }","duration":"214.656386ms","start":"2026-07-22T22:08:42.679987Z","end":"2026-07-22T22:08:42.894644Z","steps":["trace[1096777355] 'agreement among raft nodes before linearized reading' (duration: 213.026347ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:42.892825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:41.831613Z","time spent":"1.061186176s","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-22T22:08:43.618285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.246183ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-22T22:08:43.618563Z","caller":"traceutil/trace.go:171","msg":"trace[151863693] linearizableReadLoop","detail":"{readStateIndex:25; appliedIndex:24; }","duration":"720.10102ms","start":"2026-07-22T22:08:42.898441Z","end":"2026-07-22T22:08:43.618542Z","steps":["trace[151863693] 'read index received' (duration: 401.725453ms)","trace[151863693] 'applied index is now lower than readState.Index' (duration: 318.373017ms)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:08:43.61856Z","caller":"traceutil/trace.go:171","msg":"trace[1597322112] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"720.269724ms","start":"2026-07-22T22:08:42.898242Z","end":"2026-07-22T22:08:43.618511Z","steps":["trace[1597322112] 'process raft request' (duration: 401.724333ms)","trace[1597322112] 'compare' (duration: 318.040109ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:08:43.618787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:42.898223Z","time spent":"720.472658ms","remote":"127.0.0.1:40852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-22T22:08:43.618822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.364696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-22T22:08:43.618908Z","caller":"traceutil/trace.go:171","msg":"trace[1942921618] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:22; }","duration":"720.501339ms","start":"2026-07-22T22:08:42.898395Z","end":"2026-07-22T22:08:43.618897Z","steps":["trace[1942921618] 'agreement among raft nodes before linearized reading' (duration: 720.300254ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:43.618996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:42.898376Z","time spent":"720.5649ms","remote":"127.0.0.1:59728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":27,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" "} {"level":"info","ts":"2026-07-22T22:08:43.619031Z","caller":"traceutil/trace.go:171","msg":"trace[908291549] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"720.366716ms","start":"2026-07-22T22:08:42.898639Z","end":"2026-07-22T22:08:43.619006Z","steps":["trace[908291549] 'process raft request' (duration: 719.908495ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:43.619181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:42.898619Z","time spent":"720.477749ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-22T22:08:43.620354Z","caller":"traceutil/trace.go:171","msg":"trace[1267317725] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"721.589666ms","start":"2026-07-22T22:08:42.89874Z","end":"2026-07-22T22:08:43.620329Z","steps":["trace[1267317725] 'process raft request' (duration: 721.372871ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:43.620483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.021641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-22T22:08:43.620561Z","caller":"traceutil/trace.go:171","msg":"trace[1517538797] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:29; }","duration":"721.151515ms","start":"2026-07-22T22:08:42.89939Z","end":"2026-07-22T22:08:43.620541Z","steps":["trace[1517538797] 'agreement among raft nodes before linearized reading' (duration: 720.980481ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:08:43.620585Z","caller":"traceutil/trace.go:171","msg":"trace[128432051] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"721.813871ms","start":"2026-07-22T22:08:42.898761Z","end":"2026-07-22T22:08:43.620575Z","steps":["trace[128432051] 'process raft request' (duration: 721.425881ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:43.620604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:42.89934Z","time spent":"721.255027ms","remote":"127.0.0.1:59462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" "} {"level":"warn","ts":"2026-07-22T22:08:43.620607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:42.898725Z","time spent":"721.78958ms","remote":"127.0.0.1:59652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-22T22:08:43.620636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:42.898754Z","time spent":"721.854242ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":947,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-22T22:08:43.620767Z","caller":"traceutil/trace.go:171","msg":"trace[1570885336] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"721.850511ms","start":"2026-07-22T22:08:42.89891Z","end":"2026-07-22T22:08:43.62076Z","steps":["trace[1570885336] 'process raft request' (duration: 721.310198ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:43.6208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:42.898904Z","time spent":"721.877593ms","remote":"127.0.0.1:59740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-22T22:08:43.620825Z","caller":"traceutil/trace.go:171","msg":"trace[553043833] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"721.880213ms","start":"2026-07-22T22:08:42.898933Z","end":"2026-07-22T22:08:43.620814Z","steps":["trace[553043833] 'process raft request' (duration: 721.333909ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:43.6209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:42.898925Z","time spent":"721.926743ms","remote":"127.0.0.1:59490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":357,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-22T22:08:43.620938Z","caller":"traceutil/trace.go:171","msg":"trace[384626529] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"721.652747ms","start":"2026-07-22T22:08:42.899278Z","end":"2026-07-22T22:08:43.620931Z","steps":["trace[384626529] 'process raft request' (duration: 721.019952ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:08:43.620922Z","caller":"traceutil/trace.go:171","msg":"trace[970263615] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"721.043983ms","start":"2026-07-22T22:08:42.899858Z","end":"2026-07-22T22:08:43.620902Z","steps":["trace[970263615] 'process raft request' (duration: 720.472609ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:43.620977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:42.899267Z","time spent":"721.687888ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":956,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-22T22:08:43.621053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.111684ms","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-07-22T22:08:43.620926Z","caller":"traceutil/trace.go:171","msg":"trace[1172123919] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"722.18397ms","start":"2026-07-22T22:08:42.898725Z","end":"2026-07-22T22:08:43.620909Z","steps":["trace[1172123919] 'process raft request' (duration: 720.345945ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:08:43.621097Z","caller":"traceutil/trace.go:171","msg":"trace[1803795866] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:29; }","duration":"721.162745ms","start":"2026-07-22T22:08:42.899925Z","end":"2026-07-22T22:08:43.621087Z","steps":["trace[1803795866] 'agreement among raft nodes before linearized reading' (duration: 721.094804ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:43.621129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:42.899922Z","time spent":"721.200566ms","remote":"127.0.0.1:59490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":27,"request content":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" "} {"level":"warn","ts":"2026-07-22T22:08:43.621142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:42.898713Z","time spent":"722.388955ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-22T22:08:43.621044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:08:42.899847Z","time spent":"721.124664ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-22T22:08:45.400932Z","caller":"traceutil/trace.go:171","msg":"trace[18716712] linearizableReadLoop","detail":"{readStateIndex:231; appliedIndex:230; }","duration":"144.954067ms","start":"2026-07-22T22:08:45.255952Z","end":"2026-07-22T22:08:45.400906Z","steps":["trace[18716712] 'read index received' (duration: 100.083052ms)","trace[18716712] 'applied index is now lower than readState.Index' (duration: 44.870155ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:08:45.401123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.149352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:08:45.401179Z","caller":"traceutil/trace.go:171","msg":"trace[651148599] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:0; response_revision:225; }","duration":"145.249295ms","start":"2026-07-22T22:08:45.255906Z","end":"2026-07-22T22:08:45.401156Z","steps":["trace[651148599] 'agreement among raft nodes before linearized reading' (duration: 145.114441ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:08:45.401429Z","caller":"traceutil/trace.go:171","msg":"trace[724524306] transaction","detail":"{read_only:false; response_revision:225; number_of_response:1; }","duration":"152.946591ms","start":"2026-07-22T22:08:45.248467Z","end":"2026-07-22T22:08:45.401414Z","steps":["trace[724524306] 'process raft request' (duration: 107.732817ms)","trace[724524306] 'compare' (duration: 44.558928ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:08:45.770971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.711548ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-22T22:08:45.771062Z","caller":"traceutil/trace.go:171","msg":"trace[1914264015] linearizableReadLoop","detail":"{readStateIndex:236; appliedIndex:235; }","duration":"112.722088ms","start":"2026-07-22T22:08:45.658324Z","end":"2026-07-22T22:08:45.771046Z","steps":["trace[1914264015] 'read index received' (duration: 11.661352ms)","trace[1914264015] 'applied index is now lower than readState.Index' (duration: 101.059696ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:08:45.77114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.81739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:08:45.771172Z","caller":"traceutil/trace.go:171","msg":"trace[1935809512] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:230; }","duration":"112.882452ms","start":"2026-07-22T22:08:45.65828Z","end":"2026-07-22T22:08:45.771163Z","steps":["trace[1935809512] 'agreement among raft nodes before linearized reading' (duration: 112.80993ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:08:45.771159Z","caller":"traceutil/trace.go:171","msg":"trace[269545613] transaction","detail":"{read_only:false; response_revision:230; number_of_response:1; }","duration":"114.182033ms","start":"2026-07-22T22:08:45.656948Z","end":"2026-07-22T22:08:45.77113Z","steps":["trace[269545613] 'process raft request' (duration: 13.24048ms)","trace[269545613] 'compare' (duration: 100.619686ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:08:46.474128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.722469ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-22T22:08:46.47428Z","caller":"traceutil/trace.go:171","msg":"trace[1213179233] linearizableReadLoop","detail":"{readStateIndex:251; appliedIndex:249; }","duration":"205.558435ms","start":"2026-07-22T22:08:46.268706Z","end":"2026-07-22T22:08:46.474264Z","steps":["trace[1213179233] 'read index received' (duration: 145.989954ms)","trace[1213179233] 'applied index is now lower than readState.Index' (duration: 59.567651ms)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:08:46.474358Z","caller":"traceutil/trace.go:171","msg":"trace[225954157] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"217.551025ms","start":"2026-07-22T22:08:46.256796Z","end":"2026-07-22T22:08:46.474347Z","steps":["trace[225954157] 'process raft request' (duration: 11.530049ms)","trace[225954157] 'compare' (duration: 205.565095ms)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:08:46.474623Z","caller":"traceutil/trace.go:171","msg":"trace[1210295863] transaction","detail":"{read_only:false; response_revision:245; number_of_response:1; }","duration":"205.976346ms","start":"2026-07-22T22:08:46.268638Z","end":"2026-07-22T22:08:46.474614Z","steps":["trace[1210295863] 'process raft request' (duration: 205.584116ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:46.47467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.282559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-22T22:08:46.475375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.648101ms","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-07-22T22:08:46.475445Z","caller":"traceutil/trace.go:171","msg":"trace[679158179] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:245; }","duration":"206.761454ms","start":"2026-07-22T22:08:46.268668Z","end":"2026-07-22T22:08:46.475429Z","steps":["trace[679158179] 'agreement among raft nodes before linearized reading' (duration: 206.615221ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:08:46.475528Z","caller":"traceutil/trace.go:171","msg":"trace[1999572339] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:245; }","duration":"160.447283ms","start":"2026-07-22T22:08:46.314324Z","end":"2026-07-22T22:08:46.474772Z","steps":["trace[1999572339] 'agreement among raft nodes before linearized reading' (duration: 160.099905ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:08:58.099257Z","caller":"traceutil/trace.go:171","msg":"trace[343205961] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"139.268221ms","start":"2026-07-22T22:08:57.959963Z","end":"2026-07-22T22:08:58.099232Z","steps":["trace[343205961] 'process raft request' (duration: 139.117288ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:09:17.768232Z","caller":"traceutil/trace.go:171","msg":"trace[146542676] linearizableReadLoop","detail":"{readStateIndex:504; appliedIndex:503; }","duration":"252.43228ms","start":"2026-07-22T22:09:17.515771Z","end":"2026-07-22T22:09:17.768204Z","steps":["trace[146542676] 'read index received' (duration: 252.142973ms)","trace[146542676] 'applied index is now lower than readState.Index' (duration: 288.396µs)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:09:17.768291Z","caller":"traceutil/trace.go:171","msg":"trace[129536266] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"272.162148ms","start":"2026-07-22T22:09:17.496093Z","end":"2026-07-22T22:09:17.768255Z","steps":["trace[129536266] 'process raft request' (duration: 271.875651ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:17.768364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.568534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:09:17.768405Z","caller":"traceutil/trace.go:171","msg":"trace[1092128547] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:486; }","duration":"252.651935ms","start":"2026-07-22T22:09:17.515739Z","end":"2026-07-22T22:09:17.768391Z","steps":["trace[1092128547] 'agreement among raft nodes before linearized reading' (duration: 252.567473ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:18.760067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.570465ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-22T22:09:18.760168Z","caller":"traceutil/trace.go:171","msg":"trace[2076107438] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"396.364644ms","start":"2026-07-22T22:09:18.363789Z","end":"2026-07-22T22:09:18.760153Z","steps":["trace[2076107438] 'process raft request' (duration: 95.638025ms)","trace[2076107438] 'compare' (duration: 300.445002ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:09:18.760214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:18.363765Z","time spent":"396.430135ms","remote":"127.0.0.1:59422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80679,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-22T22:09:18.781739Z","caller":"traceutil/trace.go:171","msg":"trace[2090625269] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"412.003792ms","start":"2026-07-22T22:09:18.36968Z","end":"2026-07-22T22:09:18.781684Z","steps":["trace[2090625269] 'process raft request' (duration: 411.605083ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:09:18.781786Z","caller":"traceutil/trace.go:171","msg":"trace[2046619366] linearizableReadLoop","detail":"{readStateIndex:555; appliedIndex:551; }","duration":"383.853221ms","start":"2026-07-22T22:09:18.397907Z","end":"2026-07-22T22:09:18.781761Z","steps":["trace[2046619366] 'read index received' (duration: 61.439817ms)","trace[2046619366] 'applied index is now lower than readState.Index' (duration: 322.412514ms)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:09:18.78191Z","caller":"traceutil/trace.go:171","msg":"trace[1159382585] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"399.242364ms","start":"2026-07-22T22:09:18.382624Z","end":"2026-07-22T22:09:18.781867Z","steps":["trace[1159382585] 'process raft request' (duration: 398.846344ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:18.781961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:18.369641Z","time spent":"412.194207ms","remote":"127.0.0.1:59422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65199,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-22T22:09:18.782125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:18.382581Z","time spent":"399.422068ms","remote":"127.0.0.1:59422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-22T22:09:18.782139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.22856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-22T22:09:18.782198Z","caller":"traceutil/trace.go:171","msg":"trace[462797867] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:535; }","duration":"384.340803ms","start":"2026-07-22T22:09:18.397843Z","end":"2026-07-22T22:09:18.782184Z","steps":["trace[462797867] 'agreement among raft nodes before linearized reading' (duration: 384.149039ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:18.782232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:18.397797Z","time spent":"384.427285ms","remote":"127.0.0.1:59652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-22T22:09:18.781888Z","caller":"traceutil/trace.go:171","msg":"trace[586009173] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"392.550372ms","start":"2026-07-22T22:09:18.389321Z","end":"2026-07-22T22:09:18.781871Z","steps":["trace[586009173] 'process raft request' (duration: 392.349457ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:18.782355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:18.3893Z","time spent":"393.020083ms","remote":"127.0.0.1:59422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-22T22:09:18.782608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.371957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:09:18.782657Z","caller":"traceutil/trace.go:171","msg":"trace[1749742544] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:535; }","duration":"197.46368ms","start":"2026-07-22T22:09:18.585178Z","end":"2026-07-22T22:09:18.782642Z","steps":["trace[1749742544] 'agreement among raft nodes before linearized reading' (duration: 197.392018ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:18.78272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.111601ms","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-07-22T22:09:18.782791Z","caller":"traceutil/trace.go:171","msg":"trace[1229314606] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:535; }","duration":"109.185434ms","start":"2026-07-22T22:09:18.673584Z","end":"2026-07-22T22:09:18.782769Z","steps":["trace[1229314606] 'agreement among raft nodes before linearized reading' (duration: 109.03808ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:18.78286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.309127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-22T22:09:18.782902Z","caller":"traceutil/trace.go:171","msg":"trace[591122401] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:535; }","duration":"109.382038ms","start":"2026-07-22T22:09:18.673511Z","end":"2026-07-22T22:09:18.782893Z","steps":["trace[591122401] 'agreement among raft nodes before linearized reading' (duration: 109.307766ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:18.783051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.078954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:09:18.783089Z","caller":"traceutil/trace.go:171","msg":"trace[1185254127] 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:535; }","duration":"136.127195ms","start":"2026-07-22T22:09:18.646951Z","end":"2026-07-22T22:09:18.783079Z","steps":["trace[1185254127] 'agreement among raft nodes before linearized reading' (duration: 136.072524ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:18.783251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.72585ms","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-07-22T22:09:18.783286Z","caller":"traceutil/trace.go:171","msg":"trace[804242744] 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:535; }","duration":"136.764581ms","start":"2026-07-22T22:09:18.646513Z","end":"2026-07-22T22:09:18.783278Z","steps":["trace[804242744] 'agreement among raft nodes before linearized reading' (duration: 136.70719ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:18.783364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.457453ms","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-07-22T22:09:18.783413Z","caller":"traceutil/trace.go:171","msg":"trace[190431025] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:535; }","duration":"105.518575ms","start":"2026-07-22T22:09:18.67788Z","end":"2026-07-22T22:09:18.783399Z","steps":["trace[190431025] 'agreement among raft nodes before linearized reading' (duration: 105.446313ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:18.783577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.121119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:09:18.783624Z","caller":"traceutil/trace.go:171","msg":"trace[498910220] 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:535; }","duration":"137.197701ms","start":"2026-07-22T22:09:18.646414Z","end":"2026-07-22T22:09:18.783611Z","steps":["trace[498910220] 'agreement among raft nodes before linearized reading' (duration: 137.005486ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:18.783778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.035231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:09:18.783815Z","caller":"traceutil/trace.go:171","msg":"trace[36810081] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:535; }","duration":"157.094543ms","start":"2026-07-22T22:09:18.62671Z","end":"2026-07-22T22:09:18.783805Z","steps":["trace[36810081] 'agreement among raft nodes before linearized reading' (duration: 157.039761ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:18.783958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.41283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:09:18.783985Z","caller":"traceutil/trace.go:171","msg":"trace[787194039] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:535; }","duration":"157.472672ms","start":"2026-07-22T22:09:18.626505Z","end":"2026-07-22T22:09:18.783977Z","steps":["trace[787194039] 'agreement among raft nodes before linearized reading' (duration: 157.427901ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:18.784078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.605735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:09:18.784102Z","caller":"traceutil/trace.go:171","msg":"trace[1163859896] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:535; }","duration":"157.649646ms","start":"2026-07-22T22:09:18.626445Z","end":"2026-07-22T22:09:18.784095Z","steps":["trace[1163859896] 'agreement among raft nodes before linearized reading' (duration: 157.607335ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:18.784299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.525979ms","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-07-22T22:09:18.78432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.218502ms","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-07-22T22:09:18.784374Z","caller":"traceutil/trace.go:171","msg":"trace[1536067342] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:535; }","duration":"106.615481ms","start":"2026-07-22T22:09:18.677738Z","end":"2026-07-22T22:09:18.784354Z","steps":["trace[1536067342] 'agreement among raft nodes before linearized reading' (duration: 106.514279ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:09:18.784404Z","caller":"traceutil/trace.go:171","msg":"trace[341446033] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:535; }","duration":"180.313204ms","start":"2026-07-22T22:09:18.604061Z","end":"2026-07-22T22:09:18.784374Z","steps":["trace[341446033] 'agreement among raft nodes before linearized reading' (duration: 180.194982ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:18.784584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.38602ms","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":"info","ts":"2026-07-22T22:09:18.784626Z","caller":"traceutil/trace.go:171","msg":"trace[109565935] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:535; }","duration":"181.461102ms","start":"2026-07-22T22:09:18.603155Z","end":"2026-07-22T22:09:18.784616Z","steps":["trace[109565935] 'agreement among raft nodes before linearized reading' (duration: 181.401731ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:18.784658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.382296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:09:18.784712Z","caller":"traceutil/trace.go:171","msg":"trace[645674942] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:535; }","duration":"199.441587ms","start":"2026-07-22T22:09:18.585262Z","end":"2026-07-22T22:09:18.784704Z","steps":["trace[645674942] 'agreement among raft nodes before linearized reading' (duration: 199.382016ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:18.784596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.335185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:09:18.784781Z","caller":"traceutil/trace.go:171","msg":"trace[1843518643] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:535; }","duration":"199.53063ms","start":"2026-07-22T22:09:18.585243Z","end":"2026-07-22T22:09:18.784774Z","steps":["trace[1843518643] 'agreement among raft nodes before linearized reading' (duration: 199.325665ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:18.784631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.507174ms","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":"info","ts":"2026-07-22T22:09:18.784839Z","caller":"traceutil/trace.go:171","msg":"trace[1502533478] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:535; }","duration":"181.734858ms","start":"2026-07-22T22:09:18.603092Z","end":"2026-07-22T22:09:18.784827Z","steps":["trace[1502533478] 'agreement among raft nodes before linearized reading' (duration: 181.521733ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:09:19.407299Z","caller":"traceutil/trace.go:171","msg":"trace[497896659] transaction","detail":"{read_only:false; number_of_response:1; response_revision:538; }","duration":"561.368358ms","start":"2026-07-22T22:09:18.845902Z","end":"2026-07-22T22:09:19.40727Z","steps":["trace[497896659] 'process raft request' (duration: 555.057965ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:19.40769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:18.845887Z","time spent":"561.533352ms","remote":"127.0.0.1:59422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97,"response count":0,"response size":150531,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-22T22:09:19.408316Z","caller":"traceutil/trace.go:171","msg":"trace[60499570] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"544.573891ms","start":"2026-07-22T22:09:18.863716Z","end":"2026-07-22T22:09:19.40829Z","steps":["trace[60499570] 'process raft request' (duration: 544.312575ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:19.408455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:18.863694Z","time spent":"544.691854ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-22T22:09:19.408903Z","caller":"traceutil/trace.go:171","msg":"trace[1989057844] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"541.189169ms","start":"2026-07-22T22:09:18.867693Z","end":"2026-07-22T22:09:19.408882Z","steps":["trace[1989057844] 'process raft request' (duration: 540.531303ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:19.40901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:18.867676Z","time spent":"541.271541ms","remote":"127.0.0.1:59422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80688,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-22T22:09:19.409379Z","caller":"traceutil/trace.go:171","msg":"trace[2018374673] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"525.253714ms","start":"2026-07-22T22:09:18.884106Z","end":"2026-07-22T22:09:19.409359Z","steps":["trace[2018374673] 'process raft request' (duration: 524.721471ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:09:19.409407Z","caller":"traceutil/trace.go:171","msg":"trace[2041536181] linearizableReadLoop","detail":"{readStateIndex:562; appliedIndex:558; }","duration":"374.72975ms","start":"2026-07-22T22:09:19.034559Z","end":"2026-07-22T22:09:19.409288Z","steps":["trace[2041536181] 'read index received' (duration: 366.47623ms)","trace[2041536181] 'applied index is now lower than readState.Index' (duration: 8.25253ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:09:19.409465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:18.884079Z","time spent":"525.345735ms","remote":"127.0.0.1:59422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-22T22:09:19.409506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.936685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:09:19.409545Z","caller":"traceutil/trace.go:171","msg":"trace[821396070] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:541; }","duration":"375.007907ms","start":"2026-07-22T22:09:19.034528Z","end":"2026-07-22T22:09:19.409536Z","steps":["trace[821396070] 'agreement among raft nodes before linearized reading' (duration: 374.901104ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:19.40957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:19.034513Z","time spent":"375.051248ms","remote":"127.0.0.1:36168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-07-22T22:09:19.409909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.069274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-22T22:09:19.409929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.691695ms","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-07-22T22:09:19.409962Z","caller":"traceutil/trace.go:171","msg":"trace[1566642047] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:541; }","duration":"286.161416ms","start":"2026-07-22T22:09:19.12379Z","end":"2026-07-22T22:09:19.409951Z","steps":["trace[1566642047] 'agreement among raft nodes before linearized reading' (duration: 286.053743ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:19.409957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.159296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:09:19.409996Z","caller":"traceutil/trace.go:171","msg":"trace[1683933767] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:541; }","duration":"304.766827ms","start":"2026-07-22T22:09:19.105212Z","end":"2026-07-22T22:09:19.409979Z","steps":["trace[1683933767] 'agreement among raft nodes before linearized reading' (duration: 304.660604ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:19.410015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.372691ms","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-07-22T22:09:19.410024Z","caller":"traceutil/trace.go:171","msg":"trace[1117017050] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:541; }","duration":"286.277499ms","start":"2026-07-22T22:09:19.12373Z","end":"2026-07-22T22:09:19.410007Z","steps":["trace[1117017050] 'agreement among raft nodes before linearized reading' (duration: 286.126426ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:09:19.410044Z","caller":"traceutil/trace.go:171","msg":"trace[1675394783] 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:541; }","duration":"324.435213ms","start":"2026-07-22T22:09:19.085598Z","end":"2026-07-22T22:09:19.410033Z","steps":["trace[1675394783] 'agreement among raft nodes before linearized reading' (duration: 324.404272ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:19.410048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:19.105179Z","time spent":"304.854309ms","remote":"127.0.0.1:36200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-07-22T22:09:19.410066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:19.085575Z","time spent":"324.485814ms","remote":"127.0.0.1:36184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-07-22T22:09:19.409989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.132356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:09:19.410213Z","caller":"traceutil/trace.go:171","msg":"trace[2111540696] 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:541; }","duration":"324.354111ms","start":"2026-07-22T22:09:19.085851Z","end":"2026-07-22T22:09:19.410205Z","steps":["trace[2111540696] 'agreement among raft nodes before linearized reading' (duration: 324.123586ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:19.409949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.408853ms","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-07-22T22:09:19.410279Z","caller":"traceutil/trace.go:171","msg":"trace[835868180] 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:541; }","duration":"324.759131ms","start":"2026-07-22T22:09:19.085503Z","end":"2026-07-22T22:09:19.410263Z","steps":["trace[835868180] 'agreement among raft nodes before linearized reading' (duration: 324.391902ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:19.410326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.797461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-22T22:09:19.410344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:19.085491Z","time spent":"324.834552ms","remote":"127.0.0.1:36184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"info","ts":"2026-07-22T22:09:19.410359Z","caller":"traceutil/trace.go:171","msg":"trace[400111231] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:541; }","duration":"343.863143ms","start":"2026-07-22T22:09:19.06648Z","end":"2026-07-22T22:09:19.410343Z","steps":["trace[400111231] 'agreement among raft nodes before linearized reading' (duration: 343.826712ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:19.410381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:19.066458Z","time spent":"343.917194ms","remote":"127.0.0.1:36174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-07-22T22:09:19.410241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:19.085828Z","time spent":"324.401322ms","remote":"127.0.0.1:36184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-07-22T22:09:19.410462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.077684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-22T22:09:19.41047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.034767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:09:19.410485Z","caller":"traceutil/trace.go:171","msg":"trace[32785655] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:541; }","duration":"343.116035ms","start":"2026-07-22T22:09:19.06736Z","end":"2026-07-22T22:09:19.410476Z","steps":["trace[32785655] 'agreement among raft nodes before linearized reading' (duration: 343.082074ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:19.410515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:19.067351Z","time spent":"343.152135ms","remote":"127.0.0.1:36174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"info","ts":"2026-07-22T22:09:19.410528Z","caller":"traceutil/trace.go:171","msg":"trace[2086847029] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:541; }","duration":"344.083148ms","start":"2026-07-22T22:09:19.066401Z","end":"2026-07-22T22:09:19.410484Z","steps":["trace[2086847029] 'agreement among raft nodes before linearized reading' (duration: 344.050427ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:19.410545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:19.066386Z","time spent":"344.15471ms","remote":"127.0.0.1:36174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-07-22T22:09:19.411008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.492084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:09:19.411131Z","caller":"traceutil/trace.go:171","msg":"trace[133105082] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:541; }","duration":"305.661329ms","start":"2026-07-22T22:09:19.105444Z","end":"2026-07-22T22:09:19.411105Z","steps":["trace[133105082] 'agreement among raft nodes before linearized reading' (duration: 305.391262ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:19.41119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:19.105437Z","time spent":"305.740241ms","remote":"127.0.0.1:36200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-22T22:09:19.411692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.838643ms","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-07-22T22:09:19.411744Z","caller":"traceutil/trace.go:171","msg":"trace[1639820516] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:541; }","duration":"286.904644ms","start":"2026-07-22T22:09:19.124817Z","end":"2026-07-22T22:09:19.411722Z","steps":["trace[1639820516] 'agreement among raft nodes before linearized reading' (duration: 286.824652ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:19.418964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.312082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:09:19.419009Z","caller":"traceutil/trace.go:171","msg":"trace[1735719129] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:541; }","duration":"384.374113ms","start":"2026-07-22T22:09:19.034622Z","end":"2026-07-22T22:09:19.418996Z","steps":["trace[1735719129] 'agreement among raft nodes before linearized reading' (duration: 375.210941ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:19.419036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:19.034597Z","time spent":"384.431545ms","remote":"127.0.0.1:36168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-07-22T22:09:24.038054Z","caller":"traceutil/trace.go:171","msg":"trace[782582867] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"315.560407ms","start":"2026-07-22T22:09:23.722468Z","end":"2026-07-22T22:09:24.038029Z","steps":["trace[782582867] 'read index received' (duration: 314.626985ms)","trace[782582867] 'applied index is now lower than readState.Index' (duration: 932.552µs)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:09:24.038174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.691081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:09:24.038206Z","caller":"traceutil/trace.go:171","msg":"trace[606865172] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"315.769382ms","start":"2026-07-22T22:09:23.722426Z","end":"2026-07-22T22:09:24.038195Z","steps":["trace[606865172] 'agreement among raft nodes before linearized reading' (duration: 315.698981ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:09:24.038158Z","caller":"traceutil/trace.go:171","msg":"trace[21362462] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"428.659235ms","start":"2026-07-22T22:09:23.609451Z","end":"2026-07-22T22:09:24.03811Z","steps":["trace[21362462] 'process raft request' (duration: 427.970689ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:24.038238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:23.722409Z","time spent":"315.821904ms","remote":"127.0.0.1:59382","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-07-22T22:09:24.038613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:23.609428Z","time spent":"428.912882ms","remote":"127.0.0.1:59478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036189,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-22T22:09:24.384098Z","caller":"traceutil/trace.go:171","msg":"trace[1467738107] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:607; }","duration":"247.382588ms","start":"2026-07-22T22:09:24.13668Z","end":"2026-07-22T22:09:24.384062Z","steps":["trace[1467738107] 'read index received' (duration: 218.604131ms)","trace[1467738107] 'applied index is now lower than readState.Index' (duration: 28.777127ms)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:09:24.384283Z","caller":"traceutil/trace.go:171","msg":"trace[823648950] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"276.128054ms","start":"2026-07-22T22:09:24.108138Z","end":"2026-07-22T22:09:24.384266Z","steps":["trace[823648950] 'process raft request' (duration: 275.818556ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:09:24.384412Z","caller":"traceutil/trace.go:171","msg":"trace[273436031] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"286.757471ms","start":"2026-07-22T22:09:24.09764Z","end":"2026-07-22T22:09:24.384398Z","steps":["trace[273436031] 'process raft request' (duration: 257.627306ms)","trace[273436031] 'compare' (duration: 28.314415ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:09:24.384576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.87604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-l6wsj\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-22T22:09:24.384635Z","caller":"traceutil/trace.go:171","msg":"trace[1072835559] range","detail":"{range_begin:/registry/pods/kube-system/cilium-l6wsj; range_end:; response_count:1; response_revision:587; }","duration":"247.978372ms","start":"2026-07-22T22:09:24.13664Z","end":"2026-07-22T22:09:24.384618Z","steps":["trace[1072835559] 'agreement among raft nodes before linearized reading' (duration: 247.87032ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:24.384644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.117514ms","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-07-22T22:09:24.384825Z","caller":"traceutil/trace.go:171","msg":"trace[38913408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:587; }","duration":"124.337769ms","start":"2026-07-22T22:09:24.260478Z","end":"2026-07-22T22:09:24.384815Z","steps":["trace[38913408] 'agreement among raft nodes before linearized reading' (duration: 124.088083ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:24.899456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.489978ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-07-22T22:09:24.900038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:24.386016Z","time spent":"514.017ms","remote":"127.0.0.1:59408","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-07-22T22:09:24.90017Z","caller":"traceutil/trace.go:171","msg":"trace[616942874] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"506.592971ms","start":"2026-07-22T22:09:24.393549Z","end":"2026-07-22T22:09:24.900142Z","steps":["trace[616942874] 'process raft request' (duration: 506.225282ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:24.900311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:24.393531Z","time spent":"506.694043ms","remote":"127.0.0.1:59652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-22T22:09:24.900298Z","caller":"traceutil/trace.go:171","msg":"trace[722435524] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:609; }","duration":"505.456654ms","start":"2026-07-22T22:09:24.394827Z","end":"2026-07-22T22:09:24.900284Z","steps":["trace[722435524] 'read index received' (duration: 91.142006ms)","trace[722435524] 'applied index is now lower than readState.Index' (duration: 414.313038ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:09:24.900505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.658708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:09:24.900669Z","caller":"traceutil/trace.go:171","msg":"trace[529020437] range","detail":"{range_begin:/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:589; }","duration":"505.72444ms","start":"2026-07-22T22:09:24.394806Z","end":"2026-07-22T22:09:24.90053Z","steps":["trace[529020437] 'agreement among raft nodes before linearized reading' (duration: 505.532745ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:24.900762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:24.394795Z","time spent":"505.900215ms","remote":"127.0.0.1:59726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" "} {"level":"warn","ts":"2026-07-22T22:09:24.900508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.698681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:09:24.900958Z","caller":"traceutil/trace.go:171","msg":"trace[1081042324] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"499.884759ms","start":"2026-07-22T22:09:24.401037Z","end":"2026-07-22T22:09:24.900921Z","steps":["trace[1081042324] 'process raft request' (duration: 498.997208ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:24.901023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:24.401021Z","time spent":"499.970861ms","remote":"127.0.0.1:59566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-22T22:09:24.900984Z","caller":"traceutil/trace.go:171","msg":"trace[222918329] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:589; }","duration":"178.220663ms","start":"2026-07-22T22:09:24.722755Z","end":"2026-07-22T22:09:24.900976Z","steps":["trace[222918329] 'agreement among raft nodes before linearized reading' (duration: 177.715441ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:09:25.976996Z","caller":"traceutil/trace.go:171","msg":"trace[1383636365] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:616; }","duration":"253.24391ms","start":"2026-07-22T22:09:25.723687Z","end":"2026-07-22T22:09:25.976931Z","steps":["trace[1383636365] 'read index received' (duration: 246.813754ms)","trace[1383636365] 'applied index is now lower than readState.Index' (duration: 6.429276ms)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:09:25.97706Z","caller":"traceutil/trace.go:171","msg":"trace[1877284755] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"666.184544ms","start":"2026-07-22T22:09:25.310842Z","end":"2026-07-22T22:09:25.977027Z","steps":["trace[1877284755] 'process raft request' (duration: 659.924763ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:25.977124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.420344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:09:25.977158Z","caller":"traceutil/trace.go:171","msg":"trace[926980480] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"253.512596ms","start":"2026-07-22T22:09:25.723635Z","end":"2026-07-22T22:09:25.977147Z","steps":["trace[926980480] 'agreement among raft nodes before linearized reading' (duration: 253.429424ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:09:25.977187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:09:25.310815Z","time spent":"666.305838ms","remote":"127.0.0.1:59478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036225,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-22T22:09:27.549748Z","caller":"traceutil/trace.go:171","msg":"trace[1400197984] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"150.331168ms","start":"2026-07-22T22:09:27.399392Z","end":"2026-07-22T22:09:27.549723Z","steps":["trace[1400197984] 'process raft request' (duration: 150.188605ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:09:27.559738Z","caller":"traceutil/trace.go:171","msg":"trace[1367254276] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"146.67595ms","start":"2026-07-22T22:09:27.413034Z","end":"2026-07-22T22:09:27.55971Z","steps":["trace[1367254276] 'process raft request' (duration: 146.052375ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:10:14.685713Z","caller":"traceutil/trace.go:171","msg":"trace[1105975609] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"168.934855ms","start":"2026-07-22T22:10:14.516745Z","end":"2026-07-22T22:10:14.68568Z","steps":["trace[1105975609] 'process raft request' (duration: 127.16674ms)","trace[1105975609] 'compare' (duration: 41.601451ms)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:10:41.454842Z","caller":"traceutil/trace.go:171","msg":"trace[957910129] linearizableReadLoop","detail":"{readStateIndex:1104; appliedIndex:1103; }","duration":"165.769057ms","start":"2026-07-22T22:10:41.289042Z","end":"2026-07-22T22:10:41.454811Z","steps":["trace[957910129] 'read index received' (duration: 165.531961ms)","trace[957910129] 'applied index is now lower than readState.Index' (duration: 236.046µs)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:10:41.455261Z","caller":"traceutil/trace.go:171","msg":"trace[779651729] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"173.862045ms","start":"2026-07-22T22:10:41.281371Z","end":"2026-07-22T22:10:41.455233Z","steps":["trace[779651729] 'process raft request' (duration: 173.23819ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:10:41.455355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.899595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:10:41.455439Z","caller":"traceutil/trace.go:171","msg":"trace[1528616078] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1063; }","duration":"155.994467ms","start":"2026-07-22T22:10:41.299404Z","end":"2026-07-22T22:10:41.455399Z","steps":["trace[1528616078] 'agreement among raft nodes before linearized reading' (duration: 155.877544ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:10:41.455696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.631418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-22T22:10:41.45606Z","caller":"traceutil/trace.go:171","msg":"trace[1495647749] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1063; }","duration":"166.905815ms","start":"2026-07-22T22:10:41.288999Z","end":"2026-07-22T22:10:41.455905Z","steps":["trace[1495647749] 'agreement among raft nodes before linearized reading' (duration: 166.190597ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:10:58.373051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"739.24881ms","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-07-22T22:10:58.373122Z","caller":"traceutil/trace.go:171","msg":"trace[843380449] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1168; }","duration":"739.364383ms","start":"2026-07-22T22:10:57.633736Z","end":"2026-07-22T22:10:58.373101Z","steps":["trace[843380449] 'range keys from in-memory index tree' (duration: 738.974863ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:10:58.373151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:10:57.633717Z","time spent":"739.427485ms","remote":"127.0.0.1:59652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-22T22:10:58.373128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.611846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-22T22:10:58.373168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"739.21864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-22T22:10:58.3744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.229884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-22T22:10:58.3745Z","caller":"traceutil/trace.go:171","msg":"trace[124359210] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1168; }","duration":"483.851594ms","start":"2026-07-22T22:10:57.890615Z","end":"2026-07-22T22:10:58.374466Z","steps":["trace[124359210] 'count revisions from in-memory index tree' (duration: 482.141122ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:10:58.374511Z","caller":"traceutil/trace.go:171","msg":"trace[115365898] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1168; }","duration":"740.195233ms","start":"2026-07-22T22:10:57.633911Z","end":"2026-07-22T22:10:58.374106Z","steps":["trace[115365898] 'range keys from in-memory index tree' (duration: 739.088266ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:10:58.37317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.07704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-07-22T22:10:58.374556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:10:57.890594Z","time spent":"483.945615ms","remote":"127.0.0.1:59566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":13,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"info","ts":"2026-07-22T22:10:58.374593Z","caller":"traceutil/trace.go:171","msg":"trace[23516229] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1168; }","duration":"686.531655ms","start":"2026-07-22T22:10:57.688043Z","end":"2026-07-22T22:10:58.374575Z","steps":["trace[23516229] 'range keys from in-memory index tree' (duration: 684.940277ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:10:58.374618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:10:57.688027Z","time spent":"686.580946ms","remote":"127.0.0.1:59652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-22T22:10:58.373215Z","caller":"traceutil/trace.go:171","msg":"trace[700446905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1168; }","duration":"736.730639ms","start":"2026-07-22T22:10:57.636464Z","end":"2026-07-22T22:10:58.373194Z","steps":["trace[700446905] 'range keys from in-memory index tree' (duration: 736.434952ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:10:58.374744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:10:57.636456Z","time spent":"738.261866ms","remote":"127.0.0.1:59652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-22T22:10:58.374006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.148701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-22T22:10:58.374933Z","caller":"traceutil/trace.go:171","msg":"trace[579125495] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1168; }","duration":"741.077144ms","start":"2026-07-22T22:10:57.633835Z","end":"2026-07-22T22:10:58.374913Z","steps":["trace[579125495] 'range keys from in-memory index tree' (duration: 740.07977ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:10:58.374982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:10:57.633831Z","time spent":"741.138346ms","remote":"127.0.0.1:59652","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-07-22T22:10:58.375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:10:57.633906Z","time spent":"740.634513ms","remote":"127.0.0.1:59652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-22T22:11:10.846394Z","caller":"traceutil/trace.go:171","msg":"trace[98714880] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"415.385257ms","start":"2026-07-22T22:11:10.430982Z","end":"2026-07-22T22:11:10.846367Z","steps":["trace[98714880] 'process raft request' (duration: 415.202673ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:11:10.846534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:11:10.430959Z","time spent":"415.50241ms","remote":"127.0.0.1:59652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-22T22:11:10.846732Z","caller":"traceutil/trace.go:171","msg":"trace[639138963] linearizableReadLoop","detail":"{readStateIndex:1258; appliedIndex:1257; }","duration":"409.912785ms","start":"2026-07-22T22:11:10.436784Z","end":"2026-07-22T22:11:10.846697Z","steps":["trace[639138963] 'read index received' (duration: 409.323581ms)","trace[639138963] 'applied index is now lower than readState.Index' (duration: 585.874µs)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:11:10.846967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.155311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-22T22:11:10.847036Z","caller":"traceutil/trace.go:171","msg":"trace[1610126707] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1209; }","duration":"410.280584ms","start":"2026-07-22T22:11:10.436739Z","end":"2026-07-22T22:11:10.84702Z","steps":["trace[1610126707] 'agreement among raft nodes before linearized reading' (duration: 410.072129ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:11:10.84704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.502645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-22T22:11:10.847069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:11:10.436717Z","time spent":"410.346515ms","remote":"127.0.0.1:59652","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-07-22T22:11:10.847079Z","caller":"traceutil/trace.go:171","msg":"trace[1879196629] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1209; }","duration":"409.561706ms","start":"2026-07-22T22:11:10.437506Z","end":"2026-07-22T22:11:10.847068Z","steps":["trace[1879196629] 'agreement among raft nodes before linearized reading' (duration: 409.374032ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:11:10.847127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:11:10.437484Z","time spent":"409.633748ms","remote":"127.0.0.1:59652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-22T22:11:10.847266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.870338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-22T22:11:10.847347Z","caller":"traceutil/trace.go:171","msg":"trace[571900609] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1209; }","duration":"227.005561ms","start":"2026-07-22T22:11:10.62032Z","end":"2026-07-22T22:11:10.847326Z","steps":["trace[571900609] 'agreement among raft nodes before linearized reading' (duration: 226.840347ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:11:10.847368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.934041ms","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-07-22T22:11:10.847397Z","caller":"traceutil/trace.go:171","msg":"trace[1517760515] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1209; }","duration":"408.972792ms","start":"2026-07-22T22:11:10.438415Z","end":"2026-07-22T22:11:10.847388Z","steps":["trace[1517760515] 'agreement among raft nodes before linearized reading' (duration: 408.90522ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:11:10.847424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.971471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-22T22:11:10.847427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:11:10.438408Z","time spent":"409.012313ms","remote":"127.0.0.1:59652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-22T22:11:10.847489Z","caller":"traceutil/trace.go:171","msg":"trace[1409854443] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1209; }","duration":"127.055844ms","start":"2026-07-22T22:11:10.720404Z","end":"2026-07-22T22:11:10.84746Z","steps":["trace[1409854443] 'agreement among raft nodes before linearized reading' (duration: 126.990812ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:11:10.847301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.309822ms","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-07-22T22:11:10.847599Z","caller":"traceutil/trace.go:171","msg":"trace[419275269] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1209; }","duration":"407.64075ms","start":"2026-07-22T22:11:10.439949Z","end":"2026-07-22T22:11:10.84759Z","steps":["trace[419275269] 'agreement among raft nodes before linearized reading' (duration: 407.283931ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:11:10.847635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:11:10.439931Z","time spent":"407.696431ms","remote":"127.0.0.1:59652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-22T22:11:19.433097Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890119903025423036,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-22T22:11:19.629115Z","caller":"traceutil/trace.go:171","msg":"trace[1725565490] linearizableReadLoop","detail":"{readStateIndex:1319; appliedIndex:1318; }","duration":"696.993118ms","start":"2026-07-22T22:11:18.932103Z","end":"2026-07-22T22:11:19.629096Z","steps":["trace[1725565490] 'read index received' (duration: 696.874655ms)","trace[1725565490] 'applied index is now lower than readState.Index' (duration: 117.793µs)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:11:19.629198Z","caller":"traceutil/trace.go:171","msg":"trace[179513729] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"715.450554ms","start":"2026-07-22T22:11:18.913733Z","end":"2026-07-22T22:11:19.629183Z","steps":["trace[179513729] 'process raft request' (duration: 715.221558ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:11:19.62927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.166212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-22T22:11:19.629283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:11:18.913716Z","time spent":"715.514416ms","remote":"127.0.0.1:59652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-22T22:11:19.629301Z","caller":"traceutil/trace.go:171","msg":"trace[542742099] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1269; }","duration":"697.222083ms","start":"2026-07-22T22:11:18.932072Z","end":"2026-07-22T22:11:19.629294Z","steps":["trace[542742099] 'agreement among raft nodes before linearized reading' (duration: 697.11778ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:11:19.629323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:11:18.932062Z","time spent":"697.255464ms","remote":"127.0.0.1:59652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-22T22:11:19.692395Z","caller":"traceutil/trace.go:171","msg":"trace[772730471] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"109.95542ms","start":"2026-07-22T22:11:19.582398Z","end":"2026-07-22T22:11:19.692354Z","steps":["trace[772730471] 'process raft request' (duration: 109.729825ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:11:19.756109Z","caller":"traceutil/trace.go:171","msg":"trace[247721647] linearizableReadLoop","detail":"{readStateIndex:1321; appliedIndex:1319; }","duration":"126.91719ms","start":"2026-07-22T22:11:19.629169Z","end":"2026-07-22T22:11:19.756086Z","steps":["trace[247721647] 'read index received' (duration: 62.939083ms)","trace[247721647] 'applied index is now lower than readState.Index' (duration: 63.977147ms)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:11:19.756396Z","caller":"traceutil/trace.go:171","msg":"trace[546682761] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"122.590315ms","start":"2026-07-22T22:11:19.633789Z","end":"2026-07-22T22:11:19.75638Z","steps":["trace[546682761] 'process raft request' (duration: 122.213336ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:11:19.842689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.68297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:11:19.842762Z","caller":"traceutil/trace.go:171","msg":"trace[592278031] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1271; }","duration":"118.840004ms","start":"2026-07-22T22:11:19.723903Z","end":"2026-07-22T22:11:19.842743Z","steps":["trace[592278031] 'agreement among raft nodes before linearized reading' (duration: 32.459555ms)","trace[592278031] 'range keys from in-memory index tree' (duration: 86.282487ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:11:19.843109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.664775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-22T22:11:19.843163Z","caller":"traceutil/trace.go:171","msg":"trace[65988268] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1271; }","duration":"714.757357ms","start":"2026-07-22T22:11:19.128389Z","end":"2026-07-22T22:11:19.843146Z","steps":["trace[65988268] 'agreement among raft nodes before linearized reading' (duration: 627.739012ms)","trace[65988268] 'count revisions from in-memory index tree' (duration: 86.937752ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:11:19.843212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:11:19.128363Z","time spent":"714.833679ms","remote":"127.0.0.1:36200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-22T22:11:19.843424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.942748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-22T22:11:19.843461Z","caller":"traceutil/trace.go:171","msg":"trace[1574646945] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1271; }","duration":"334.007168ms","start":"2026-07-22T22:11:19.50944Z","end":"2026-07-22T22:11:19.843447Z","steps":["trace[1574646945] 'agreement among raft nodes before linearized reading' (duration: 246.715577ms)","trace[1574646945] 'count revisions from in-memory index tree' (duration: 87.23961ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:11:19.843537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:11:19.509422Z","time spent":"334.103331ms","remote":"127.0.0.1:40832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-07-22T22:11:19.843802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.694987ms","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-07-22T22:11:19.843842Z","caller":"traceutil/trace.go:171","msg":"trace[385137694] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1271; }","duration":"829.747389ms","start":"2026-07-22T22:11:19.014083Z","end":"2026-07-22T22:11:19.84383Z","steps":["trace[385137694] 'agreement among raft nodes before linearized reading' (duration: 742.086138ms)","trace[385137694] 'range keys from in-memory index tree' (duration: 87.539478ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:11:19.84389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:11:19.014076Z","time spent":"829.80311ms","remote":"127.0.0.1:59652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-22T22:11:19.844108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"825.740531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-07-22T22:11:19.84415Z","caller":"traceutil/trace.go:171","msg":"trace[666949166] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1271; }","duration":"825.814003ms","start":"2026-07-22T22:11:19.018321Z","end":"2026-07-22T22:11:19.844135Z","steps":["trace[666949166] 'agreement among raft nodes before linearized reading' (duration: 737.855425ms)","trace[666949166] 'range keys from in-memory index tree' (duration: 87.860205ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:11:19.844191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:11:19.018302Z","time spent":"825.879365ms","remote":"127.0.0.1:59652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-22T22:11:19.84438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"836.126613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:11:19.844427Z","caller":"traceutil/trace.go:171","msg":"trace[1238254693] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1271; }","duration":"836.173224ms","start":"2026-07-22T22:11:19.008239Z","end":"2026-07-22T22:11:19.844412Z","steps":["trace[1238254693] 'agreement among raft nodes before linearized reading' (duration: 747.94193ms)","trace[1238254693] 'count revisions from in-memory index tree' (duration: 88.173482ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:11:19.84447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:11:19.0082Z","time spent":"836.257566ms","remote":"127.0.0.1:60932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-07-22T22:11:19.844686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"902.116149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-22T22:11:19.844718Z","caller":"traceutil/trace.go:171","msg":"trace[556823922] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1271; }","duration":"902.14633ms","start":"2026-07-22T22:11:18.94256Z","end":"2026-07-22T22:11:19.844707Z","steps":["trace[556823922] 'agreement among raft nodes before linearized reading' (duration: 813.631019ms)","trace[556823922] 'range keys from in-memory index tree' (duration: 88.434819ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:11:19.844749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:11:18.942466Z","time spent":"902.277013ms","remote":"127.0.0.1:59652","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-07-22T22:11:20.950616Z","caller":"traceutil/trace.go:171","msg":"trace[1297803464] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"647.693356ms","start":"2026-07-22T22:11:20.302898Z","end":"2026-07-22T22:11:20.950592Z","steps":["trace[1297803464] 'process raft request' (duration: 647.498221ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:11:20.950765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:11:20.302878Z","time spent":"647.804419ms","remote":"127.0.0.1:59550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6320,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-22T22:11:20.950913Z","caller":"traceutil/trace.go:171","msg":"trace[716905112] linearizableReadLoop","detail":"{readStateIndex:1328; appliedIndex:1328; }","duration":"331.11655ms","start":"2026-07-22T22:11:20.619786Z","end":"2026-07-22T22:11:20.950902Z","steps":["trace[716905112] 'read index received' (duration: 331.11037ms)","trace[716905112] 'applied index is now lower than readState.Index' (duration: 4.68µs)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:11:20.951033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.219462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:11:20.951121Z","caller":"traceutil/trace.go:171","msg":"trace[421604330] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1277; }","duration":"331.305674ms","start":"2026-07-22T22:11:20.619757Z","end":"2026-07-22T22:11:20.951062Z","steps":["trace[421604330] 'agreement among raft nodes before linearized reading' (duration: 331.215611ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:11:20.951175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:11:20.619725Z","time spent":"331.439337ms","remote":"127.0.0.1:36160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-07-22T22:11:21.93843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.334201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-22T22:11:21.938493Z","caller":"traceutil/trace.go:171","msg":"trace[931024550] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1279; }","duration":"304.447464ms","start":"2026-07-22T22:11:21.634029Z","end":"2026-07-22T22:11:21.938476Z","steps":["trace[931024550] 'range keys from in-memory index tree' (duration: 304.163497ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:11:21.938522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:11:21.633999Z","time spent":"304.515995ms","remote":"127.0.0.1:59652","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-07-22T22:11:21.938549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.781717ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-22T22:11:21.93863Z","caller":"traceutil/trace.go:171","msg":"trace[1181212512] linearizableReadLoop","detail":"{readStateIndex:1331; appliedIndex:1330; }","duration":"216.190649ms","start":"2026-07-22T22:11:21.722428Z","end":"2026-07-22T22:11:21.938618Z","steps":["trace[1181212512] 'read index received' (duration: 53.160246ms)","trace[1181212512] 'applied index is now lower than readState.Index' (duration: 163.029123ms)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:11:21.938673Z","caller":"traceutil/trace.go:171","msg":"trace[1274643247] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"241.01936ms","start":"2026-07-22T22:11:21.697645Z","end":"2026-07-22T22:11:21.938664Z","steps":["trace[1274643247] 'process raft request' (duration: 78.054558ms)","trace[1274643247] 'compare' (duration: 162.676955ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:11:21.938724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.303861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:11:21.938748Z","caller":"traceutil/trace.go:171","msg":"trace[28780713] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1280; }","duration":"216.356993ms","start":"2026-07-22T22:11:21.722383Z","end":"2026-07-22T22:11:21.93874Z","steps":["trace[28780713] 'agreement among raft nodes before linearized reading' (duration: 216.310952ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:11:21.938904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.843775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-22T22:11:21.93896Z","caller":"traceutil/trace.go:171","msg":"trace[696733257] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1280; }","duration":"178.940278ms","start":"2026-07-22T22:11:21.760005Z","end":"2026-07-22T22:11:21.938945Z","steps":["trace[696733257] 'agreement among raft nodes before linearized reading' (duration: 178.796114ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:11:22.058836Z","caller":"traceutil/trace.go:171","msg":"trace[172192812] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"114.323265ms","start":"2026-07-22T22:11:21.944483Z","end":"2026-07-22T22:11:22.058806Z","steps":["trace[172192812] 'process raft request' (duration: 113.996717ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:11:22.059346Z","caller":"traceutil/trace.go:171","msg":"trace[60832102] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"114.761086ms","start":"2026-07-22T22:11:21.944564Z","end":"2026-07-22T22:11:22.059325Z","steps":["trace[60832102] 'process raft request' (duration: 114.11758ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:11:22.059555Z","caller":"traceutil/trace.go:171","msg":"trace[2061310692] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"114.629063ms","start":"2026-07-22T22:11:21.944908Z","end":"2026-07-22T22:11:22.059537Z","steps":["trace[2061310692] 'process raft request' (duration: 113.858334ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:11:22.059655Z","caller":"traceutil/trace.go:171","msg":"trace[187901205] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"114.666914ms","start":"2026-07-22T22:11:21.944977Z","end":"2026-07-22T22:11:22.059644Z","steps":["trace[187901205] 'process raft request' (duration: 114.52127ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:11:22.329899Z","caller":"traceutil/trace.go:171","msg":"trace[198750467] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"155.527992ms","start":"2026-07-22T22:11:22.174331Z","end":"2026-07-22T22:11:22.329859Z","steps":["trace[198750467] 'process raft request' (duration: 94.608389ms)","trace[198750467] 'compare' (duration: 60.583385ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:11:26.788863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.242665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-07-22T22:11:26.788942Z","caller":"traceutil/trace.go:171","msg":"trace[1405532326] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1326; }","duration":"241.367848ms","start":"2026-07-22T22:11:26.54755Z","end":"2026-07-22T22:11:26.788918Z","steps":["trace[1405532326] 'range keys from in-memory index tree' (duration: 241.077201ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:11:27.46472Z","caller":"traceutil/trace.go:171","msg":"trace[1004904711] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"669.071174ms","start":"2026-07-22T22:11:26.795623Z","end":"2026-07-22T22:11:27.464695Z","steps":["trace[1004904711] 'process raft request' (duration: 668.897919ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:11:27.464858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:11:26.795606Z","time spent":"669.185856ms","remote":"127.0.0.1:59652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}