{"level":"warn","ts":"2026-07-30T23:42:10.975352Z","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-30T23:42:10.975435Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.89: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.89:2380","--initial-cluster=instance=https://199.204.45.89:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.89:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.89: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-30T23:42:10.975503Z","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-30T23:42:10.975512Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-07-30T23:42:10.97553Z","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-30T23:42:10.976135Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"]} {"level":"info","ts":"2026-07-30T23:42:10.976305Z","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.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.89: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-30T23:42:10.980058Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.512119ms"} {"level":"info","ts":"2026-07-30T23:42:10.997297Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c3b8446219deb8c1","cluster-id":"fe02a46d8aa9751f"} {"level":"info","ts":"2026-07-30T23:42:10.997382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=()"} {"level":"info","ts":"2026-07-30T23:42:10.997403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 0"} {"level":"info","ts":"2026-07-30T23:42:10.997415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c3b8446219deb8c1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-30T23:42:10.997423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 1"} {"level":"info","ts":"2026-07-30T23:42:10.997473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"warn","ts":"2026-07-30T23:42:11.008332Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-30T23:42:11.010214Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-30T23:42:11.012262Z","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-30T23:42:11.015778Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c3b8446219deb8c1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-30T23:42:11.016057Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c3b8446219deb8c1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-30T23:42:11.021176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"info","ts":"2026-07-30T23:42:11.021338Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","added-peer-id":"c3b8446219deb8c1","added-peer-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-07-30T23:42:11.019313Z","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-30T23:42:11.021446Z","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-30T23:42:11.021463Z","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-30T23:42:11.023368Z","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-30T23:42:11.023587Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c3b8446219deb8c1","initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-30T23:42:11.023619Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-30T23:42:11.024275Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-07-30T23:42:11.024312Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-07-30T23:42:11.797913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 is starting a new election at term 1"} {"level":"info","ts":"2026-07-30T23:42:11.797972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-30T23:42:11.797988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgPreVoteResp from c3b8446219deb8c1 at term 1"} {"level":"info","ts":"2026-07-30T23:42:11.798002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became candidate at term 2"} {"level":"info","ts":"2026-07-30T23:42:11.798016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgVoteResp from c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-07-30T23:42:11.798026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became leader at term 2"} {"level":"info","ts":"2026-07-30T23:42:11.798035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c3b8446219deb8c1 elected leader c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-07-30T23:42:11.799668Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c3b8446219deb8c1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.89:2379]}","request-path":"/0/members/c3b8446219deb8c1/attributes","cluster-id":"fe02a46d8aa9751f","publish-timeout":"7s"} {"level":"info","ts":"2026-07-30T23:42:11.800018Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T23:42:11.800189Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-30T23:42:11.800292Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-30T23:42:11.800743Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-30T23:42:11.800765Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-30T23:42:11.803521Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-30T23:42:11.804607Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.89:2379"} {"level":"info","ts":"2026-07-30T23:42:11.818935Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T23:42:11.822055Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T23:42:11.822241Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-07-30T23:42:13.317878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.919561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-30T23:42:13.318014Z","caller":"traceutil/trace.go:171","msg":"trace[1109616576] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:3; }","duration":"110.091147ms","start":"2026-07-30T23:42:13.207897Z","end":"2026-07-30T23:42:13.317988Z","steps":["trace[1109616576] 'range keys from in-memory index tree' (duration: 109.84755ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:13.318177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.314383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-30T23:42:13.318214Z","caller":"traceutil/trace.go:171","msg":"trace[2079270861] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:3; }","duration":"110.373294ms","start":"2026-07-30T23:42:13.20783Z","end":"2026-07-30T23:42:13.318204Z","steps":["trace[2079270861] 'range keys from in-memory index tree' (duration: 110.258441ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:13.318283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.424315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-30T23:42:13.318437Z","caller":"traceutil/trace.go:171","msg":"trace[65049366] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:3; }","duration":"110.649521ms","start":"2026-07-30T23:42:13.207753Z","end":"2026-07-30T23:42:13.318402Z","steps":["trace[65049366] 'range keys from in-memory index tree' (duration: 110.333314ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:14.83962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.14979243s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-30T23:42:14.840069Z","caller":"traceutil/trace.go:171","msg":"trace[997145762] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:7; }","duration":"1.521629776s","start":"2026-07-30T23:42:13.318417Z","end":"2026-07-30T23:42:14.840047Z","steps":["trace[997145762] 'read index received' (duration: 370.769908ms)","trace[997145762] 'applied index is now lower than readState.Index' (duration: 1.150858638s)"],"step_count":2} {"level":"info","ts":"2026-07-30T23:42:14.840149Z","caller":"traceutil/trace.go:171","msg":"trace[895079489] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.602546841s","start":"2026-07-30T23:42:13.237529Z","end":"2026-07-30T23:42:14.840076Z","steps":["trace[895079489] 'process raft request' (duration: 1.602446019s)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:42:14.840192Z","caller":"traceutil/trace.go:171","msg":"trace[1966083030] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"1.608356588s","start":"2026-07-30T23:42:13.231798Z","end":"2026-07-30T23:42:14.840155Z","steps":["trace[1966083030] 'process raft request' (duration: 1.608097851s)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:42:14.840199Z","caller":"traceutil/trace.go:171","msg":"trace[205903211] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"1.607798814s","start":"2026-07-30T23:42:13.23232Z","end":"2026-07-30T23:42:14.840119Z","steps":["trace[205903211] 'process raft request' (duration: 1.607629559s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:14.840348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:13.237509Z","time spent":"1.602745896s","remote":"127.0.0.1:60812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T23:42:14.840363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:13.231791Z","time spent":"1.608496152s","remote":"127.0.0.1:32952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T23:42:14.84054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.610036894s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-30T23:42:14.840553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.558743352s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-30T23:42:14.84062Z","caller":"traceutil/trace.go:171","msg":"trace[1066625482] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"1.610162867s","start":"2026-07-30T23:42:13.230443Z","end":"2026-07-30T23:42:14.840606Z","steps":["trace[1066625482] 'agreement among raft nodes before linearized reading' (duration: 1.610008353s)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:42:14.840713Z","caller":"traceutil/trace.go:171","msg":"trace[786236954] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"1.601363989s","start":"2026-07-30T23:42:13.239333Z","end":"2026-07-30T23:42:14.840697Z","steps":["trace[786236954] 'process raft request' (duration: 1.600678481s)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:42:14.84064Z","caller":"traceutil/trace.go:171","msg":"trace[497112280] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"1.608505373s","start":"2026-07-30T23:42:13.231629Z","end":"2026-07-30T23:42:14.840134Z","steps":["trace[497112280] 'process raft request' (duration: 457.326486ms)","trace[497112280] 'compare' (duration: 1.149634926s)"],"step_count":2} {"level":"warn","ts":"2026-07-30T23:42:14.841054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:13.231608Z","time spent":"1.609391646s","remote":"127.0.0.1:32952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T23:42:14.840662Z","caller":"traceutil/trace.go:171","msg":"trace[964080883] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.558863426s","start":"2026-07-30T23:42:13.281768Z","end":"2026-07-30T23:42:14.840632Z","steps":["trace[964080883] 'agreement among raft nodes before linearized reading' (duration: 1.558734393s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:14.841179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:13.281758Z","time spent":"1.559374429s","remote":"127.0.0.1:60756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-30T23:42:14.840716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:13.230416Z","time spent":"1.610288511s","remote":"127.0.0.1:32798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":28,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-07-30T23:42:14.840494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:13.232282Z","time spent":"1.608126732s","remote":"127.0.0.1:32952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T23:42:14.840801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:13.239324Z","time spent":"1.60142966s","remote":"127.0.0.1:60876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T23:42:14.840101Z","caller":"traceutil/trace.go:171","msg":"trace[1926232424] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"1.607946388s","start":"2026-07-30T23:42:13.2321Z","end":"2026-07-30T23:42:14.840046Z","steps":["trace[1926232424] 'process raft request' (duration: 1.607826023s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:14.841654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:13.23209Z","time spent":"1.609500409s","remote":"127.0.0.1:32952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T23:42:14.840403Z","caller":"traceutil/trace.go:171","msg":"trace[2046205704] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"1.608312168s","start":"2026-07-30T23:42:13.231738Z","end":"2026-07-30T23:42:14.84005Z","steps":["trace[2046205704] 'process raft request' (duration: 1.608106991s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:14.842029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:13.231729Z","time spent":"1.610249779s","remote":"127.0.0.1:32952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T23:42:15.174659Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.485546694s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-30T23:42:15.32086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999471638s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-30T23:42:15.320986Z","caller":"traceutil/trace.go:171","msg":"trace[315534901] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999673914s","start":"2026-07-30T23:42:13.321282Z","end":"2026-07-30T23:42:15.320956Z","steps":["trace[315534901] 'agreement among raft nodes before linearized reading' (duration: 1.99952149s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:15.321049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:13.321258Z","time spent":"1.999780036s","remote":"127.0.0.1:60630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/30 23:42:15 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-30T23:42:16.459506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999939713s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-30T23:42:16.459601Z","caller":"traceutil/trace.go:171","msg":"trace[413865808] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000118288s","start":"2026-07-30T23:42:14.459458Z","end":"2026-07-30T23:42:16.459576Z","steps":["trace[413865808] 'agreement among raft nodes before linearized reading' (duration: 1.999978044s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:16.459656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:14.459428Z","time spent":"2.00021787s","remote":"127.0.0.1:60618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/30 23:42:16 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-30T23:42:16.911589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.73642782s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-30T23:42:16.911925Z","caller":"traceutil/trace.go:171","msg":"trace[1378421215] linearizableReadLoop","detail":"{readStateIndex:17; appliedIndex:14; }","duration":"2.071739043s","start":"2026-07-30T23:42:14.84015Z","end":"2026-07-30T23:42:16.911889Z","steps":["trace[1378421215] 'read index received' (duration: 334.81158ms)","trace[1378421215] 'applied index is now lower than readState.Index' (duration: 1.736924293s)"],"step_count":2} {"level":"info","ts":"2026-07-30T23:42:16.91203Z","caller":"traceutil/trace.go:171","msg":"trace[82701992] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"3.589944936s","start":"2026-07-30T23:42:13.32204Z","end":"2026-07-30T23:42:16.911985Z","steps":["trace[82701992] 'process raft request' (duration: 3.589665649s)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:42:16.912013Z","caller":"traceutil/trace.go:171","msg":"trace[244077921] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"2.064480728s","start":"2026-07-30T23:42:14.847452Z","end":"2026-07-30T23:42:16.911933Z","steps":["trace[244077921] 'process raft request' (duration: 2.064351015s)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:42:16.912138Z","caller":"traceutil/trace.go:171","msg":"trace[123886350] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"2.061595701s","start":"2026-07-30T23:42:14.850533Z","end":"2026-07-30T23:42:16.912129Z","steps":["trace[123886350] 'process raft request' (duration: 2.061416086s)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:42:16.912163Z","caller":"traceutil/trace.go:171","msg":"trace[1714869853] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"2.064589812s","start":"2026-07-30T23:42:14.847565Z","end":"2026-07-30T23:42:16.912155Z","steps":["trace[1714869853] 'process raft request' (duration: 2.064296333s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:16.912218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:14.850522Z","time spent":"2.061663853s","remote":"127.0.0.1:32952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T23:42:16.912264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:14.847539Z","time spent":"2.064660944s","remote":"127.0.0.1:32952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T23:42:16.912277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:14.84742Z","time spent":"2.064746006s","remote":"127.0.0.1:32952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T23:42:16.912124Z","caller":"traceutil/trace.go:171","msg":"trace[45748556] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"2.064453788s","start":"2026-07-30T23:42:14.84766Z","end":"2026-07-30T23:42:16.912113Z","steps":["trace[45748556] 'process raft request' (duration: 2.064260173s)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:42:16.912481Z","caller":"traceutil/trace.go:171","msg":"trace[536363334] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"2.064837628s","start":"2026-07-30T23:42:14.847631Z","end":"2026-07-30T23:42:16.912469Z","steps":["trace[536363334] 'process raft request' (duration: 2.064261402s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:16.91248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:14.847632Z","time spent":"2.064769296s","remote":"127.0.0.1:32952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T23:42:16.912537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:14.847617Z","time spent":"2.06489434s","remote":"127.0.0.1:32952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T23:42:16.911926Z","caller":"traceutil/trace.go:171","msg":"trace[1247433170] transaction","detail":"{read_only:false; number_of_response:0; response_revision:13; }","duration":"3.588475246s","start":"2026-07-30T23:42:13.323413Z","end":"2026-07-30T23:42:16.911888Z","steps":["trace[1247433170] 'process raft request' (duration: 3.588353393s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:16.912687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.781909154s","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-30T23:42:16.912715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.065305251s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-wqcpn\" ","response":"range_response_count:1 size:861"} {"level":"warn","ts":"2026-07-30T23:42:16.912695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:13.323368Z","time spent":"3.589294479s","remote":"127.0.0.1:60756","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T23:42:16.912737Z","caller":"traceutil/trace.go:171","msg":"trace[1177114892] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:19; }","duration":"2.782008336s","start":"2026-07-30T23:42:14.130711Z","end":"2026-07-30T23:42:16.912719Z","steps":["trace[1177114892] 'agreement among raft nodes before linearized reading' (duration: 2.781922504s)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:42:16.912755Z","caller":"traceutil/trace.go:171","msg":"trace[935972764] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-wqcpn; range_end:; response_count:1; response_revision:19; }","duration":"2.065416483s","start":"2026-07-30T23:42:14.847326Z","end":"2026-07-30T23:42:16.912743Z","steps":["trace[935972764] 'agreement among raft nodes before linearized reading' (duration: 2.065343111s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:16.912776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:14.130683Z","time spent":"2.782086528s","remote":"127.0.0.1:60998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-07-30T23:42:16.912778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:13.322031Z","time spent":"3.590146072s","remote":"127.0.0.1:32842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T23:42:16.912911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.489441738s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-30T23:42:16.912962Z","caller":"traceutil/trace.go:171","msg":"trace[368972545] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19; }","duration":"1.489490739s","start":"2026-07-30T23:42:15.423441Z","end":"2026-07-30T23:42:16.912932Z","steps":["trace[368972545] 'agreement among raft nodes before linearized reading' (duration: 1.489426827s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:16.912993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:15.42343Z","time spent":"1.489558001s","remote":"127.0.0.1:60630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-30T23:42:16.912087Z","caller":"traceutil/trace.go:171","msg":"trace[543395031] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"2.056109273s","start":"2026-07-30T23:42:14.855955Z","end":"2026-07-30T23:42:16.912064Z","steps":["trace[543395031] 'process raft request' (duration: 2.056029471s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:16.912883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.779806588s","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-30T23:42:16.913111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.388348937s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-30T23:42:16.913172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.065671669s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3490"} {"level":"info","ts":"2026-07-30T23:42:16.913213Z","caller":"traceutil/trace.go:171","msg":"trace[1490178469] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:19; }","duration":"2.065797062s","start":"2026-07-30T23:42:14.847406Z","end":"2026-07-30T23:42:16.913203Z","steps":["trace[1490178469] 'agreement among raft nodes before linearized reading' (duration: 2.065729991s)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:42:16.912002Z","caller":"traceutil/trace.go:171","msg":"trace[362248696] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"3.590174762s","start":"2026-07-30T23:42:13.321793Z","end":"2026-07-30T23:42:16.911968Z","steps":["trace[362248696] 'process raft request' (duration: 1.85327646s)","trace[362248696] 'compare' (duration: 1.736179104s)"],"step_count":2} {"level":"warn","ts":"2026-07-30T23:42:16.913222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.606473362s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-30T23:42:16.913266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:14.847304Z","time spent":"2.065955077s","remote":"127.0.0.1:60812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3514,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-07-30T23:42:16.913265Z","caller":"traceutil/trace.go:171","msg":"trace[1930009083] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:19; }","duration":"1.606558004s","start":"2026-07-30T23:42:15.306697Z","end":"2026-07-30T23:42:16.913255Z","steps":["trace[1930009083] 'agreement among raft nodes before linearized reading' (duration: 1.606498862s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:16.913281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:14.855917Z","time spent":"2.05710962s","remote":"127.0.0.1:60812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3478,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T23:42:16.913306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:15.306674Z","time spent":"1.606623696s","remote":"127.0.0.1:60756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-07-30T23:42:16.91285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.552827ms","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-30T23:42:16.913345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:13.321764Z","time spent":"3.591545438s","remote":"127.0.0.1:60756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T23:42:16.913399Z","caller":"traceutil/trace.go:171","msg":"trace[1768358602] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"335.135333ms","start":"2026-07-30T23:42:16.578251Z","end":"2026-07-30T23:42:16.913387Z","steps":["trace[1768358602] 'agreement among raft nodes before linearized reading' (duration: 334.569149ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:16.912797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:14.847305Z","time spent":"2.065485615s","remote":"127.0.0.1:60876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":885,"request content":"key:\"/registry/certificatesigningrequests/csr-wqcpn\" "} {"level":"info","ts":"2026-07-30T23:42:16.913211Z","caller":"traceutil/trace.go:171","msg":"trace[1624483314] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:19; }","duration":"3.38851638s","start":"2026-07-30T23:42:13.524641Z","end":"2026-07-30T23:42:16.913157Z","steps":["trace[1624483314] 'agreement among raft nodes before linearized reading' (duration: 3.388329476s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:16.913677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:13.52461Z","time spent":"3.389047555s","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-07-30T23:42:16.913172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.008881006s","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-30T23:42:16.913757Z","caller":"traceutil/trace.go:171","msg":"trace[831717251] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"2.009485263s","start":"2026-07-30T23:42:14.904253Z","end":"2026-07-30T23:42:16.913738Z","steps":["trace[831717251] 'agreement among raft nodes before linearized reading' (duration: 2.008872676s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:16.913801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:14.904237Z","time spent":"2.009553715s","remote":"127.0.0.1:60756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-30T23:42:16.913433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:16.578223Z","time spent":"335.200844ms","remote":"127.0.0.1:60756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-07-30T23:42:16.913351Z","caller":"traceutil/trace.go:171","msg":"trace[1908828894] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:19; }","duration":"2.780489046s","start":"2026-07-30T23:42:14.132647Z","end":"2026-07-30T23:42:16.913136Z","steps":["trace[1908828894] 'agreement among raft nodes before linearized reading' (duration: 2.779809768s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:16.914035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:14.132618Z","time spent":"2.781408699s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"info","ts":"2026-07-30T23:42:51.744863Z","caller":"traceutil/trace.go:171","msg":"trace[1752298728] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:537; }","duration":"365.062378ms","start":"2026-07-30T23:42:51.379767Z","end":"2026-07-30T23:42:51.74483Z","steps":["trace[1752298728] 'read index received' (duration: 364.855314ms)","trace[1752298728] 'applied index is now lower than readState.Index' (duration: 205.204µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T23:42:51.745001Z","caller":"traceutil/trace.go:171","msg":"trace[185517075] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"410.752761ms","start":"2026-07-30T23:42:51.334197Z","end":"2026-07-30T23:42:51.74495Z","steps":["trace[185517075] 'process raft request' (duration: 410.426625ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:51.745095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.278363ms","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-30T23:42:51.745148Z","caller":"traceutil/trace.go:171","msg":"trace[307973773] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:523; }","duration":"365.404885ms","start":"2026-07-30T23:42:51.37973Z","end":"2026-07-30T23:42:51.745135Z","steps":["trace[307973773] 'agreement among raft nodes before linearized reading' (duration: 365.263222ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:51.745207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:51.379703Z","time spent":"365.494067ms","remote":"127.0.0.1:60892","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-30T23:42:51.745233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:51.334162Z","time spent":"410.946674ms","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T23:42:52.245462Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313097574969522570,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-30T23:42:52.459879Z","caller":"traceutil/trace.go:171","msg":"trace[1996988933] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"948.283681ms","start":"2026-07-30T23:42:51.511556Z","end":"2026-07-30T23:42:52.45984Z","steps":["trace[1996988933] 'process raft request' (duration: 947.847303ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:52.460048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:51.511529Z","time spent":"948.438944ms","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T23:42:52.460185Z","caller":"traceutil/trace.go:171","msg":"trace[184866676] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"932.642234ms","start":"2026-07-30T23:42:51.527508Z","end":"2026-07-30T23:42:52.46015Z","steps":["trace[184866676] 'process raft request' (duration: 932.301018ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:42:52.460314Z","caller":"traceutil/trace.go:171","msg":"trace[518058379] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"926.774535ms","start":"2026-07-30T23:42:51.533523Z","end":"2026-07-30T23:42:52.460297Z","steps":["trace[518058379] 'process raft request' (duration: 926.416558ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:52.460334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:51.527498Z","time spent":"932.762157ms","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T23:42:52.46037Z","caller":"traceutil/trace.go:171","msg":"trace[1372557388] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"943.665537ms","start":"2026-07-30T23:42:51.516689Z","end":"2026-07-30T23:42:52.460355Z","steps":["trace[1372557388] 'process raft request' (duration: 943.022045ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:52.4604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:51.533516Z","time spent":"926.858878ms","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T23:42:52.460434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:51.51665Z","time spent":"943.753618ms","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T23:42:52.460474Z","caller":"traceutil/trace.go:171","msg":"trace[1238651442] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"942.947434ms","start":"2026-07-30T23:42:51.517519Z","end":"2026-07-30T23:42:52.460467Z","steps":["trace[1238651442] 'process raft request' (duration: 942.238331ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:52.460509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:51.517512Z","time spent":"942.978285ms","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T23:42:52.460525Z","caller":"traceutil/trace.go:171","msg":"trace[1845771690] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"927.758944ms","start":"2026-07-30T23:42:51.532749Z","end":"2026-07-30T23:42:52.460508Z","steps":["trace[1845771690] 'process raft request' (duration: 927.105781ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:52.46061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:51.532722Z","time spent":"927.835206ms","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T23:42:52.460648Z","caller":"traceutil/trace.go:171","msg":"trace[798657720] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"925.630594ms","start":"2026-07-30T23:42:51.535013Z","end":"2026-07-30T23:42:52.460644Z","steps":["trace[798657720] 'process raft request' (duration: 925.032353ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:42:52.460649Z","caller":"traceutil/trace.go:171","msg":"trace[838515903] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"914.256705ms","start":"2026-07-30T23:42:51.546383Z","end":"2026-07-30T23:42:52.46064Z","steps":["trace[838515903] 'process raft request' (duration: 913.848918ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:52.460679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:51.534989Z","time spent":"925.679486ms","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T23:42:52.46069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:51.546373Z","time spent":"914.297396ms","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T23:42:52.460736Z","caller":"traceutil/trace.go:171","msg":"trace[1336015431] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"913.95836ms","start":"2026-07-30T23:42:51.546766Z","end":"2026-07-30T23:42:52.460724Z","steps":["trace[1336015431] 'process raft request' (duration: 913.621804ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:42:52.460622Z","caller":"traceutil/trace.go:171","msg":"trace[1044438991] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"920.974999ms","start":"2026-07-30T23:42:51.53964Z","end":"2026-07-30T23:42:52.460615Z","steps":["trace[1044438991] 'process raft request' (duration: 920.479129ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:52.460761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:51.546723Z","time spent":"914.027801ms","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T23:42:52.460772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:51.539622Z","time spent":"921.132321ms","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T23:42:52.460989Z","caller":"traceutil/trace.go:171","msg":"trace[115087434] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"873.360892ms","start":"2026-07-30T23:42:51.587595Z","end":"2026-07-30T23:42:52.460955Z","steps":["trace[115087434] 'process raft request' (duration: 872.961075ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:42:52.461014Z","caller":"traceutil/trace.go:171","msg":"trace[1009921638] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"743.771402ms","start":"2026-07-30T23:42:51.717209Z","end":"2026-07-30T23:42:52.46098Z","steps":["trace[1009921638] 'process raft request' (duration: 743.6293ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:52.461089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:51.587562Z","time spent":"873.489513ms","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T23:42:52.461188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:51.717171Z","time spent":"743.934315ms","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T23:42:52.469169Z","caller":"traceutil/trace.go:171","msg":"trace[1016697425] linearizableReadLoop","detail":"{readStateIndex:551; appliedIndex:538; }","duration":"724.18895ms","start":"2026-07-30T23:42:51.744956Z","end":"2026-07-30T23:42:52.469145Z","steps":["trace[1016697425] 'read index received' (duration: 714.553063ms)","trace[1016697425] 'applied index is now lower than readState.Index' (duration: 9.635267ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T23:42:52.469513Z","caller":"traceutil/trace.go:171","msg":"trace[1360056135] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"719.2727ms","start":"2026-07-30T23:42:51.750233Z","end":"2026-07-30T23:42:52.469505Z","steps":["trace[1360056135] 'process raft request' (duration: 718.787651ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:52.469648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:51.75021Z","time spent":"719.33116ms","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T23:42:52.469663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"686.487075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T23:42:52.469787Z","caller":"traceutil/trace.go:171","msg":"trace[1674381579] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:536; }","duration":"686.617968ms","start":"2026-07-30T23:42:51.783096Z","end":"2026-07-30T23:42:52.469714Z","steps":["trace[1674381579] 'agreement among raft nodes before linearized reading' (duration: 686.505886ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:52.469831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:51.78308Z","time spent":"686.742619ms","remote":"127.0.0.1:60618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-30T23:42:52.470009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"894.793975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-30T23:42:52.47004Z","caller":"traceutil/trace.go:171","msg":"trace[143900241] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:536; }","duration":"894.885837ms","start":"2026-07-30T23:42:51.575147Z","end":"2026-07-30T23:42:52.470033Z","steps":["trace[143900241] 'agreement among raft nodes before linearized reading' (duration: 894.831875ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:52.471707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:51.575098Z","time spent":"896.601578ms","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-30T23:42:52.904131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.347897ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T23:42:52.90425Z","caller":"traceutil/trace.go:171","msg":"trace[874409722] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"289.269214ms","start":"2026-07-30T23:42:52.614959Z","end":"2026-07-30T23:42:52.904228Z","steps":["trace[874409722] 'process raft request' (duration: 173.725183ms)","trace[874409722] 'compare' (duration: 115.179193ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T23:42:52.954621Z","caller":"traceutil/trace.go:171","msg":"trace[1296476472] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"338.178857ms","start":"2026-07-30T23:42:52.616405Z","end":"2026-07-30T23:42:52.954584Z","steps":["trace[1296476472] 'process raft request' (duration: 337.83472ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:52.954821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:52.616397Z","time spent":"338.31138ms","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29461,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T23:42:52.955182Z","caller":"traceutil/trace.go:171","msg":"trace[1745211541] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"337.252981ms","start":"2026-07-30T23:42:52.617906Z","end":"2026-07-30T23:42:52.955159Z","steps":["trace[1745211541] 'process raft request' (duration: 336.594399ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:52.955338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:52.6179Z","time spent":"337.347182ms","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29546,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T23:42:52.955545Z","caller":"traceutil/trace.go:171","msg":"trace[542935668] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"314.050786ms","start":"2026-07-30T23:42:52.64148Z","end":"2026-07-30T23:42:52.955531Z","steps":["trace[542935668] 'process raft request' (duration: 313.443445ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:52.955619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:52.641465Z","time spent":"314.124187ms","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T23:42:53.289179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.857964ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T23:42:53.298197Z","caller":"traceutil/trace.go:171","msg":"trace[154245434] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"329.748685ms","start":"2026-07-30T23:42:52.968382Z","end":"2026-07-30T23:42:53.298131Z","steps":["trace[154245434] 'process raft request' (duration: 113.857048ms)","trace[154245434] 'compare' (duration: 206.700981ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T23:42:53.29829Z","caller":"traceutil/trace.go:171","msg":"trace[624022065] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"289.223696ms","start":"2026-07-30T23:42:53.009048Z","end":"2026-07-30T23:42:53.298272Z","steps":["trace[624022065] 'process raft request' (duration: 280.396126ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:53.298379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:52.96836Z","time spent":"329.932758ms","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31102,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T23:42:53.298479Z","caller":"traceutil/trace.go:171","msg":"trace[1319754870] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"323.786405ms","start":"2026-07-30T23:42:52.974681Z","end":"2026-07-30T23:42:53.298468Z","steps":["trace[1319754870] 'process raft request' (duration: 314.63572ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:53.298541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:52.974672Z","time spent":"323.836406ms","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T23:42:54.699147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.409565954s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-07-30T23:42:54.699316Z","caller":"traceutil/trace.go:171","msg":"trace[78574324] linearizableReadLoop","detail":"{readStateIndex:585; appliedIndex:581; }","duration":"1.54024371s","start":"2026-07-30T23:42:53.159013Z","end":"2026-07-30T23:42:54.699257Z","steps":["trace[78574324] 'read index received' (duration: 17.587668ms)","trace[78574324] 'applied index is now lower than readState.Index' (duration: 1.522654362s)"],"step_count":2} {"level":"warn","ts":"2026-07-30T23:42:54.699463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.540437423s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-30T23:42:54.69953Z","caller":"traceutil/trace.go:171","msg":"trace[637142588] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:564; }","duration":"1.540565285s","start":"2026-07-30T23:42:53.158948Z","end":"2026-07-30T23:42:54.699513Z","steps":["trace[637142588] 'agreement among raft nodes before linearized reading' (duration: 1.540413563s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:54.699562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:53.158919Z","time spent":"1.540637156s","remote":"127.0.0.1:60892","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-30T23:42:54.700487Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.368289038s","expected-duration":"1s"} {"level":"info","ts":"2026-07-30T23:42:54.700949Z","caller":"traceutil/trace.go:171","msg":"trace[1990500319] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"1.368885367s","start":"2026-07-30T23:42:53.332041Z","end":"2026-07-30T23:42:54.700926Z","steps":["trace[1990500319] 'process raft request' (duration: 1.368693044s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:54.701092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:53.332011Z","time spent":"1.36900082s","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31121,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T23:42:54.709731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.229387831s","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-30T23:42:54.709769Z","caller":"traceutil/trace.go:171","msg":"trace[713133768] 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:567; }","duration":"1.229431831s","start":"2026-07-30T23:42:53.480328Z","end":"2026-07-30T23:42:54.70976Z","steps":["trace[713133768] 'agreement among raft nodes before linearized reading' (duration: 1.2293624s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:54.709787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:53.480303Z","time spent":"1.229479162s","remote":"127.0.0.1:55440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-30T23:42:54.7098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.204724984s","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":"warn","ts":"2026-07-30T23:42:54.709813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.139644796s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T23:42:54.709838Z","caller":"traceutil/trace.go:171","msg":"trace[566600859] 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:567; }","duration":"1.204808995s","start":"2026-07-30T23:42:53.505018Z","end":"2026-07-30T23:42:54.709827Z","steps":["trace[566600859] 'agreement among raft nodes before linearized reading' (duration: 1.204731063s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:54.70987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:53.504997Z","time spent":"1.204866756s","remote":"127.0.0.1:55446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-07-30T23:42:54.709854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.140831057s","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-30T23:42:54.709883Z","caller":"traceutil/trace.go:171","msg":"trace[1671846143] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:567; }","duration":"1.139738727s","start":"2026-07-30T23:42:53.57012Z","end":"2026-07-30T23:42:54.709859Z","steps":["trace[1671846143] 'agreement among raft nodes before linearized reading' (duration: 1.139595305s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:54.709917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.205000548s","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-30T23:42:54.709934Z","caller":"traceutil/trace.go:171","msg":"trace[219275543] 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:567; }","duration":"1.205025518s","start":"2026-07-30T23:42:53.504903Z","end":"2026-07-30T23:42:54.709929Z","steps":["trace[219275543] 'agreement among raft nodes before linearized reading' (duration: 1.205003988s)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:42:54.709922Z","caller":"traceutil/trace.go:171","msg":"trace[700228808] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:567; }","duration":"1.140936929s","start":"2026-07-30T23:42:53.56897Z","end":"2026-07-30T23:42:54.709907Z","steps":["trace[700228808] 'agreement among raft nodes before linearized reading' (duration: 1.140804547s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:54.709947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:53.504897Z","time spent":"1.20504663s","remote":"127.0.0.1:55446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-07-30T23:42:54.709894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.204924677s","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":"warn","ts":"2026-07-30T23:42:54.709962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:53.568958Z","time spent":"1.140995371s","remote":"127.0.0.1:55456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-07-30T23:42:54.70997Z","caller":"traceutil/trace.go:171","msg":"trace[1417691476] 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:567; }","duration":"1.204998118s","start":"2026-07-30T23:42:53.504964Z","end":"2026-07-30T23:42:54.709962Z","steps":["trace[1417691476] 'agreement among raft nodes before linearized reading' (duration: 1.204914387s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:54.709985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.229241668s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-30T23:42:54.709992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:53.504961Z","time spent":"1.205025498s","remote":"127.0.0.1:55446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"info","ts":"2026-07-30T23:42:54.710003Z","caller":"traceutil/trace.go:171","msg":"trace[1352602588] 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:567; }","duration":"1.229295699s","start":"2026-07-30T23:42:53.480703Z","end":"2026-07-30T23:42:54.709999Z","steps":["trace[1352602588] 'agreement among raft nodes before linearized reading' (duration: 1.229273008s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:54.710017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:53.480693Z","time spent":"1.229320149s","remote":"127.0.0.1:55440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-07-30T23:42:54.710079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.229663625s","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":"warn","ts":"2026-07-30T23:42:54.710081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.167075602s","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-30T23:42:54.710091Z","caller":"traceutil/trace.go:171","msg":"trace[391176389] 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:567; }","duration":"1.229677165s","start":"2026-07-30T23:42:53.48041Z","end":"2026-07-30T23:42:54.710087Z","steps":["trace[391176389] 'agreement among raft nodes before linearized reading' (duration: 1.229656275s)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:42:54.710101Z","caller":"traceutil/trace.go:171","msg":"trace[671984255] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:567; }","duration":"1.167148563s","start":"2026-07-30T23:42:53.542946Z","end":"2026-07-30T23:42:54.710095Z","steps":["trace[671984255] 'agreement among raft nodes before linearized reading' (duration: 1.167113663s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:54.710107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:53.480377Z","time spent":"1.229726396s","remote":"127.0.0.1:55440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-07-30T23:42:54.710118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:53.54292Z","time spent":"1.167193374s","remote":"127.0.0.1:55452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-07-30T23:42:54.709936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:53.570105Z","time spent":"1.139821379s","remote":"127.0.0.1:55452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"info","ts":"2026-07-30T23:42:54.71019Z","caller":"traceutil/trace.go:171","msg":"trace[808042763] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"1.374800322s","start":"2026-07-30T23:42:53.33538Z","end":"2026-07-30T23:42:54.710181Z","steps":["trace[808042763] 'process raft request' (duration: 1.374153171s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:54.710205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.167398757s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T23:42:54.710224Z","caller":"traceutil/trace.go:171","msg":"trace[1026591388] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:567; }","duration":"1.167452058s","start":"2026-07-30T23:42:53.542765Z","end":"2026-07-30T23:42:54.710217Z","steps":["trace[1026591388] 'agreement among raft nodes before linearized reading' (duration: 1.167422588s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:54.710242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:53.542747Z","time spent":"1.167491009s","remote":"127.0.0.1:55452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-30T23:42:54.710151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.141123473s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T23:42:54.710262Z","caller":"traceutil/trace.go:171","msg":"trace[192087623] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:567; }","duration":"1.141247346s","start":"2026-07-30T23:42:53.569009Z","end":"2026-07-30T23:42:54.710256Z","steps":["trace[192087623] 'agreement among raft nodes before linearized reading' (duration: 1.141116383s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:54.710269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:53.335364Z","time spent":"1.374849042s","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31111,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T23:42:54.710283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:53.569004Z","time spent":"1.141271396s","remote":"127.0.0.1:55456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-07-30T23:42:54.710336Z","caller":"traceutil/trace.go:171","msg":"trace[1290775348] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"1.319889049s","start":"2026-07-30T23:42:53.39044Z","end":"2026-07-30T23:42:54.710329Z","steps":["trace[1290775348] 'process raft request' (duration: 1.319212087s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:54.710364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:53.390412Z","time spent":"1.31993734s","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":73770,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T23:42:54.710448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"922.19803ms","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-30T23:42:54.710467Z","caller":"traceutil/trace.go:171","msg":"trace[675539015] 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:567; }","duration":"922.242801ms","start":"2026-07-30T23:42:53.788219Z","end":"2026-07-30T23:42:54.710462Z","steps":["trace[675539015] 'agreement among raft nodes before linearized reading' (duration: 922.21216ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:54.71049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:53.788205Z","time spent":"922.280702ms","remote":"127.0.0.1:55464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-07-30T23:42:54.710499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"960.596105ms","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-30T23:42:54.71051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.217175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-30T23:42:54.710525Z","caller":"traceutil/trace.go:171","msg":"trace[333427827] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:567; }","duration":"960.676607ms","start":"2026-07-30T23:42:53.749841Z","end":"2026-07-30T23:42:54.710518Z","steps":["trace[333427827] 'agreement among raft nodes before linearized reading' (duration: 960.611935ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:42:54.710531Z","caller":"traceutil/trace.go:171","msg":"trace[2038959693] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:567; }","duration":"223.280167ms","start":"2026-07-30T23:42:54.487245Z","end":"2026-07-30T23:42:54.710525Z","steps":["trace[2038959693] 'agreement among raft nodes before linearized reading' (duration: 223.159285ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:54.710531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"922.081118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-30T23:42:54.710546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:53.749815Z","time spent":"960.726387ms","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-30T23:42:54.710589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"922.257071ms","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-30T23:42:54.710607Z","caller":"traceutil/trace.go:171","msg":"trace[308409649] 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:567; }","duration":"922.320922ms","start":"2026-07-30T23:42:53.78828Z","end":"2026-07-30T23:42:54.710601Z","steps":["trace[308409649] 'agreement among raft nodes before linearized reading' (duration: 922.293011ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:54.710618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"928.641746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-30T23:42:54.710627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:53.788274Z","time spent":"922.344672ms","remote":"127.0.0.1:55464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-07-30T23:42:54.710629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.437098ms","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-30T23:42:54.710638Z","caller":"traceutil/trace.go:171","msg":"trace[1075260582] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:567; }","duration":"928.697128ms","start":"2026-07-30T23:42:53.781934Z","end":"2026-07-30T23:42:54.710631Z","steps":["trace[1075260582] 'agreement among raft nodes before linearized reading' (duration: 928.667118ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:42:54.710644Z","caller":"traceutil/trace.go:171","msg":"trace[1075001316] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:567; }","duration":"233.49976ms","start":"2026-07-30T23:42:54.47714Z","end":"2026-07-30T23:42:54.71064Z","steps":["trace[1075001316] 'agreement among raft nodes before linearized reading' (duration: 233.422538ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:54.710657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:53.781913Z","time spent":"928.740359ms","remote":"127.0.0.1:60618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-30T23:42:54.710554Z","caller":"traceutil/trace.go:171","msg":"trace[32046577] 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:567; }","duration":"922.119979ms","start":"2026-07-30T23:42:53.788426Z","end":"2026-07-30T23:42:54.710546Z","steps":["trace[32046577] 'agreement among raft nodes before linearized reading' (duration: 922.087638ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:54.71076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:53.78842Z","time spent":"922.319382ms","remote":"127.0.0.1:55464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"info","ts":"2026-07-30T23:42:58.021561Z","caller":"traceutil/trace.go:171","msg":"trace[1035330356] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"111.901672ms","start":"2026-07-30T23:42:57.909627Z","end":"2026-07-30T23:42:58.021528Z","steps":["trace[1035330356] 'process raft request' (duration: 111.013597ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:59.235236Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313097574969522728,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-30T23:42:59.404725Z","caller":"traceutil/trace.go:171","msg":"trace[1101302366] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"675.538922ms","start":"2026-07-30T23:42:58.729151Z","end":"2026-07-30T23:42:59.40469Z","steps":["trace[1101302366] 'process raft request' (duration: 675.277217ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:59.404959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:58.729117Z","time spent":"675.704035ms","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T23:42:59.845124Z","caller":"traceutil/trace.go:171","msg":"trace[5315108] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:644; }","duration":"1.109945873s","start":"2026-07-30T23:42:58.735148Z","end":"2026-07-30T23:42:59.845093Z","steps":["trace[5315108] 'read index received' (duration: 669.243114ms)","trace[5315108] 'applied index is now lower than readState.Index' (duration: 440.701629ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T23:42:59.845275Z","caller":"traceutil/trace.go:171","msg":"trace[491188949] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"869.711651ms","start":"2026-07-30T23:42:58.975553Z","end":"2026-07-30T23:42:59.845265Z","steps":["trace[491188949] 'process raft request' (duration: 868.52664ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:59.845519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.061034885s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T23:42:59.845573Z","caller":"traceutil/trace.go:171","msg":"trace[1641252860] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:624; }","duration":"1.061098996s","start":"2026-07-30T23:42:58.784459Z","end":"2026-07-30T23:42:59.845558Z","steps":["trace[1641252860] 'agreement among raft nodes before linearized reading' (duration: 1.060999775s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:59.84573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:58.78442Z","time spent":"1.0612968s","remote":"127.0.0.1:60630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-30T23:42:59.846045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:58.975512Z","time spent":"869.795352ms","remote":"127.0.0.1:60738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036193,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T23:42:59.846042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.110821028s","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-30T23:42:59.8462Z","caller":"traceutil/trace.go:171","msg":"trace[1099705356] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:624; }","duration":"1.111083673s","start":"2026-07-30T23:42:58.735091Z","end":"2026-07-30T23:42:59.846175Z","steps":["trace[1099705356] 'agreement among raft nodes before linearized reading' (duration: 1.110484712s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:59.84629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:58.735079Z","time spent":"1.111198014s","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-30T23:42:59.846066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.104911285s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-30T23:42:59.847286Z","caller":"traceutil/trace.go:171","msg":"trace[1012594785] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:624; }","duration":"1.106328639s","start":"2026-07-30T23:42:58.74093Z","end":"2026-07-30T23:42:59.847259Z","steps":["trace[1012594785] 'agreement among raft nodes before linearized reading' (duration: 1.104559339s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:59.847357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:58.740926Z","time spent":"1.106416282s","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-30T23:42:59.846012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.105051738s","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-30T23:42:59.847539Z","caller":"traceutil/trace.go:171","msg":"trace[1500556987] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:624; }","duration":"1.106492433s","start":"2026-07-30T23:42:58.740903Z","end":"2026-07-30T23:42:59.847396Z","steps":["trace[1500556987] 'agreement among raft nodes before linearized reading' (duration: 1.104514238s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:42:59.847608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:58.740896Z","time spent":"1.106692326s","remote":"127.0.0.1:60892","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-30T23:43:01.155239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.492968ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T23:43:01.155426Z","caller":"traceutil/trace.go:171","msg":"trace[545591662] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:624; }","duration":"693.710352ms","start":"2026-07-30T23:43:00.461695Z","end":"2026-07-30T23:43:01.155405Z","steps":["trace[545591662] 'range keys from in-memory index tree' (duration: 693.470388ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:43:01.156347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.278378924s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T23:43:01.156859Z","caller":"traceutil/trace.go:171","msg":"trace[1038179198] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"1.254556375s","start":"2026-07-30T23:42:59.902288Z","end":"2026-07-30T23:43:01.156845Z","steps":["trace[1038179198] 'process raft request' (duration: 1.254483924s)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:43:01.156955Z","caller":"traceutil/trace.go:171","msg":"trace[530414599] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"1.30375457s","start":"2026-07-30T23:42:59.853154Z","end":"2026-07-30T23:43:01.156909Z","steps":["trace[530414599] 'process raft request' (duration: 1.303448035s)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:43:01.156949Z","caller":"traceutil/trace.go:171","msg":"trace[1906901731] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:646; }","duration":"1.302887405s","start":"2026-07-30T23:42:59.854017Z","end":"2026-07-30T23:43:01.156904Z","steps":["trace[1906901731] 'read index received' (duration: 23.789978ms)","trace[1906901731] 'applied index is now lower than readState.Index' (duration: 1.279092477s)"],"step_count":2} {"level":"warn","ts":"2026-07-30T23:43:01.157108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:59.853113Z","time spent":"1.303918972s","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T23:43:01.157081Z","caller":"traceutil/trace.go:171","msg":"trace[1813260150] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"1.303804441s","start":"2026-07-30T23:42:59.853199Z","end":"2026-07-30T23:43:01.157003Z","steps":["trace[1813260150] 'process raft request' (duration: 1.303495976s)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:43:01.157243Z","caller":"traceutil/trace.go:171","msg":"trace[1269911175] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"1.304795448s","start":"2026-07-30T23:42:59.852427Z","end":"2026-07-30T23:43:01.157223Z","steps":["trace[1269911175] 'process raft request' (duration: 25.433757ms)","trace[1269911175] 'compare' (duration: 1.277983838s)"],"step_count":2} {"level":"warn","ts":"2026-07-30T23:43:01.157163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.303105379s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-30T23:43:01.157395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:59.852399Z","time spent":"1.304899239s","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T23:43:01.157423Z","caller":"traceutil/trace.go:171","msg":"trace[1671600762] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:628; }","duration":"1.303401954s","start":"2026-07-30T23:42:59.853982Z","end":"2026-07-30T23:43:01.157384Z","steps":["trace[1671600762] 'agreement among raft nodes before linearized reading' (duration: 1.303072318s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:43:01.157485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:59.85397Z","time spent":"1.303481105s","remote":"127.0.0.1:60618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-30T23:43:01.157476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:59.85318Z","time spent":"1.304065495s","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T23:43:01.157537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:42:59.902255Z","time spent":"1.254678367s","remote":"127.0.0.1:60964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T23:43:01.216037Z","caller":"traceutil/trace.go:171","msg":"trace[1583430678] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"610.967813ms","start":"2026-07-30T23:43:00.604812Z","end":"2026-07-30T23:43:01.21578Z","steps":["trace[1583430678] 'process raft request' (duration: 610.675718ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:43:01.216365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:43:00.604776Z","time spent":"611.317989ms","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T23:43:02.053715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.013677ms","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-30T23:43:02.05382Z","caller":"traceutil/trace.go:171","msg":"trace[712464351] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:629; }","duration":"644.160679ms","start":"2026-07-30T23:43:01.409635Z","end":"2026-07-30T23:43:02.053796Z","steps":["trace[712464351] 'range keys from in-memory index tree' (duration: 643.735032ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:43:02.053875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:43:01.409612Z","time spent":"644.251951ms","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-30T23:43:02.055348Z","caller":"traceutil/trace.go:171","msg":"trace[897744982] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"452.499493ms","start":"2026-07-30T23:43:01.602815Z","end":"2026-07-30T23:43:02.055315Z","steps":["trace[897744982] 'process raft request' (duration: 451.613589ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:43:02.055482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:43:01.602783Z","time spent":"452.625225ms","remote":"127.0.0.1:60738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T23:43:03.471687Z","caller":"traceutil/trace.go:171","msg":"trace[1323696915] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"233.544358ms","start":"2026-07-30T23:43:03.238118Z","end":"2026-07-30T23:43:03.471662Z","steps":["trace[1323696915] 'process raft request' (duration: 232.729344ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:43:04.113778Z","caller":"traceutil/trace.go:171","msg":"trace[1151855223] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"158.73089ms","start":"2026-07-30T23:43:03.954978Z","end":"2026-07-30T23:43:04.113709Z","steps":["trace[1151855223] 'process raft request' (duration: 156.224399ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:43:04.143821Z","caller":"traceutil/trace.go:171","msg":"trace[1356873066] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"110.348947ms","start":"2026-07-30T23:43:04.033427Z","end":"2026-07-30T23:43:04.143776Z","steps":["trace[1356873066] 'process raft request' (duration: 110.205395ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:43:04.449887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.109185ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T23:43:04.450143Z","caller":"traceutil/trace.go:171","msg":"trace[1505814048] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"274.183624ms","start":"2026-07-30T23:43:04.175939Z","end":"2026-07-30T23:43:04.450123Z","steps":["trace[1505814048] 'process raft request' (duration: 274.125963ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:43:04.450182Z","caller":"traceutil/trace.go:171","msg":"trace[44610808] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"321.605466ms","start":"2026-07-30T23:43:04.12851Z","end":"2026-07-30T23:43:04.450115Z","steps":["trace[44610808] 'process raft request' (duration: 115.179697ms)","trace[44610808] 'compare' (duration: 205.955892ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T23:43:04.450244Z","caller":"traceutil/trace.go:171","msg":"trace[1327466151] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"301.452864ms","start":"2026-07-30T23:43:04.148758Z","end":"2026-07-30T23:43:04.450211Z","steps":["trace[1327466151] 'process raft request' (duration: 301.25048ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:43:04.450404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:43:04.148737Z","time spent":"301.583335ms","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T23:43:04.450468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:43:04.12847Z","time spent":"321.848639ms","remote":"127.0.0.1:60818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17505,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T23:43:05.184637Z","caller":"traceutil/trace.go:171","msg":"trace[1858686323] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"328.633648ms","start":"2026-07-30T23:43:04.854598Z","end":"2026-07-30T23:43:05.183232Z","steps":["trace[1858686323] 'process raft request' (duration: 317.474115ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:43:05.184905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:43:04.854558Z","time spent":"330.246753ms","remote":"127.0.0.1:60738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036321,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T23:43:19.781624Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313097574969523079,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-30T23:43:20.052344Z","caller":"traceutil/trace.go:171","msg":"trace[668277390] linearizableReadLoop","detail":"{readStateIndex:830; appliedIndex:829; }","duration":"770.903274ms","start":"2026-07-30T23:43:19.281422Z","end":"2026-07-30T23:43:20.052325Z","steps":["trace[668277390] 'read index received' (duration: 770.686301ms)","trace[668277390] 'applied index is now lower than readState.Index' (duration: 216.023µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T23:43:20.05267Z","caller":"traceutil/trace.go:171","msg":"trace[947642727] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"774.453698ms","start":"2026-07-30T23:43:19.278199Z","end":"2026-07-30T23:43:20.052652Z","steps":["trace[947642727] 'process raft request' (duration: 773.97531ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:43:20.052792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:43:19.278167Z","time spent":"774.546629ms","remote":"127.0.0.1:60866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T23:43:20.053013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.797506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-30T23:43:20.05307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.653605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-30T23:43:20.053108Z","caller":"traceutil/trace.go:171","msg":"trace[1533213235] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:802; }","duration":"771.735757ms","start":"2026-07-30T23:43:19.281361Z","end":"2026-07-30T23:43:20.053097Z","steps":["trace[1533213235] 'agreement among raft nodes before linearized reading' (duration: 771.595985ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:43:20.053102Z","caller":"traceutil/trace.go:171","msg":"trace[1329504788] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:802; }","duration":"269.985689ms","start":"2026-07-30T23:43:19.783098Z","end":"2026-07-30T23:43:20.053084Z","steps":["trace[1329504788] 'agreement among raft nodes before linearized reading' (duration: 269.811476ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:43:20.053145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:43:19.281338Z","time spent":"771.801158ms","remote":"127.0.0.1:60892","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-30T23:43:20.053427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.704294ms","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-30T23:43:20.053516Z","caller":"traceutil/trace.go:171","msg":"trace[1355995783] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:802; }","duration":"749.839745ms","start":"2026-07-30T23:43:19.303658Z","end":"2026-07-30T23:43:20.053497Z","steps":["trace[1355995783] 'agreement among raft nodes before linearized reading' (duration: 749.392189ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:43:20.053516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.920007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-30T23:43:20.053642Z","caller":"traceutil/trace.go:171","msg":"trace[927213100] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:802; }","duration":"767.091969ms","start":"2026-07-30T23:43:19.286521Z","end":"2026-07-30T23:43:20.053613Z","steps":["trace[927213100] 'agreement among raft nodes before linearized reading' (duration: 766.640313ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:43:20.053567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:43:19.303642Z","time spent":"749.914707ms","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-30T23:43:20.053697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:43:19.286516Z","time spent":"767.17265ms","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-30T23:43:20.053714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"767.162851ms","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-30T23:43:20.053813Z","caller":"traceutil/trace.go:171","msg":"trace[1215457132] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:802; }","duration":"767.297243ms","start":"2026-07-30T23:43:19.286494Z","end":"2026-07-30T23:43:20.053791Z","steps":["trace[1215457132] 'agreement among raft nodes before linearized reading' (duration: 766.323139ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:43:20.053945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:43:19.286459Z","time spent":"767.471694ms","remote":"127.0.0.1:60892","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-30T23:43:34.784793Z","caller":"traceutil/trace.go:171","msg":"trace[1338522801] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"181.581489ms","start":"2026-07-30T23:43:34.603196Z","end":"2026-07-30T23:43:34.784777Z","steps":["trace[1338522801] 'process raft request' (duration: 181.485857ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:43:40.948559Z","caller":"traceutil/trace.go:171","msg":"trace[928433356] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"140.211194ms","start":"2026-07-30T23:43:40.808314Z","end":"2026-07-30T23:43:40.948525Z","steps":["trace[928433356] 'process raft request' (duration: 140.096622ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:43:42.068224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.913475ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T23:43:42.068319Z","caller":"traceutil/trace.go:171","msg":"trace[931271203] linearizableReadLoop","detail":"{readStateIndex:1035; appliedIndex:1034; }","duration":"285.743729ms","start":"2026-07-30T23:43:41.78256Z","end":"2026-07-30T23:43:42.068304Z","steps":["trace[931271203] 'read index received' (duration: 156.527019ms)","trace[931271203] 'applied index is now lower than readState.Index' (duration: 129.21562ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T23:43:42.068373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.82003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T23:43:42.0684Z","caller":"traceutil/trace.go:171","msg":"trace[183399691] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1003; }","duration":"285.899631ms","start":"2026-07-30T23:43:41.782494Z","end":"2026-07-30T23:43:42.068394Z","steps":["trace[183399691] 'agreement among raft nodes before linearized reading' (duration: 285.85214ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:43:42.068432Z","caller":"traceutil/trace.go:171","msg":"trace[1370618217] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"370.218627ms","start":"2026-07-30T23:43:41.698179Z","end":"2026-07-30T23:43:42.068398Z","steps":["trace[1370618217] 'process raft request' (duration: 241.063318ms)","trace[1370618217] 'compare' (duration: 128.810524ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T23:43:42.068694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:43:41.698163Z","time spent":"370.397329ms","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T23:44:42.892842Z","caller":"traceutil/trace.go:171","msg":"trace[872271737] linearizableReadLoop","detail":"{readStateIndex:1251; appliedIndex:1250; }","duration":"111.78408ms","start":"2026-07-30T23:44:42.781037Z","end":"2026-07-30T23:44:42.892821Z","steps":["trace[872271737] 'read index received' (duration: 111.729129ms)","trace[872271737] 'applied index is now lower than readState.Index' (duration: 53.881µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T23:44:42.89292Z","caller":"traceutil/trace.go:171","msg":"trace[347618718] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"118.327314ms","start":"2026-07-30T23:44:42.774579Z","end":"2026-07-30T23:44:42.892906Z","steps":["trace[347618718] 'process raft request' (duration: 118.089262ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:44:42.892993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.944602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T23:44:42.893046Z","caller":"traceutil/trace.go:171","msg":"trace[860785203] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1206; }","duration":"112.033433ms","start":"2026-07-30T23:44:42.780999Z","end":"2026-07-30T23:44:42.893032Z","steps":["trace[860785203] 'agreement among raft nodes before linearized reading' (duration: 111.921982ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:44:44.030825Z","caller":"traceutil/trace.go:171","msg":"trace[499510994] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"120.234869ms","start":"2026-07-30T23:44:43.910564Z","end":"2026-07-30T23:44:44.030799Z","steps":["trace[499510994] 'process raft request' (duration: 120.098417ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:44:44.031142Z","caller":"traceutil/trace.go:171","msg":"trace[306870214] linearizableReadLoop","detail":"{readStateIndex:1258; appliedIndex:1258; }","duration":"108.461175ms","start":"2026-07-30T23:44:43.922636Z","end":"2026-07-30T23:44:44.031097Z","steps":["trace[306870214] 'read index received' (duration: 108.451305ms)","trace[306870214] 'applied index is now lower than readState.Index' (duration: 8µs)"],"step_count":2} {"level":"warn","ts":"2026-07-30T23:44:44.031311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.637367ms","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-30T23:44:44.031356Z","caller":"traceutil/trace.go:171","msg":"trace[673124451] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1212; }","duration":"108.725947ms","start":"2026-07-30T23:44:43.922617Z","end":"2026-07-30T23:44:44.031343Z","steps":["trace[673124451] 'agreement among raft nodes before linearized reading' (duration: 108.600236ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:45:00.239796Z","caller":"traceutil/trace.go:171","msg":"trace[106702708] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"143.070178ms","start":"2026-07-30T23:45:00.096696Z","end":"2026-07-30T23:45:00.239767Z","steps":["trace[106702708] 'process raft request' (duration: 142.887285ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:45:00.336505Z","caller":"traceutil/trace.go:171","msg":"trace[2096746967] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"195.672392ms","start":"2026-07-30T23:45:00.140794Z","end":"2026-07-30T23:45:00.336466Z","steps":["trace[2096746967] 'process raft request' (duration: 146.610101ms)","trace[2096746967] 'compare' (duration: 48.683867ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T23:45:00.336762Z","caller":"traceutil/trace.go:171","msg":"trace[879149943] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"166.943557ms","start":"2026-07-30T23:45:00.169792Z","end":"2026-07-30T23:45:00.336735Z","steps":["trace[879149943] 'process raft request' (duration: 166.562863ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:45:08.555519Z","caller":"traceutil/trace.go:171","msg":"trace[1561195192] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"137.735706ms","start":"2026-07-30T23:45:08.417759Z","end":"2026-07-30T23:45:08.555494Z","steps":["trace[1561195192] 'process raft request' (duration: 137.545515ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:45:17.925567Z","caller":"traceutil/trace.go:171","msg":"trace[131739365] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"678.656997ms","start":"2026-07-30T23:45:17.246885Z","end":"2026-07-30T23:45:17.925542Z","steps":["trace[131739365] 'process raft request' (duration: 635.273402ms)","trace[131739365] 'compare' (duration: 42.710909ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T23:45:17.925929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:45:17.246867Z","time spent":"678.793998ms","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T23:45:17.926301Z","caller":"traceutil/trace.go:171","msg":"trace[833014078] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"679.081921ms","start":"2026-07-30T23:45:17.247175Z","end":"2026-07-30T23:45:17.926256Z","steps":["trace[833014078] 'process raft request' (duration: 678.286353ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:45:17.926572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:45:17.247149Z","time spent":"679.255322ms","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T23:45:17.927018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.541085ms","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-30T23:45:17.926313Z","caller":"traceutil/trace.go:171","msg":"trace[1921999120] linearizableReadLoop","detail":"{readStateIndex:1412; appliedIndex:1410; }","duration":"455.339563ms","start":"2026-07-30T23:45:17.470463Z","end":"2026-07-30T23:45:17.925802Z","steps":["trace[1921999120] 'read index received' (duration: 411.719456ms)","trace[1921999120] 'applied index is now lower than readState.Index' (duration: 43.618187ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T23:45:17.927202Z","caller":"traceutil/trace.go:171","msg":"trace[745360802] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1359; }","duration":"456.676226ms","start":"2026-07-30T23:45:17.470405Z","end":"2026-07-30T23:45:17.927081Z","steps":["trace[745360802] 'agreement among raft nodes before linearized reading' (duration: 455.96037ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:45:17.92734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:45:17.470381Z","time spent":"456.944618ms","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-30T23:45:17.927477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.968977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-30T23:45:17.927517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.961356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.89\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-30T23:45:17.927582Z","caller":"traceutil/trace.go:171","msg":"trace[582869499] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1359; }","duration":"144.146471ms","start":"2026-07-30T23:45:17.783415Z","end":"2026-07-30T23:45:17.927561Z","steps":["trace[582869499] 'agreement among raft nodes before linearized reading' (duration: 143.934288ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:45:17.92759Z","caller":"traceutil/trace.go:171","msg":"trace[349257052] range","detail":"{range_begin:/registry/masterleases/199.204.45.89; range_end:; response_count:1; response_revision:1359; }","duration":"192.103857ms","start":"2026-07-30T23:45:17.735462Z","end":"2026-07-30T23:45:17.927566Z","steps":["trace[349257052] 'agreement among raft nodes before linearized reading' (duration: 191.832123ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:45:40.189863Z","caller":"traceutil/trace.go:171","msg":"trace[1545124745] linearizableReadLoop","detail":"{readStateIndex:1495; appliedIndex:1494; }","duration":"141.985336ms","start":"2026-07-30T23:45:40.04784Z","end":"2026-07-30T23:45:40.189825Z","steps":["trace[1545124745] 'read index received' (duration: 141.602033ms)","trace[1545124745] 'applied index is now lower than readState.Index' (duration: 381.583µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T23:45:40.189952Z","caller":"traceutil/trace.go:171","msg":"trace[1941274802] transaction","detail":"{read_only:false; response_revision:1436; number_of_response:1; }","duration":"145.024732ms","start":"2026-07-30T23:45:40.044889Z","end":"2026-07-30T23:45:40.189914Z","steps":["trace[1941274802] 'process raft request' (duration: 144.653339ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:45:40.190072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.212488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-30T23:45:40.190134Z","caller":"traceutil/trace.go:171","msg":"trace[377001313] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1436; }","duration":"142.300438ms","start":"2026-07-30T23:45:40.047819Z","end":"2026-07-30T23:45:40.19012Z","steps":["trace[377001313] 'agreement among raft nodes before linearized reading' (duration: 142.161347ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:45:40.190255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.660396ms","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-30T23:45:40.190304Z","caller":"traceutil/trace.go:171","msg":"trace[679136918] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1436; }","duration":"138.750497ms","start":"2026-07-30T23:45:40.051539Z","end":"2026-07-30T23:45:40.190289Z","steps":["trace[679136918] 'agreement among raft nodes before linearized reading' (duration: 138.525036ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:45:40.190473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.825533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-node-lease/\" range_end:\"/registry/secrets/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T23:45:40.190504Z","caller":"traceutil/trace.go:171","msg":"trace[644660448] range","detail":"{range_begin:/registry/secrets/kube-node-lease/; range_end:/registry/secrets/kube-node-lease0; response_count:0; response_revision:1436; }","duration":"100.892793ms","start":"2026-07-30T23:45:40.089597Z","end":"2026-07-30T23:45:40.190489Z","steps":["trace[644660448] 'agreement among raft nodes before linearized reading' (duration: 100.839323ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:45:40.190655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.749425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:1 size:1912"} {"level":"info","ts":"2026-07-30T23:45:40.190686Z","caller":"traceutil/trace.go:171","msg":"trace[1512129647] range","detail":"{range_begin:/registry/services/specs/envoy-gateway-system/envoy-gateway; range_end:; response_count:1; response_revision:1436; }","duration":"132.796285ms","start":"2026-07-30T23:45:40.057878Z","end":"2026-07-30T23:45:40.190675Z","steps":["trace[1512129647] 'agreement among raft nodes before linearized reading' (duration: 132.726635ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:45:40.359401Z","caller":"traceutil/trace.go:171","msg":"trace[1916355917] transaction","detail":"{read_only:false; response_revision:1437; number_of_response:1; }","duration":"164.79073ms","start":"2026-07-30T23:45:40.19458Z","end":"2026-07-30T23:45:40.359371Z","steps":["trace[1916355917] 'process raft request' (duration: 114.291708ms)","trace[1916355917] 'compare' (duration: 50.2036ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T23:45:40.359378Z","caller":"traceutil/trace.go:171","msg":"trace[1070496275] linearizableReadLoop","detail":"{readStateIndex:1497; appliedIndex:1495; }","duration":"162.46179ms","start":"2026-07-30T23:45:40.196882Z","end":"2026-07-30T23:45:40.359344Z","steps":["trace[1070496275] 'read index received' (duration: 112.096409ms)","trace[1070496275] 'applied index is now lower than readState.Index' (duration: 50.363741ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T23:45:40.359434Z","caller":"traceutil/trace.go:171","msg":"trace[1738162072] transaction","detail":"{read_only:false; response_revision:1438; number_of_response:1; }","duration":"164.039014ms","start":"2026-07-30T23:45:40.195362Z","end":"2026-07-30T23:45:40.359401Z","steps":["trace[1738162072] 'process raft request' (duration: 163.924773ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T23:45:40.35973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.803133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:1 size:1912"} {"level":"info","ts":"2026-07-30T23:45:40.359777Z","caller":"traceutil/trace.go:171","msg":"trace[57228524] range","detail":"{range_begin:/registry/services/specs/envoy-gateway-system/envoy-gateway; range_end:; response_count:1; response_revision:1438; }","duration":"162.906073ms","start":"2026-07-30T23:45:40.196852Z","end":"2026-07-30T23:45:40.359758Z","steps":["trace[57228524] 'agreement among raft nodes before linearized reading' (duration: 162.705652ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T23:45:41.47709Z","caller":"traceutil/trace.go:171","msg":"trace[1715092700] transaction","detail":"{read_only:false; response_revision:1442; number_of_response:1; }","duration":"166.774665ms","start":"2026-07-30T23:45:41.310015Z","end":"2026-07-30T23:45:41.47679Z","steps":["trace[1715092700] 'process raft request' (duration: 166.604963ms)"],"step_count":1}