{"level":"warn","ts":"2026-10-09T02:24:02.280568Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-09T02:24:02.280689Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.79:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.79:2380","--initial-cluster=instance=https://162.253.55.79:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.79:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.79: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-10-09T02:24:02.280757Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-09T02:24:02.280765Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.79:2380"]} {"level":"info","ts":"2026-10-09T02:24:02.280784Z","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-10-09T02:24:02.281513Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"]} {"level":"info","ts":"2026-10-09T02:24:02.281598Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.79:2380"],"listen-peer-urls":["https://162.253.55.79:2380"],"advertise-client-urls":["https://162.253.55.79:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.79: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-10-09T02:24:02.284229Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.431335ms"} {"level":"info","ts":"2026-10-09T02:24:02.292516Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"401ca643156fc5da","cluster-id":"e9f568c3681bb0d0"} {"level":"info","ts":"2026-10-09T02:24:02.292617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=()"} {"level":"info","ts":"2026-10-09T02:24:02.292637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became follower at term 0"} {"level":"info","ts":"2026-10-09T02:24:02.292644Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 401ca643156fc5da [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-09T02:24:02.292653Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became follower at term 1"} {"level":"info","ts":"2026-10-09T02:24:02.292684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=(4619750124827952602)"} {"level":"warn","ts":"2026-10-09T02:24:02.298889Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-09T02:24:02.30023Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-09T02:24:02.301417Z","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-10-09T02:24:02.30341Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"401ca643156fc5da","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-09T02:24:02.305296Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"401ca643156fc5da","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-09T02:24:02.305205Z","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-10-09T02:24:02.305593Z","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-10-09T02:24:02.305607Z","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-10-09T02:24:02.307643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=(4619750124827952602)"} {"level":"info","ts":"2026-10-09T02:24:02.307795Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e9f568c3681bb0d0","local-member-id":"401ca643156fc5da","added-peer-id":"401ca643156fc5da","added-peer-peer-urls":["https://162.253.55.79:2380"]} {"level":"info","ts":"2026-10-09T02:24:02.307934Z","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-10-09T02:24:02.307991Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.79:2380"} {"level":"info","ts":"2026-10-09T02:24:02.308026Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.79:2380"} {"level":"info","ts":"2026-10-09T02:24:02.308204Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"401ca643156fc5da","initial-advertise-peer-urls":["https://162.253.55.79:2380"],"listen-peer-urls":["https://162.253.55.79:2380"],"advertise-client-urls":["https://162.253.55.79:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-09T02:24:02.308235Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-09T02:24:02.793956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da is starting a new election at term 1"} {"level":"info","ts":"2026-10-09T02:24:02.794044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became pre-candidate at term 1"} {"level":"info","ts":"2026-10-09T02:24:02.794077Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da received MsgPreVoteResp from 401ca643156fc5da at term 1"} {"level":"info","ts":"2026-10-09T02:24:02.794101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became candidate at term 2"} {"level":"info","ts":"2026-10-09T02:24:02.794121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da received MsgVoteResp from 401ca643156fc5da at term 2"} {"level":"info","ts":"2026-10-09T02:24:02.79414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became leader at term 2"} {"level":"info","ts":"2026-10-09T02:24:02.794162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 401ca643156fc5da elected leader 401ca643156fc5da at term 2"} {"level":"info","ts":"2026-10-09T02:24:02.795357Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"401ca643156fc5da","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.79:2379]}","request-path":"/0/members/401ca643156fc5da/attributes","cluster-id":"e9f568c3681bb0d0","publish-timeout":"7s"} {"level":"info","ts":"2026-10-09T02:24:02.795688Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-09T02:24:02.796038Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-09T02:24:02.796085Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-09T02:24:02.795871Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-09T02:24:02.795904Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:24:02.797226Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e9f568c3681bb0d0","local-member-id":"401ca643156fc5da","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:24:02.797342Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:24:02.79738Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-09T02:24:02.798291Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-09T02:24:02.80975Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.79:2379"} {"level":"info","ts":"2026-10-09T02:24:05.179821Z","caller":"traceutil/trace.go:171","msg":"trace[1791561402] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"133.236619ms","start":"2026-10-09T02:24:05.046558Z","end":"2026-10-09T02:24:05.179794Z","steps":["trace[1791561402] 'process raft request' (duration: 133.114156ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:07.309815Z","caller":"traceutil/trace.go:171","msg":"trace[1977434259] linearizableReadLoop","detail":"{readStateIndex:211; appliedIndex:210; }","duration":"186.856851ms","start":"2026-10-09T02:24:07.122926Z","end":"2026-10-09T02:24:07.309783Z","steps":["trace[1977434259] 'read index received' (duration: 186.691387ms)","trace[1977434259] 'applied index is now lower than readState.Index' (duration: 164.514µs)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:24:07.309946Z","caller":"traceutil/trace.go:171","msg":"trace[1382640463] transaction","detail":"{read_only:false; response_revision:206; number_of_response:1; }","duration":"207.700533ms","start":"2026-10-09T02:24:07.102215Z","end":"2026-10-09T02:24:07.309916Z","steps":["trace[1382640463] 'process raft request' (duration: 207.402576ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:07.310046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.089746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-10-09T02:24:07.3101Z","caller":"traceutil/trace.go:171","msg":"trace[1439829156] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:206; }","duration":"187.24669ms","start":"2026-10-09T02:24:07.122841Z","end":"2026-10-09T02:24:07.310088Z","steps":["trace[1439829156] 'agreement among raft nodes before linearized reading' (duration: 187.070466ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:09.654005Z","caller":"traceutil/trace.go:171","msg":"trace[1062687123] transaction","detail":"{read_only:false; response_revision:271; number_of_response:1; }","duration":"143.64637ms","start":"2026-10-09T02:24:09.510326Z","end":"2026-10-09T02:24:09.653973Z","steps":["trace[1062687123] 'process raft request' (duration: 143.450666ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:09.662561Z","caller":"traceutil/trace.go:171","msg":"trace[1186091185] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"129.763111ms","start":"2026-10-09T02:24:09.532762Z","end":"2026-10-09T02:24:09.662525Z","steps":["trace[1186091185] 'process raft request' (duration: 129.535847ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:09.80648Z","caller":"traceutil/trace.go:171","msg":"trace[919201823] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"125.135289ms","start":"2026-10-09T02:24:09.681328Z","end":"2026-10-09T02:24:09.806464Z","steps":["trace[919201823] 'process raft request' (duration: 63.490279ms)","trace[919201823] 'compare' (duration: 61.458996ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:24:09.806458Z","caller":"traceutil/trace.go:171","msg":"trace[2011809834] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"118.370348ms","start":"2026-10-09T02:24:09.688064Z","end":"2026-10-09T02:24:09.806435Z","steps":["trace[2011809834] 'process raft request' (duration: 118.322307ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:11.10555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.415071ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-09T02:24:11.105747Z","caller":"traceutil/trace.go:171","msg":"trace[1156331480] linearizableReadLoop","detail":"{readStateIndex:302; appliedIndex:301; }","duration":"541.826175ms","start":"2026-10-09T02:24:10.563865Z","end":"2026-10-09T02:24:11.105691Z","steps":["trace[1156331480] 'read index received' (duration: 360.291262ms)","trace[1156331480] 'applied index is now lower than readState.Index' (duration: 181.532453ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:24:11.105887Z","caller":"traceutil/trace.go:171","msg":"trace[1383595486] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"573.228802ms","start":"2026-10-09T02:24:10.532631Z","end":"2026-10-09T02:24:11.10586Z","steps":["trace[1383595486] 'process raft request' (duration: 391.474894ms)","trace[1383595486] 'compare' (duration: 177.245098ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:24:11.105958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:10.532576Z","time spent":"573.342474ms","remote":"127.0.0.1:51858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-09T02:24:11.106783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.914219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-10-09T02:24:11.106787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.36533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-09T02:24:11.106859Z","caller":"traceutil/trace.go:171","msg":"trace[1877269809] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:288; }","duration":"543.030681ms","start":"2026-10-09T02:24:10.563798Z","end":"2026-10-09T02:24:11.106829Z","steps":["trace[1877269809] 'agreement among raft nodes before linearized reading' (duration: 542.425197ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:11.106882Z","caller":"traceutil/trace.go:171","msg":"trace[75288155] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:288; }","duration":"236.506653ms","start":"2026-10-09T02:24:10.870339Z","end":"2026-10-09T02:24:11.106846Z","steps":["trace[75288155] 'agreement among raft nodes before linearized reading' (duration: 236.338839ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:11.106897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:10.563773Z","time spent":"543.113224ms","remote":"127.0.0.1:51910","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-10-09T02:24:12.154556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.831261ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-09T02:24:12.154845Z","caller":"traceutil/trace.go:171","msg":"trace[909514816] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"1.041484053s","start":"2026-10-09T02:24:11.113339Z","end":"2026-10-09T02:24:12.154823Z","steps":["trace[909514816] 'process raft request' (duration: 1.041400071s)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:12.154951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:11.113316Z","time spent":"1.041587535s","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:24:12.155085Z","caller":"traceutil/trace.go:171","msg":"trace[449445932] linearizableReadLoop","detail":"{readStateIndex:303; appliedIndex:302; }","duration":"1.041845151s","start":"2026-10-09T02:24:11.113198Z","end":"2026-10-09T02:24:12.155043Z","steps":["trace[449445932] 'read index received' (duration: 207.291084ms)","trace[449445932] 'applied index is now lower than readState.Index' (duration: 834.551107ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:24:12.155249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.042048536s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:24:12.155312Z","caller":"traceutil/trace.go:171","msg":"trace[2108217070] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:0; response_revision:290; }","duration":"1.042154198s","start":"2026-10-09T02:24:11.11314Z","end":"2026-10-09T02:24:12.155294Z","steps":["trace[2108217070] 'agreement among raft nodes before linearized reading' (duration: 1.042058096s)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:12.155341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"823.080061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-10-09T02:24:12.155356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:11.113117Z","time spent":"1.042228609s","remote":"127.0.0.1:51858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"info","ts":"2026-10-09T02:24:12.155383Z","caller":"traceutil/trace.go:171","msg":"trace[91936408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:290; }","duration":"823.184274ms","start":"2026-10-09T02:24:11.332187Z","end":"2026-10-09T02:24:12.155371Z","steps":["trace[91936408] 'agreement among raft nodes before linearized reading' (duration: 823.057631ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:12.155433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:11.332169Z","time spent":"823.254575ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-09T02:24:12.155458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.960567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-10-09T02:24:12.155544Z","caller":"traceutil/trace.go:171","msg":"trace[2038161458] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:290; }","duration":"103.07906ms","start":"2026-10-09T02:24:12.052443Z","end":"2026-10-09T02:24:12.155522Z","steps":["trace[2038161458] 'agreement among raft nodes before linearized reading' (duration: 102.926037ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:12.155165Z","caller":"traceutil/trace.go:171","msg":"trace[1372836484] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"1.042101936s","start":"2026-10-09T02:24:11.11302Z","end":"2026-10-09T02:24:12.155122Z","steps":["trace[1372836484] 'process raft request' (duration: 207.453757ms)","trace[1372836484] 'compare' (duration: 833.687358ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:24:12.157032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:11.112962Z","time spent":"1.043953618s","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:24:12.776407Z","caller":"traceutil/trace.go:171","msg":"trace[1786604545] linearizableReadLoop","detail":"{readStateIndex:306; appliedIndex:305; }","duration":"615.137255ms","start":"2026-10-09T02:24:12.161241Z","end":"2026-10-09T02:24:12.776378Z","steps":["trace[1786604545] 'read index received' (duration: 53.778547ms)","trace[1786604545] 'applied index is now lower than readState.Index' (duration: 561.357748ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:24:12.776588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.895068ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:24:12.776737Z","caller":"traceutil/trace.go:171","msg":"trace[1760570967] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:292; }","duration":"610.047612ms","start":"2026-10-09T02:24:12.16667Z","end":"2026-10-09T02:24:12.776718Z","steps":["trace[1760570967] 'agreement among raft nodes before linearized reading' (duration: 609.871057ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:12.77659Z","caller":"traceutil/trace.go:171","msg":"trace[562281129] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"616.190479ms","start":"2026-10-09T02:24:12.160288Z","end":"2026-10-09T02:24:12.776478Z","steps":["trace[562281129] 'process raft request' (duration: 613.674203ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:12.776581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.303418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-10-09T02:24:12.77685Z","caller":"traceutil/trace.go:171","msg":"trace[1743391690] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:292; }","duration":"615.629137ms","start":"2026-10-09T02:24:12.161208Z","end":"2026-10-09T02:24:12.776837Z","steps":["trace[1743391690] 'agreement among raft nodes before linearized reading' (duration: 615.297169ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:12.776977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:12.160275Z","time spent":"616.560748ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-09T02:24:12.776892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:12.161196Z","time spent":"615.684798ms","remote":"127.0.0.1:51760","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-10-09T02:24:35.861305Z","caller":"traceutil/trace.go:171","msg":"trace[142988668] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"126.833259ms","start":"2026-10-09T02:24:35.734445Z","end":"2026-10-09T02:24:35.861278Z","steps":["trace[142988668] 'process raft request' (duration: 120.149067ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:36.305446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.532097ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-09T02:24:36.305706Z","caller":"traceutil/trace.go:171","msg":"trace[1964496787] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"259.307615ms","start":"2026-10-09T02:24:36.046236Z","end":"2026-10-09T02:24:36.305543Z","steps":["trace[1964496787] 'process raft request' (duration: 130.609464ms)","trace[1964496787] 'compare' (duration: 128.377054ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:24:36.323135Z","caller":"traceutil/trace.go:171","msg":"trace[1000588694] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"269.862604ms","start":"2026-10-09T02:24:36.053251Z","end":"2026-10-09T02:24:36.323113Z","steps":["trace[1000588694] 'process raft request' (duration: 269.706141ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:36.323271Z","caller":"traceutil/trace.go:171","msg":"trace[353690229] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"269.838994ms","start":"2026-10-09T02:24:36.053398Z","end":"2026-10-09T02:24:36.323237Z","steps":["trace[353690229] 'process raft request' (duration: 269.618679ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:36.32331Z","caller":"traceutil/trace.go:171","msg":"trace[846263992] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"276.682299ms","start":"2026-10-09T02:24:36.046333Z","end":"2026-10-09T02:24:36.323015Z","steps":["trace[846263992] 'process raft request' (duration: 276.519985ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:36.323537Z","caller":"traceutil/trace.go:171","msg":"trace[889621770] linearizableReadLoop","detail":"{readStateIndex:454; appliedIndex:450; }","duration":"113.797174ms","start":"2026-10-09T02:24:36.209722Z","end":"2026-10-09T02:24:36.323519Z","steps":["trace[889621770] 'read index received' (duration: 113.214001ms)","trace[889621770] 'applied index is now lower than readState.Index' (duration: 582.303µs)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:24:36.323606Z","caller":"traceutil/trace.go:171","msg":"trace[1753099614] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"270.191302ms","start":"2026-10-09T02:24:36.053394Z","end":"2026-10-09T02:24:36.323585Z","steps":["trace[1753099614] 'process raft request' (duration: 269.67166ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:36.32371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.974738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.79\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-10-09T02:24:36.323916Z","caller":"traceutil/trace.go:171","msg":"trace[950796880] range","detail":"{range_begin:/registry/masterleases/162.253.55.79; range_end:; response_count:1; response_revision:433; }","duration":"114.228873ms","start":"2026-10-09T02:24:36.209668Z","end":"2026-10-09T02:24:36.323897Z","steps":["trace[950796880] 'agreement among raft nodes before linearized reading' (duration: 113.948117ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:48.491132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.438079ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-09T02:24:48.491414Z","caller":"traceutil/trace.go:171","msg":"trace[462364971] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"466.256967ms","start":"2026-10-09T02:24:48.025124Z","end":"2026-10-09T02:24:48.491381Z","steps":["trace[462364971] 'process raft request' (duration: 91.49501ms)","trace[462364971] 'compare' (duration: 374.234045ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:24:48.4916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:48.025107Z","time spent":"466.428511ms","remote":"127.0.0.1:52142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-09T02:24:48.491692Z","caller":"traceutil/trace.go:171","msg":"trace[1955653054] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"460.511237ms","start":"2026-10-09T02:24:48.031057Z","end":"2026-10-09T02:24:48.491568Z","steps":["trace[1955653054] 'process raft request' (duration: 460.184178ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:48.491909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:48.031041Z","time spent":"460.759042ms","remote":"127.0.0.1:52136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4177,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-09T02:24:48.492458Z","caller":"traceutil/trace.go:171","msg":"trace[70352516] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"379.499794ms","start":"2026-10-09T02:24:48.112928Z","end":"2026-10-09T02:24:48.492428Z","steps":["trace[70352516] 'process raft request' (duration: 378.588234ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:48.492672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:48.11289Z","time spent":"379.653497ms","remote":"127.0.0.1:51744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317275,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-09T02:24:49.039096Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14256884722654443891,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-09T02:24:49.54025Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14256884722654443891,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-09T02:24:49.556276Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.046666095s","expected-duration":"1s"} {"level":"info","ts":"2026-10-09T02:24:49.619412Z","caller":"traceutil/trace.go:171","msg":"trace[1086006860] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"1.109926566s","start":"2026-10-09T02:24:48.509446Z","end":"2026-10-09T02:24:49.619372Z","steps":["trace[1086006860] 'process raft request' (duration: 1.047185457s)","trace[1086006860] 'compare' (duration: 62.280969ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:24:49.619541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:48.509413Z","time spent":"1.110064818s","remote":"127.0.0.1:52108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4320,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:24:49.717616Z","caller":"traceutil/trace.go:171","msg":"trace[1645834224] linearizableReadLoop","detail":"{readStateIndex:514; appliedIndex:509; }","duration":"1.179087129s","start":"2026-10-09T02:24:48.538501Z","end":"2026-10-09T02:24:49.717588Z","steps":["trace[1645834224] 'read index received' (duration: 1.018024876s)","trace[1645834224] 'applied index is now lower than readState.Index' (duration: 161.061233ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:24:49.717765Z","caller":"traceutil/trace.go:171","msg":"trace[719025574] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"404.686423ms","start":"2026-10-09T02:24:49.313067Z","end":"2026-10-09T02:24:49.717753Z","steps":["trace[719025574] 'process raft request' (duration: 404.470608ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:49.717775Z","caller":"traceutil/trace.go:171","msg":"trace[2089991793] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"1.205286342s","start":"2026-10-09T02:24:48.512427Z","end":"2026-10-09T02:24:49.717713Z","steps":["trace[2089991793] 'process raft request' (duration: 1.205023876s)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:49.717874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:49.313034Z","time spent":"404.757145ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-09T02:24:49.71801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:48.512396Z","time spent":"1.205499137s","remote":"127.0.0.1:51834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3576,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-09T02:24:49.71803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.179539761s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-09T02:24:49.718066Z","caller":"traceutil/trace.go:171","msg":"trace[1084046107] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:490; }","duration":"1.179628713s","start":"2026-10-09T02:24:48.538425Z","end":"2026-10-09T02:24:49.718054Z","steps":["trace[1084046107] 'agreement among raft nodes before linearized reading' (duration: 1.179564621s)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:49.718099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:48.538399Z","time spent":"1.179694134s","remote":"127.0.0.1:51910","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":"info","ts":"2026-10-09T02:24:49.718173Z","caller":"traceutil/trace.go:171","msg":"trace[850356801] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"1.207999924s","start":"2026-10-09T02:24:48.510017Z","end":"2026-10-09T02:24:49.718017Z","steps":["trace[850356801] 'process raft request' (duration: 1.207272117s)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:49.718219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.173316379s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-09T02:24:49.718303Z","caller":"traceutil/trace.go:171","msg":"trace[2104032137] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:490; }","duration":"1.173462313s","start":"2026-10-09T02:24:48.544821Z","end":"2026-10-09T02:24:49.718284Z","steps":["trace[2104032137] 'agreement among raft nodes before linearized reading' (duration: 1.173261388s)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:49.71835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:48.544793Z","time spent":"1.173548154s","remote":"127.0.0.1:51910","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-10-09T02:24:49.718387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.655391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-10-09T02:24:49.71844Z","caller":"traceutil/trace.go:171","msg":"trace[881313950] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:490; }","duration":"663.763514ms","start":"2026-10-09T02:24:49.054661Z","end":"2026-10-09T02:24:49.718425Z","steps":["trace[881313950] 'agreement among raft nodes before linearized reading' (duration: 663.666222ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:49.718477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:49.054612Z","time spent":"663.856426ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-09T02:24:49.718524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:48.510005Z","time spent":"1.20830163s","remote":"127.0.0.1:51736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":712,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-09T02:24:49.718614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.173373311s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-09T02:24:49.718644Z","caller":"traceutil/trace.go:171","msg":"trace[538385504] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:490; }","duration":"1.173423751s","start":"2026-10-09T02:24:48.545212Z","end":"2026-10-09T02:24:49.718635Z","steps":["trace[538385504] 'agreement among raft nodes before linearized reading' (duration: 1.1733703s)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:49.718698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:48.545203Z","time spent":"1.173487543s","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-09T02:24:49.718176Z","caller":"traceutil/trace.go:171","msg":"trace[82786750] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"1.199107524s","start":"2026-10-09T02:24:48.519037Z","end":"2026-10-09T02:24:49.718144Z","steps":["trace[82786750] 'process raft request' (duration: 1.198465659s)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:49.71882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:48.51899Z","time spent":"1.199801799s","remote":"127.0.0.1:51834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15015,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-09T02:24:49.719078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.11058452s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329948"} {"level":"info","ts":"2026-10-09T02:24:49.719138Z","caller":"traceutil/trace.go:171","msg":"trace[1027372497] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:490; }","duration":"1.110653952s","start":"2026-10-09T02:24:48.608467Z","end":"2026-10-09T02:24:49.719121Z","steps":["trace[1027372497] 'agreement among raft nodes before linearized reading' (duration: 1.110136521s)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:49.719174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:48.608453Z","time spent":"1.110714043s","remote":"127.0.0.1:51744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":4,"response size":329971,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"warn","ts":"2026-10-09T02:24:50.355838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.537868ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-09T02:24:50.356007Z","caller":"traceutil/trace.go:171","msg":"trace[375522269] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"631.883463ms","start":"2026-10-09T02:24:49.724107Z","end":"2026-10-09T02:24:50.355991Z","steps":["trace[375522269] 'process raft request' (duration: 354.1199ms)","trace[375522269] 'compare' (duration: 277.232771ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:24:50.356072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:49.72408Z","time spent":"631.956114ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:24:50.357211Z","caller":"traceutil/trace.go:171","msg":"trace[862549356] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"629.457368ms","start":"2026-10-09T02:24:49.727713Z","end":"2026-10-09T02:24:50.35717Z","steps":["trace[862549356] 'process raft request' (duration: 629.028429ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:50.357435Z","caller":"traceutil/trace.go:171","msg":"trace[332242492] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"629.646462ms","start":"2026-10-09T02:24:49.727733Z","end":"2026-10-09T02:24:50.357379Z","steps":["trace[332242492] 'process raft request' (duration: 628.816944ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:50.357537Z","caller":"traceutil/trace.go:171","msg":"trace[1105910521] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"629.679942ms","start":"2026-10-09T02:24:49.727837Z","end":"2026-10-09T02:24:50.357517Z","steps":["trace[1105910521] 'process raft request' (duration: 629.11941ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:50.357609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:49.727827Z","time spent":"629.748383ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-09T02:24:50.357688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:49.727723Z","time spent":"629.829976ms","remote":"127.0.0.1:52108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4617,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:24:50.357819Z","caller":"traceutil/trace.go:171","msg":"trace[727881940] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"629.902526ms","start":"2026-10-09T02:24:49.727903Z","end":"2026-10-09T02:24:50.357806Z","steps":["trace[727881940] 'process raft request' (duration: 629.488267ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:50.357871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:49.727883Z","time spent":"629.963329ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:24:50.357905Z","caller":"traceutil/trace.go:171","msg":"trace[1292359441] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"629.970339ms","start":"2026-10-09T02:24:49.727914Z","end":"2026-10-09T02:24:50.357884Z","steps":["trace[1292359441] 'process raft request' (duration: 629.59721ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:50.358032Z","caller":"traceutil/trace.go:171","msg":"trace[336134713] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"630.097282ms","start":"2026-10-09T02:24:49.727921Z","end":"2026-10-09T02:24:50.358018Z","steps":["trace[336134713] 'process raft request' (duration: 629.843265ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:50.358084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:49.727898Z","time spent":"630.161143ms","remote":"127.0.0.1:51834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3622,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-09T02:24:50.358078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:49.727904Z","time spent":"630.069391ms","remote":"127.0.0.1:51834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15061,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:24:50.358217Z","caller":"traceutil/trace.go:171","msg":"trace[1672762214] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"630.116242ms","start":"2026-10-09T02:24:49.728084Z","end":"2026-10-09T02:24:50.3582Z","steps":["trace[1672762214] 'process raft request' (duration: 629.736143ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:50.3583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:49.728074Z","time spent":"630.185304ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:24:50.358325Z","caller":"traceutil/trace.go:171","msg":"trace[1781038904] linearizableReadLoop","detail":"{readStateIndex:525; appliedIndex:514; }","duration":"492.327557ms","start":"2026-10-09T02:24:49.865988Z","end":"2026-10-09T02:24:50.358316Z","steps":["trace[1781038904] 'read index received' (duration: 212.347754ms)","trace[1781038904] 'applied index is now lower than readState.Index' (duration: 279.978752ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:24:50.35839Z","caller":"traceutil/trace.go:171","msg":"trace[2116802815] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"626.42798ms","start":"2026-10-09T02:24:49.731956Z","end":"2026-10-09T02:24:50.358384Z","steps":["trace[2116802815] 'process raft request' (duration: 626.308507ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:50.358433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:49.731937Z","time spent":"626.475951ms","remote":"127.0.0.1:52134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14386,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-09T02:24:50.358195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:49.727634Z","time spent":"629.811865ms","remote":"127.0.0.1:52136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4294,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:24:50.358488Z","caller":"traceutil/trace.go:171","msg":"trace[127309586] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"629.109929ms","start":"2026-10-09T02:24:49.729364Z","end":"2026-10-09T02:24:50.358474Z","steps":["trace[127309586] 'process raft request' (duration: 628.753741ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:50.358546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:49.729333Z","time spent":"629.188471ms","remote":"127.0.0.1:51736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":736,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-09T02:24:50.357262Z","caller":"traceutil/trace.go:171","msg":"trace[140610046] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"629.781195ms","start":"2026-10-09T02:24:49.727445Z","end":"2026-10-09T02:24:50.357226Z","steps":["trace[140610046] 'process raft request' (duration: 628.498826ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:50.358763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:49.727415Z","time spent":"631.306269ms","remote":"127.0.0.1:51736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":653,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-09T02:24:50.358798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.797146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329948"} {"level":"info","ts":"2026-10-09T02:24:50.359109Z","caller":"traceutil/trace.go:171","msg":"trace[1127063062] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:501; }","duration":"493.169344ms","start":"2026-10-09T02:24:49.865916Z","end":"2026-10-09T02:24:50.359085Z","steps":["trace[1127063062] 'agreement among raft nodes before linearized reading' (duration: 492.427558ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:50.359165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:49.865885Z","time spent":"493.265627ms","remote":"127.0.0.1:51744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":4,"response size":329971,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"warn","ts":"2026-10-09T02:24:52.632891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.06635ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-09T02:24:52.633097Z","caller":"traceutil/trace.go:171","msg":"trace[1849913421] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"602.713564ms","start":"2026-10-09T02:24:52.030357Z","end":"2026-10-09T02:24:52.63307Z","steps":["trace[1849913421] 'process raft request' (duration: 251.317026ms)","trace[1849913421] 'compare' (duration: 350.800414ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:24:52.633179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:52.030347Z","time spent":"602.798996ms","remote":"127.0.0.1:51718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:24:52.646881Z","caller":"traceutil/trace.go:171","msg":"trace[436814573] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"601.72931ms","start":"2026-10-09T02:24:52.045112Z","end":"2026-10-09T02:24:52.646841Z","steps":["trace[436814573] 'process raft request' (duration: 601.481514ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:52.647044Z","caller":"traceutil/trace.go:171","msg":"trace[1576010741] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"599.773366ms","start":"2026-10-09T02:24:52.047219Z","end":"2026-10-09T02:24:52.646992Z","steps":["trace[1576010741] 'process raft request' (duration: 599.47559ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:52.647241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:52.047212Z","time spent":"599.92165ms","remote":"127.0.0.1:51718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7684,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-09T02:24:52.647322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:52.045102Z","time spent":"601.928905ms","remote":"127.0.0.1:51718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:24:52.648243Z","caller":"traceutil/trace.go:171","msg":"trace[2028068731] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"607.8933ms","start":"2026-10-09T02:24:52.040192Z","end":"2026-10-09T02:24:52.648086Z","steps":["trace[2028068731] 'process raft request' (duration: 606.13096ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:52.648419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:52.040179Z","time spent":"608.153956ms","remote":"127.0.0.1:51718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:24:52.649292Z","caller":"traceutil/trace.go:171","msg":"trace[1001190055] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"600.939753ms","start":"2026-10-09T02:24:52.048329Z","end":"2026-10-09T02:24:52.649268Z","steps":["trace[1001190055] 'process raft request' (duration: 600.679327ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:52.649403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:52.048306Z","time spent":"601.039315ms","remote":"127.0.0.1:51718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:24:52.649585Z","caller":"traceutil/trace.go:171","msg":"trace[1270577603] linearizableReadLoop","detail":"{readStateIndex:564; appliedIndex:556; }","duration":"288.497316ms","start":"2026-10-09T02:24:52.361072Z","end":"2026-10-09T02:24:52.649569Z","steps":["trace[1270577603] 'read index received' (duration: 285.112689ms)","trace[1270577603] 'applied index is now lower than readState.Index' (duration: 3.383897ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:24:52.649627Z","caller":"traceutil/trace.go:171","msg":"trace[1927598299] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"593.688179ms","start":"2026-10-09T02:24:52.055925Z","end":"2026-10-09T02:24:52.649613Z","steps":["trace[1927598299] 'process raft request' (duration: 593.456373ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:52.649716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:52.055874Z","time spent":"593.811371ms","remote":"127.0.0.1:51718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-09T02:24:52.64983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.760351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-09T02:24:52.64987Z","caller":"traceutil/trace.go:171","msg":"trace[1081650701] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:537; }","duration":"288.833644ms","start":"2026-10-09T02:24:52.361026Z","end":"2026-10-09T02:24:52.64986Z","steps":["trace[1081650701] 'agreement among raft nodes before linearized reading' (duration: 288.741601ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:52.649952Z","caller":"traceutil/trace.go:171","msg":"trace[290975557] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"598.008357ms","start":"2026-10-09T02:24:52.051921Z","end":"2026-10-09T02:24:52.64993Z","steps":["trace[290975557] 'process raft request' (duration: 597.198389ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:52.650028Z","caller":"traceutil/trace.go:171","msg":"trace[252163466] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"449.557258ms","start":"2026-10-09T02:24:52.200413Z","end":"2026-10-09T02:24:52.64997Z","steps":["trace[252163466] 'process raft request' (duration: 449.096877ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:52.650117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:52.051913Z","time spent":"598.087649ms","remote":"127.0.0.1:51718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-09T02:24:52.650166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.011351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-10-09T02:24:52.650187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:52.200379Z","time spent":"449.732233ms","remote":"127.0.0.1:51718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-09T02:24:52.650198Z","caller":"traceutil/trace.go:171","msg":"trace[1278412788] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:537; }","duration":"279.082363ms","start":"2026-10-09T02:24:52.371106Z","end":"2026-10-09T02:24:52.650189Z","steps":["trace[1278412788] 'agreement among raft nodes before linearized reading' (duration: 279.021462ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:52.650365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.95762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-09T02:24:52.65041Z","caller":"traceutil/trace.go:171","msg":"trace[358627832] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:537; }","duration":"279.018691ms","start":"2026-10-09T02:24:52.371378Z","end":"2026-10-09T02:24:52.650396Z","steps":["trace[358627832] 'agreement among raft nodes before linearized reading' (duration: 278.925379ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:52.650429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.911767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-10-09T02:24:52.650457Z","caller":"traceutil/trace.go:171","msg":"trace[998478509] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:537; }","duration":"277.952988ms","start":"2026-10-09T02:24:52.372494Z","end":"2026-10-09T02:24:52.650447Z","steps":["trace[998478509] 'agreement among raft nodes before linearized reading' (duration: 277.902807ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:52.649694Z","caller":"traceutil/trace.go:171","msg":"trace[415892622] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"587.60124ms","start":"2026-10-09T02:24:52.062083Z","end":"2026-10-09T02:24:52.649684Z","steps":["trace[415892622] 'process raft request' (duration: 587.353525ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:52.650943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:52.062072Z","time spent":"588.826548ms","remote":"127.0.0.1:51718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-09T02:24:54.084808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.857683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:23081"} {"level":"info","ts":"2026-10-09T02:24:54.084936Z","caller":"traceutil/trace.go:171","msg":"trace[665316154] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:588; }","duration":"144.038307ms","start":"2026-10-09T02:24:53.940875Z","end":"2026-10-09T02:24:54.084913Z","steps":["trace[665316154] 'range keys from in-memory index tree' (duration: 143.543567ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:54.127126Z","caller":"traceutil/trace.go:171","msg":"trace[515282504] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"162.419584ms","start":"2026-10-09T02:24:53.964677Z","end":"2026-10-09T02:24:54.127097Z","steps":["trace[515282504] 'process raft request' (duration: 162.062565ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:54.424752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.339021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:65436"} {"level":"info","ts":"2026-10-09T02:24:54.424909Z","caller":"traceutil/trace.go:171","msg":"trace[1090071603] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:589; }","duration":"219.531766ms","start":"2026-10-09T02:24:54.205317Z","end":"2026-10-09T02:24:54.424849Z","steps":["trace[1090071603] 'range keys from in-memory index tree' (duration: 219.020234ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:54.816357Z","caller":"traceutil/trace.go:171","msg":"trace[2119950870] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"136.506228ms","start":"2026-10-09T02:24:54.679826Z","end":"2026-10-09T02:24:54.816332Z","steps":["trace[2119950870] 'process raft request' (duration: 136.467377ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:54.816459Z","caller":"traceutil/trace.go:171","msg":"trace[27067559] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"137.472709ms","start":"2026-10-09T02:24:54.678962Z","end":"2026-10-09T02:24:54.816435Z","steps":["trace[27067559] 'process raft request' (duration: 101.22398ms)","trace[27067559] 'compare' (duration: 35.963103ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:24:54.816574Z","caller":"traceutil/trace.go:171","msg":"trace[1082626323] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"137.527671ms","start":"2026-10-09T02:24:54.679007Z","end":"2026-10-09T02:24:54.816535Z","steps":["trace[1082626323] 'process raft request' (duration: 137.256945ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:24:59.965341Z","caller":"traceutil/trace.go:171","msg":"trace[1510526740] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"379.30243ms","start":"2026-10-09T02:24:59.586011Z","end":"2026-10-09T02:24:59.965313Z","steps":["trace[1510526740] 'process raft request' (duration: 379.130616ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:24:59.965557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:59.58599Z","time spent":"379.495464ms","remote":"127.0.0.1:51834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-09T02:25:00.199865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.297353ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-09T02:25:00.200449Z","caller":"traceutil/trace.go:171","msg":"trace[1181061731] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"349.576607ms","start":"2026-10-09T02:24:59.850686Z","end":"2026-10-09T02:25:00.200262Z","steps":["trace[1181061731] 'process raft request' (duration: 231.788123ms)","trace[1181061731] 'compare' (duration: 117.13634ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:25:00.200645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:24:59.850631Z","time spent":"349.893804ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:25:00.201396Z","caller":"traceutil/trace.go:171","msg":"trace[786152530] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"220.831885ms","start":"2026-10-09T02:24:59.980545Z","end":"2026-10-09T02:25:00.201377Z","steps":["trace[786152530] 'process raft request' (duration: 220.258843ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:00.952202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.584925ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-09T02:25:00.952294Z","caller":"traceutil/trace.go:171","msg":"trace[233056327] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"505.74224ms","start":"2026-10-09T02:25:00.446535Z","end":"2026-10-09T02:25:00.952277Z","steps":["trace[233056327] 'read index received' (duration: 397.011081ms)","trace[233056327] 'applied index is now lower than readState.Index' (duration: 108.730109ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:25:00.952371Z","caller":"traceutil/trace.go:171","msg":"trace[379193158] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"678.232061ms","start":"2026-10-09T02:25:00.274129Z","end":"2026-10-09T02:25:00.952361Z","steps":["trace[379193158] 'process raft request' (duration: 569.41956ms)","trace[379193158] 'compare' (duration: 108.269949ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:25:00.952414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:25:00.2741Z","time spent":"678.292321ms","remote":"127.0.0.1:51876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-09T02:25:00.952843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.309453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:25:00.952882Z","caller":"traceutil/trace.go:171","msg":"trace[813332303] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:626; }","duration":"506.352054ms","start":"2026-10-09T02:25:00.44652Z","end":"2026-10-09T02:25:00.952872Z","steps":["trace[813332303] 'agreement among raft nodes before linearized reading' (duration: 506.294572ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:00.952914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:25:00.446458Z","time spent":"506.449705ms","remote":"127.0.0.1:51670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-09T02:25:00.952911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.33299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-09T02:25:00.952966Z","caller":"traceutil/trace.go:171","msg":"trace[1330793289] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:626; }","duration":"104.424202ms","start":"2026-10-09T02:25:00.848527Z","end":"2026-10-09T02:25:00.952951Z","steps":["trace[1330793289] 'agreement among raft nodes before linearized reading' (duration: 104.238558ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:00.953207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.48933ms","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-10-09T02:25:00.953313Z","caller":"traceutil/trace.go:171","msg":"trace[250565509] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:626; }","duration":"103.661085ms","start":"2026-10-09T02:25:00.849624Z","end":"2026-10-09T02:25:00.953285Z","steps":["trace[250565509] 'agreement among raft nodes before linearized reading' (duration: 103.118833ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:00.953836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.607008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-09T02:25:00.953936Z","caller":"traceutil/trace.go:171","msg":"trace[1764517318] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:626; }","duration":"227.761762ms","start":"2026-10-09T02:25:00.726153Z","end":"2026-10-09T02:25:00.953915Z","steps":["trace[1764517318] 'agreement among raft nodes before linearized reading' (duration: 226.279458ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:01.460855Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14256884722654444133,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-09T02:25:01.961421Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14256884722654444133,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-09T02:25:02.230306Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.272163796s","expected-duration":"1s"} {"level":"warn","ts":"2026-10-09T02:25:02.466113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.16541ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-09T02:25:02.466494Z","caller":"traceutil/trace.go:171","msg":"trace[750262262] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"1.508450741s","start":"2026-10-09T02:25:00.958002Z","end":"2026-10-09T02:25:02.466453Z","steps":["trace[750262262] 'process raft request' (duration: 1.272647787s)","trace[750262262] 'compare' (duration: 235.059526ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:25:02.466649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:25:00.95797Z","time spent":"1.508600284s","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:25:02.466868Z","caller":"traceutil/trace.go:171","msg":"trace[549261240] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"1.507828546s","start":"2026-10-09T02:25:00.959011Z","end":"2026-10-09T02:25:02.466839Z","steps":["trace[549261240] 'process raft request' (duration: 1.507350006s)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:02.466976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:25:00.958994Z","time spent":"1.507932868s","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:25:02.467161Z","caller":"traceutil/trace.go:171","msg":"trace[538834516] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"1.507694563s","start":"2026-10-09T02:25:00.959454Z","end":"2026-10-09T02:25:02.467148Z","steps":["trace[538834516] 'process raft request' (duration: 1.50711392s)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:02.467304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:25:00.959422Z","time spent":"1.507774805s","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:25:02.467568Z","caller":"traceutil/trace.go:171","msg":"trace[1023922241] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"1.506639099s","start":"2026-10-09T02:25:00.960918Z","end":"2026-10-09T02:25:02.467557Z","steps":["trace[1023922241] 'process raft request' (duration: 1.505871962s)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:02.467638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:25:00.960898Z","time spent":"1.5067073s","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:25:02.477753Z","caller":"traceutil/trace.go:171","msg":"trace[339148502] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:654; }","duration":"1.517944375s","start":"2026-10-09T02:25:00.959789Z","end":"2026-10-09T02:25:02.477734Z","steps":["trace[339148502] 'read index received' (duration: 1.270818535s)","trace[339148502] 'applied index is now lower than readState.Index' (duration: 247.12481ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:25:02.477933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.518134529s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-10-09T02:25:02.47797Z","caller":"traceutil/trace.go:171","msg":"trace[552493048] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:630; }","duration":"1.518212071s","start":"2026-10-09T02:25:00.959748Z","end":"2026-10-09T02:25:02.47796Z","steps":["trace[552493048] 'agreement among raft nodes before linearized reading' (duration: 1.518132609s)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:02.477999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:25:00.959704Z","time spent":"1.518287962s","remote":"127.0.0.1:51858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-10-09T02:25:02.478363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.031663076s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:25:02.478401Z","caller":"traceutil/trace.go:171","msg":"trace[1988904359] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"1.031756467s","start":"2026-10-09T02:25:01.446634Z","end":"2026-10-09T02:25:02.478391Z","steps":["trace[1988904359] 'agreement among raft nodes before linearized reading' (duration: 1.031656675s)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:02.478426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:25:01.446608Z","time spent":"1.031811839s","remote":"127.0.0.1:51658","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-10-09T02:25:04.983702Z","caller":"traceutil/trace.go:171","msg":"trace[1695633920] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"208.280851ms","start":"2026-10-09T02:25:04.775358Z","end":"2026-10-09T02:25:04.983639Z","steps":["trace[1695633920] 'process raft request' (duration: 208.101837ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:18.070751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.581585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-8rl49\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-10-09T02:25:18.070844Z","caller":"traceutil/trace.go:171","msg":"trace[1461815050] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-8rl49; range_end:; response_count:1; response_revision:783; }","duration":"394.73096ms","start":"2026-10-09T02:25:17.676092Z","end":"2026-10-09T02:25:18.070823Z","steps":["trace[1461815050] 'range keys from in-memory index tree' (duration: 394.378461ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:18.070885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:25:17.67607Z","time spent":"394.805252ms","remote":"127.0.0.1:51834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-8rl49\" "} {"level":"info","ts":"2026-10-09T02:25:18.737791Z","caller":"traceutil/trace.go:171","msg":"trace[308930402] linearizableReadLoop","detail":"{readStateIndex:818; appliedIndex:817; }","duration":"291.744132ms","start":"2026-10-09T02:25:18.446025Z","end":"2026-10-09T02:25:18.737769Z","steps":["trace[308930402] 'read index received' (duration: 291.65315ms)","trace[308930402] 'applied index is now lower than readState.Index' (duration: 90.032µs)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:25:18.737885Z","caller":"traceutil/trace.go:171","msg":"trace[1267013602] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"658.267946ms","start":"2026-10-09T02:25:18.079612Z","end":"2026-10-09T02:25:18.73788Z","steps":["trace[1267013602] 'process raft request' (duration: 658.02222ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:18.737982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:25:18.079584Z","time spent":"658.317976ms","remote":"127.0.0.1:51834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-09T02:25:18.738016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.224934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-09T02:25:18.738127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.828672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-09T02:25:18.738134Z","caller":"traceutil/trace.go:171","msg":"trace[561953300] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:784; }","duration":"281.400908ms","start":"2026-10-09T02:25:18.45671Z","end":"2026-10-09T02:25:18.738111Z","steps":["trace[561953300] 'agreement among raft nodes before linearized reading' (duration: 281.213414ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:18.738213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.825095ms","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-10-09T02:25:18.738232Z","caller":"traceutil/trace.go:171","msg":"trace[1002212545] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:784; }","duration":"141.878947ms","start":"2026-10-09T02:25:18.596349Z","end":"2026-10-09T02:25:18.738228Z","steps":["trace[1002212545] 'agreement among raft nodes before linearized reading' (duration: 141.815405ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:18.738406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.383667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:25:18.73844Z","caller":"traceutil/trace.go:171","msg":"trace[1018391230] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:784; }","duration":"292.441309ms","start":"2026-10-09T02:25:18.445979Z","end":"2026-10-09T02:25:18.73842Z","steps":["trace[1018391230] 'agreement among raft nodes before linearized reading' (duration: 292.411879ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:18.738561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.032628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-09T02:25:18.738154Z","caller":"traceutil/trace.go:171","msg":"trace[661398110] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:784; }","duration":"154.894264ms","start":"2026-10-09T02:25:18.583253Z","end":"2026-10-09T02:25:18.738147Z","steps":["trace[661398110] 'agreement among raft nodes before linearized reading' (duration: 154.808402ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:25:18.738622Z","caller":"traceutil/trace.go:171","msg":"trace[602175090] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:784; }","duration":"278.131521ms","start":"2026-10-09T02:25:18.460476Z","end":"2026-10-09T02:25:18.738608Z","steps":["trace[602175090] 'agreement among raft nodes before linearized reading' (duration: 277.946106ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:25:20.893266Z","caller":"traceutil/trace.go:171","msg":"trace[883384290] linearizableReadLoop","detail":"{readStateIndex:830; appliedIndex:829; }","duration":"135.145027ms","start":"2026-10-09T02:25:20.758092Z","end":"2026-10-09T02:25:20.893237Z","steps":["trace[883384290] 'read index received' (duration: 134.999184ms)","trace[883384290] 'applied index is now lower than readState.Index' (duration: 144.723µs)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:25:20.893299Z","caller":"traceutil/trace.go:171","msg":"trace[1278739724] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"135.796793ms","start":"2026-10-09T02:25:20.757484Z","end":"2026-10-09T02:25:20.893281Z","steps":["trace[1278739724] 'process raft request' (duration: 135.603939ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:20.893499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.372683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-09T02:25:20.893615Z","caller":"traceutil/trace.go:171","msg":"trace[1186560146] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:796; }","duration":"135.583508ms","start":"2026-10-09T02:25:20.758014Z","end":"2026-10-09T02:25:20.893597Z","steps":["trace[1186560146] 'agreement among raft nodes before linearized reading' (duration: 135.321471ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:25:20.937451Z","caller":"traceutil/trace.go:171","msg":"trace[42198346] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"177.0393ms","start":"2026-10-09T02:25:20.760362Z","end":"2026-10-09T02:25:20.937401Z","steps":["trace[42198346] 'process raft request' (duration: 176.927917ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:25:20.937482Z","caller":"traceutil/trace.go:171","msg":"trace[170038435] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"177.224114ms","start":"2026-10-09T02:25:20.760219Z","end":"2026-10-09T02:25:20.937443Z","steps":["trace[170038435] 'process raft request' (duration: 176.949337ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:25:20.93766Z","caller":"traceutil/trace.go:171","msg":"trace[1435479484] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"176.149178ms","start":"2026-10-09T02:25:20.761427Z","end":"2026-10-09T02:25:20.937576Z","steps":["trace[1435479484] 'process raft request' (duration: 175.931383ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:25:28.04843Z","caller":"traceutil/trace.go:171","msg":"trace[481914737] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"125.777757ms","start":"2026-10-09T02:25:27.922624Z","end":"2026-10-09T02:25:28.048402Z","steps":["trace[481914737] 'process raft request' (duration: 58.7189ms)","trace[481914737] 'compare' (duration: 66.920384ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:25:28.080128Z","caller":"traceutil/trace.go:171","msg":"trace[1083928347] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"157.078157ms","start":"2026-10-09T02:25:27.923023Z","end":"2026-10-09T02:25:28.080101Z","steps":["trace[1083928347] 'process raft request' (duration: 156.877322ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:25:28.080493Z","caller":"traceutil/trace.go:171","msg":"trace[1910216288] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"155.029829ms","start":"2026-10-09T02:25:27.925438Z","end":"2026-10-09T02:25:28.080468Z","steps":["trace[1910216288] 'process raft request' (duration: 154.604038ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:25:28.080501Z","caller":"traceutil/trace.go:171","msg":"trace[1333334413] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"149.241912ms","start":"2026-10-09T02:25:27.931228Z","end":"2026-10-09T02:25:28.08047Z","steps":["trace[1333334413] 'process raft request' (duration: 149.128798ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:25:31.14799Z","caller":"traceutil/trace.go:171","msg":"trace[977886194] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"107.974965ms","start":"2026-10-09T02:25:31.039978Z","end":"2026-10-09T02:25:31.147953Z","steps":["trace[977886194] 'process raft request' (duration: 76.439519ms)","trace[977886194] 'compare' (duration: 31.27256ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:25:33.387803Z","caller":"traceutil/trace.go:171","msg":"trace[508989554] linearizableReadLoop","detail":"{readStateIndex:958; appliedIndex:957; }","duration":"140.894924ms","start":"2026-10-09T02:25:33.246873Z","end":"2026-10-09T02:25:33.387768Z","steps":["trace[508989554] 'read index received' (duration: 97.752583ms)","trace[508989554] 'applied index is now lower than readState.Index' (duration: 43.141001ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:25:33.387854Z","caller":"traceutil/trace.go:171","msg":"trace[474297529] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"168.820884ms","start":"2026-10-09T02:25:33.219Z","end":"2026-10-09T02:25:33.387821Z","steps":["trace[474297529] 'process raft request' (duration: 125.749704ms)","trace[474297529] 'compare' (duration: 42.872645ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:25:33.38811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.020046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-10-09T02:25:33.388129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.229882ms","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-10-09T02:25:33.388175Z","caller":"traceutil/trace.go:171","msg":"trace[1318889654] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:921; }","duration":"141.131068ms","start":"2026-10-09T02:25:33.247029Z","end":"2026-10-09T02:25:33.388161Z","steps":["trace[1318889654] 'agreement among raft nodes before linearized reading' (duration: 140.915773ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:25:33.38822Z","caller":"traceutil/trace.go:171","msg":"trace[1116753450] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:921; }","duration":"141.408086ms","start":"2026-10-09T02:25:33.246788Z","end":"2026-10-09T02:25:33.388196Z","steps":["trace[1116753450] 'agreement among raft nodes before linearized reading' (duration: 141.100599ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:25:33.388325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.302141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-66q5l\" ","response":"range_response_count:1 size:5676"} {"level":"info","ts":"2026-10-09T02:25:33.388434Z","caller":"traceutil/trace.go:171","msg":"trace[1085799876] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-66q5l; range_end:; response_count:1; response_revision:921; }","duration":"127.447306ms","start":"2026-10-09T02:25:33.260951Z","end":"2026-10-09T02:25:33.388398Z","steps":["trace[1085799876] 'agreement among raft nodes before linearized reading' (duration: 127.172389ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:25:49.671533Z","caller":"traceutil/trace.go:171","msg":"trace[2018139760] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"119.746332ms","start":"2026-10-09T02:25:49.551761Z","end":"2026-10-09T02:25:49.671507Z","steps":["trace[2018139760] 'process raft request' (duration: 52.139093ms)","trace[2018139760] 'compare' (duration: 67.397025ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:26:02.050275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.858305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-09T02:26:02.050538Z","caller":"traceutil/trace.go:171","msg":"trace[360936089] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1081; }","duration":"139.196364ms","start":"2026-10-09T02:26:01.9113Z","end":"2026-10-09T02:26:02.050496Z","steps":["trace[360936089] 'range keys from in-memory index tree' (duration: 138.507207ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:02.254068Z","caller":"traceutil/trace.go:171","msg":"trace[1957960973] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"198.286473ms","start":"2026-10-09T02:26:02.05576Z","end":"2026-10-09T02:26:02.254047Z","steps":["trace[1957960973] 'process raft request' (duration: 198.141679ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:04.103175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.084057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-10-09T02:26:04.103242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.951522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-10-09T02:26:04.103177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.302832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:26:04.103306Z","caller":"traceutil/trace.go:171","msg":"trace[1655357920] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1084; }","duration":"657.474797ms","start":"2026-10-09T02:26:03.445823Z","end":"2026-10-09T02:26:04.103298Z","steps":["trace[1655357920] 'range keys from in-memory index tree' (duration: 657.253801ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:04.103312Z","caller":"traceutil/trace.go:171","msg":"trace[2126005857] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1084; }","duration":"659.055005ms","start":"2026-10-09T02:26:03.444242Z","end":"2026-10-09T02:26:04.103297Z","steps":["trace[2126005857] 'range keys from in-memory index tree' (duration: 658.792238ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:04.103334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.687009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-10-09T02:26:04.103349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:03.444224Z","time spent":"659.116106ms","remote":"127.0.0.1:51910","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":"info","ts":"2026-10-09T02:26:04.103381Z","caller":"traceutil/trace.go:171","msg":"trace[890646484] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1084; }","duration":"312.768181ms","start":"2026-10-09T02:26:03.7906Z","end":"2026-10-09T02:26:04.103368Z","steps":["trace[890646484] 'range keys from in-memory index tree' (duration: 312.563047ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:04.103431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:03.790568Z","time spent":"312.855543ms","remote":"127.0.0.1:51910","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":"info","ts":"2026-10-09T02:26:04.103273Z","caller":"traceutil/trace.go:171","msg":"trace[2018009285] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1084; }","duration":"463.200451ms","start":"2026-10-09T02:26:03.640048Z","end":"2026-10-09T02:26:04.103248Z","steps":["trace[2018009285] 'range keys from in-memory index tree' (duration: 462.951943ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:04.103349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:03.445793Z","time spent":"657.547259ms","remote":"127.0.0.1:51658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-09T02:26:04.103561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:03.640037Z","time spent":"463.490957ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-10-09T02:26:04.699951Z","caller":"traceutil/trace.go:171","msg":"trace[134936494] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"591.183088ms","start":"2026-10-09T02:26:04.108741Z","end":"2026-10-09T02:26:04.699924Z","steps":["trace[134936494] 'process raft request' (duration: 591.012385ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:04.700091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:04.108712Z","time spent":"591.303162ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:26:04.718668Z","caller":"traceutil/trace.go:171","msg":"trace[1803027091] linearizableReadLoop","detail":"{readStateIndex:1132; appliedIndex:1129; }","duration":"500.611204ms","start":"2026-10-09T02:26:04.218035Z","end":"2026-10-09T02:26:04.718646Z","steps":["trace[1803027091] 'read index received' (duration: 481.727898ms)","trace[1803027091] 'applied index is now lower than readState.Index' (duration: 18.882136ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:26:04.719029Z","caller":"traceutil/trace.go:171","msg":"trace[2101374852] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"610.245459ms","start":"2026-10-09T02:26:04.108771Z","end":"2026-10-09T02:26:04.719017Z","steps":["trace[2101374852] 'process raft request' (duration: 609.683596ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:04.719125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:04.108752Z","time spent":"610.305461ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:26:04.719314Z","caller":"traceutil/trace.go:171","msg":"trace[65572093] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"610.530716ms","start":"2026-10-09T02:26:04.10877Z","end":"2026-10-09T02:26:04.719301Z","steps":["trace[65572093] 'process raft request' (duration: 609.800228ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:04.719363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:04.108747Z","time spent":"610.587628ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:26:04.719636Z","caller":"traceutil/trace.go:171","msg":"trace[1404921650] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"106.831319ms","start":"2026-10-09T02:26:04.612794Z","end":"2026-10-09T02:26:04.719625Z","steps":["trace[1404921650] 'process raft request' (duration: 105.815864ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:04.719786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.752922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-09T02:26:04.719847Z","caller":"traceutil/trace.go:171","msg":"trace[2023967979] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1088; }","duration":"501.867005ms","start":"2026-10-09T02:26:04.21797Z","end":"2026-10-09T02:26:04.719837Z","steps":["trace[2023967979] 'agreement among raft nodes before linearized reading' (duration: 501.774363ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:04.719877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:04.21795Z","time spent":"501.916936ms","remote":"127.0.0.1:51914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":5,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-10-09T02:26:04.720105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.526033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-09T02:26:04.720154Z","caller":"traceutil/trace.go:171","msg":"trace[1480846209] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1088; }","duration":"462.594785ms","start":"2026-10-09T02:26:04.257536Z","end":"2026-10-09T02:26:04.72013Z","steps":["trace[1480846209] 'agreement among raft nodes before linearized reading' (duration: 462.483923ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:04.720183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:04.257516Z","time spent":"462.661586ms","remote":"127.0.0.1:51910","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-10-09T02:26:12.934933Z","caller":"traceutil/trace.go:171","msg":"trace[1667753223] transaction","detail":"{read_only:false; response_revision:1115; number_of_response:1; }","duration":"123.826609ms","start":"2026-10-09T02:26:12.811082Z","end":"2026-10-09T02:26:12.934909Z","steps":["trace[1667753223] 'process raft request' (duration: 123.222645ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:12.935112Z","caller":"traceutil/trace.go:171","msg":"trace[801017431] transaction","detail":"{read_only:false; response_revision:1116; number_of_response:1; }","duration":"123.957913ms","start":"2026-10-09T02:26:12.811107Z","end":"2026-10-09T02:26:12.935065Z","steps":["trace[801017431] 'process raft request' (duration: 123.763718ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:17.670234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.197426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:26:17.670333Z","caller":"traceutil/trace.go:171","msg":"trace[40023202] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1131; }","duration":"167.36272ms","start":"2026-10-09T02:26:17.502949Z","end":"2026-10-09T02:26:17.670312Z","steps":["trace[40023202] 'count revisions from in-memory index tree' (duration: 167.078463ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:19.271219Z","caller":"traceutil/trace.go:171","msg":"trace[801985188] linearizableReadLoop","detail":"{readStateIndex:1181; appliedIndex:1180; }","duration":"405.926215ms","start":"2026-10-09T02:26:18.86509Z","end":"2026-10-09T02:26:19.271017Z","steps":["trace[801985188] 'read index received' (duration: 405.656658ms)","trace[801985188] 'applied index is now lower than readState.Index' (duration: 268.347µs)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:26:19.271387Z","caller":"traceutil/trace.go:171","msg":"trace[337395355] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"446.209179ms","start":"2026-10-09T02:26:18.825163Z","end":"2026-10-09T02:26:19.271372Z","steps":["trace[337395355] 'process raft request' (duration: 445.658615ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:19.271491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.793799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-10-09T02:26:19.271523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:18.825136Z","time spent":"446.27864ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:26:19.271539Z","caller":"traceutil/trace.go:171","msg":"trace[1706937946] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1133; }","duration":"306.894551ms","start":"2026-10-09T02:26:18.964634Z","end":"2026-10-09T02:26:19.271528Z","steps":["trace[1706937946] 'agreement among raft nodes before linearized reading' (duration: 306.762288ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:19.271564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:18.964612Z","time spent":"306.947493ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-09T02:26:19.271562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.777514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-10-09T02:26:19.271556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.443977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-09T02:26:19.271632Z","caller":"traceutil/trace.go:171","msg":"trace[340926298] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1133; }","duration":"305.881647ms","start":"2026-10-09T02:26:18.965729Z","end":"2026-10-09T02:26:19.271611Z","steps":["trace[340926298] 'agreement among raft nodes before linearized reading' (duration: 305.683593ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:19.271655Z","caller":"traceutil/trace.go:171","msg":"trace[919671340] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1133; }","duration":"406.579979ms","start":"2026-10-09T02:26:18.865049Z","end":"2026-10-09T02:26:19.271629Z","steps":["trace[919671340] 'agreement among raft nodes before linearized reading' (duration: 406.350274ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:19.271676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:18.965713Z","time spent":"305.950388ms","remote":"127.0.0.1:51910","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-10-09T02:26:19.271719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:18.865035Z","time spent":"406.667652ms","remote":"127.0.0.1:51910","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":"info","ts":"2026-10-09T02:26:19.470461Z","caller":"traceutil/trace.go:171","msg":"trace[980274675] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"194.485672ms","start":"2026-10-09T02:26:19.275939Z","end":"2026-10-09T02:26:19.470424Z","steps":["trace[980274675] 'process raft request' (duration: 109.954042ms)","trace[980274675] 'compare' (duration: 84.312395ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:26:19.470873Z","caller":"traceutil/trace.go:171","msg":"trace[829182265] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"194.722647ms","start":"2026-10-09T02:26:19.276094Z","end":"2026-10-09T02:26:19.470817Z","steps":["trace[829182265] 'process raft request' (duration: 194.273387ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:19.470967Z","caller":"traceutil/trace.go:171","msg":"trace[130323223] transaction","detail":"{read_only:false; response_revision:1136; number_of_response:1; }","duration":"194.748048ms","start":"2026-10-09T02:26:19.276199Z","end":"2026-10-09T02:26:19.470947Z","steps":["trace[130323223] 'process raft request' (duration: 194.451291ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:19.470893Z","caller":"traceutil/trace.go:171","msg":"trace[686322483] linearizableReadLoop","detail":"{readStateIndex:1184; appliedIndex:1181; }","duration":"138.581339ms","start":"2026-10-09T02:26:19.332288Z","end":"2026-10-09T02:26:19.47087Z","steps":["trace[686322483] 'read index received' (duration: 53.695411ms)","trace[686322483] 'applied index is now lower than readState.Index' (duration: 84.884828ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:26:19.471094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.801074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-09T02:26:19.471154Z","caller":"traceutil/trace.go:171","msg":"trace[1917679101] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1136; }","duration":"138.925948ms","start":"2026-10-09T02:26:19.332219Z","end":"2026-10-09T02:26:19.471145Z","steps":["trace[1917679101] 'agreement among raft nodes before linearized reading' (duration: 138.714472ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:20.716097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.90519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:26:20.71619Z","caller":"traceutil/trace.go:171","msg":"trace[823206407] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1137; }","duration":"268.060753ms","start":"2026-10-09T02:26:20.448105Z","end":"2026-10-09T02:26:20.716166Z","steps":["trace[823206407] 'range keys from in-memory index tree' (duration: 267.821907ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:21.017449Z","caller":"traceutil/trace.go:171","msg":"trace[309018956] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"184.908175ms","start":"2026-10-09T02:26:20.832494Z","end":"2026-10-09T02:26:21.017402Z","steps":["trace[309018956] 'process raft request' (duration: 184.756132ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:21.498453Z","caller":"traceutil/trace.go:171","msg":"trace[715062817] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"217.066026ms","start":"2026-10-09T02:26:21.281364Z","end":"2026-10-09T02:26:21.49843Z","steps":["trace[715062817] 'process raft request' (duration: 216.833881ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:21.666822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.703581ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-09T02:26:21.667079Z","caller":"traceutil/trace.go:171","msg":"trace[273349926] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"163.512709ms","start":"2026-10-09T02:26:21.503545Z","end":"2026-10-09T02:26:21.667057Z","steps":["trace[273349926] 'process raft request' (duration: 163.392786ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:21.667277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.000563ms","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-10-09T02:26:21.667373Z","caller":"traceutil/trace.go:171","msg":"trace[1313613851] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1140; }","duration":"192.135426ms","start":"2026-10-09T02:26:21.475211Z","end":"2026-10-09T02:26:21.667346Z","steps":["trace[1313613851] 'agreement among raft nodes before linearized reading' (duration: 191.84797ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:21.667468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-09T02:26:21.667532Z","caller":"traceutil/trace.go:171","msg":"trace[67190948] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1140; }","duration":"192.411662ms","start":"2026-10-09T02:26:21.475107Z","end":"2026-10-09T02:26:21.667519Z","steps":["trace[67190948] 'agreement among raft nodes before linearized reading' (duration: 192.186947ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:21.667128Z","caller":"traceutil/trace.go:171","msg":"trace[1537360875] linearizableReadLoop","detail":"{readStateIndex:1188; appliedIndex:1187; }","duration":"168.692872ms","start":"2026-10-09T02:26:21.498349Z","end":"2026-10-09T02:26:21.667042Z","steps":["trace[1537360875] 'read index received' (duration: 65.90748ms)","trace[1537360875] 'applied index is now lower than readState.Index' (duration: 102.780192ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:26:21.668396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.257743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-09T02:26:21.668427Z","caller":"traceutil/trace.go:171","msg":"trace[1653102474] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1140; }","duration":"163.317295ms","start":"2026-10-09T02:26:21.505101Z","end":"2026-10-09T02:26:21.668419Z","steps":["trace[1653102474] 'agreement among raft nodes before linearized reading' (duration: 163.239493ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:21.97856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.326168ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-09T02:26:21.978721Z","caller":"traceutil/trace.go:171","msg":"trace[1133155105] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"307.247114ms","start":"2026-10-09T02:26:21.671451Z","end":"2026-10-09T02:26:21.978698Z","steps":["trace[1133155105] 'process raft request' (duration: 96.705011ms)","trace[1133155105] 'compare' (duration: 210.191665ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:26:21.97878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:21.671431Z","time spent":"307.320207ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:26:21.978827Z","caller":"traceutil/trace.go:171","msg":"trace[799822769] transaction","detail":"{read_only:false; response_revision:1143; number_of_response:1; }","duration":"304.557911ms","start":"2026-10-09T02:26:21.674252Z","end":"2026-10-09T02:26:21.97881Z","steps":["trace[799822769] 'process raft request' (duration: 304.402247ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:21.978923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:21.674237Z","time spent":"304.644903ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-09T02:26:23.821087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.017390901s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-09T02:26:23.82118Z","caller":"traceutil/trace.go:171","msg":"trace[1020603030] linearizableReadLoop","detail":"{readStateIndex:1193; appliedIndex:1192; }","duration":"1.374600137s","start":"2026-10-09T02:26:22.446564Z","end":"2026-10-09T02:26:23.821164Z","steps":["trace[1020603030] 'read index received' (duration: 356.933619ms)","trace[1020603030] 'applied index is now lower than readState.Index' (duration: 1.017664968s)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:26:23.821272Z","caller":"traceutil/trace.go:171","msg":"trace[441483075] transaction","detail":"{read_only:false; response_revision:1144; number_of_response:1; }","duration":"1.748753751s","start":"2026-10-09T02:26:22.072485Z","end":"2026-10-09T02:26:23.821239Z","steps":["trace[441483075] 'process raft request' (duration: 731.096314ms)","trace[441483075] 'compare' (duration: 1.017175887s)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:26:23.821298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.374723869s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:26:23.821378Z","caller":"traceutil/trace.go:171","msg":"trace[91112021] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1144; }","duration":"1.374849413s","start":"2026-10-09T02:26:22.44651Z","end":"2026-10-09T02:26:23.821359Z","steps":["trace[91112021] 'agreement among raft nodes before linearized reading' (duration: 1.374725039s)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:23.821434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:22.446489Z","time spent":"1.374933364s","remote":"127.0.0.1:51658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-09T02:26:23.821751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:22.072461Z","time spent":"1.748899406s","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:26:23.877303Z","caller":"traceutil/trace.go:171","msg":"trace[460749842] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"372.866035ms","start":"2026-10-09T02:26:23.504409Z","end":"2026-10-09T02:26:23.877275Z","steps":["trace[460749842] 'process raft request' (duration: 372.737332ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:23.877459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:23.504384Z","time spent":"372.990569ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:26:24.561717Z","caller":"traceutil/trace.go:171","msg":"trace[569910433] linearizableReadLoop","detail":"{readStateIndex:1195; appliedIndex:1194; }","duration":"740.466763ms","start":"2026-10-09T02:26:23.82122Z","end":"2026-10-09T02:26:24.561687Z","steps":["trace[569910433] 'read index received' (duration: 56.050024ms)","trace[569910433] 'applied index is now lower than readState.Index' (duration: 684.415349ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:26:24.561802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.190866684s","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-10-09T02:26:24.561878Z","caller":"traceutil/trace.go:171","msg":"trace[1419620459] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1145; }","duration":"1.190973337s","start":"2026-10-09T02:26:23.370865Z","end":"2026-10-09T02:26:24.561839Z","steps":["trace[1419620459] 'agreement among raft nodes before linearized reading' (duration: 1.190858814s)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:24.561916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:23.370829Z","time spent":"1.191076478s","remote":"127.0.0.1:43366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-10-09T02:26:24.561897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.892097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-09T02:26:24.561966Z","caller":"traceutil/trace.go:171","msg":"trace[987915539] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1145; }","duration":"889.99664ms","start":"2026-10-09T02:26:23.671951Z","end":"2026-10-09T02:26:24.561948Z","steps":["trace[987915539] 'agreement among raft nodes before linearized reading' (duration: 889.761875ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:24.561977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.540020528s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-10-09T02:26:24.562005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:23.671932Z","time spent":"890.064871ms","remote":"127.0.0.1:51910","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-10-09T02:26:24.561988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"844.736147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-10-09T02:26:24.562053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"738.825067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:26:24.562081Z","caller":"traceutil/trace.go:171","msg":"trace[100131485] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1145; }","duration":"738.886989ms","start":"2026-10-09T02:26:23.823186Z","end":"2026-10-09T02:26:24.562073Z","steps":["trace[100131485] 'agreement among raft nodes before linearized reading' (duration: 738.849458ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:24.56209Z","caller":"traceutil/trace.go:171","msg":"trace[1543695279] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1145; }","duration":"844.85394ms","start":"2026-10-09T02:26:23.717211Z","end":"2026-10-09T02:26:24.562065Z","steps":["trace[1543695279] 'agreement among raft nodes before linearized reading' (duration: 844.500682ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:24.56211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:23.82317Z","time spent":"738.933489ms","remote":"127.0.0.1:51670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-09T02:26:24.56214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:23.71716Z","time spent":"844.971113ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-10-09T02:26:24.562008Z","caller":"traceutil/trace.go:171","msg":"trace[1568218905] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1145; }","duration":"1.5400868s","start":"2026-10-09T02:26:23.021911Z","end":"2026-10-09T02:26:24.561997Z","steps":["trace[1568218905] 'agreement among raft nodes before linearized reading' (duration: 1.539909026s)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:24.562187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:23.02189Z","time spent":"1.540287875s","remote":"127.0.0.1:51910","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-10-09T02:26:24.562271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:23.780875Z","time spent":"781.393349ms","remote":"127.0.0.1:51736","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-10-09T02:26:24.562326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.932079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-10-09T02:26:24.562346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.92413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-09T02:26:24.562354Z","caller":"traceutil/trace.go:171","msg":"trace[1551767234] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1145; }","duration":"578.99896ms","start":"2026-10-09T02:26:23.983346Z","end":"2026-10-09T02:26:24.562345Z","steps":["trace[1551767234] 'agreement among raft nodes before linearized reading' (duration: 578.914748ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:24.562376Z","caller":"traceutil/trace.go:171","msg":"trace[308572368] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1145; }","duration":"579.984151ms","start":"2026-10-09T02:26:23.982381Z","end":"2026-10-09T02:26:24.562365Z","steps":["trace[308572368] 'agreement among raft nodes before linearized reading' (duration: 579.900939ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:24.562407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:23.982362Z","time spent":"580.039643ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-09T02:26:24.562381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:23.983324Z","time spent":"579.050731ms","remote":"127.0.0.1:51910","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":"info","ts":"2026-10-09T02:26:24.757455Z","caller":"traceutil/trace.go:171","msg":"trace[1914312011] transaction","detail":"{read_only:false; response_revision:1148; number_of_response:1; }","duration":"185.752498ms","start":"2026-10-09T02:26:24.571664Z","end":"2026-10-09T02:26:24.757416Z","steps":["trace[1914312011] 'process raft request' (duration: 185.612705ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:24.757518Z","caller":"traceutil/trace.go:171","msg":"trace[67343384] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"190.498034ms","start":"2026-10-09T02:26:24.566969Z","end":"2026-10-09T02:26:24.757467Z","steps":["trace[67343384] 'process raft request' (duration: 190.078934ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:24.757929Z","caller":"traceutil/trace.go:171","msg":"trace[1611491728] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"185.925661ms","start":"2026-10-09T02:26:24.571964Z","end":"2026-10-09T02:26:24.757889Z","steps":["trace[1611491728] 'process raft request' (duration: 185.41491ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:24.758248Z","caller":"traceutil/trace.go:171","msg":"trace[1660111903] linearizableReadLoop","detail":"{readStateIndex:1201; appliedIndex:1195; }","duration":"180.148743ms","start":"2026-10-09T02:26:24.578078Z","end":"2026-10-09T02:26:24.758227Z","steps":["trace[1660111903] 'read index received' (duration: 24.98548ms)","trace[1660111903] 'applied index is now lower than readState.Index' (duration: 155.161993ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:26:24.758222Z","caller":"traceutil/trace.go:171","msg":"trace[294983163] transaction","detail":"{read_only:false; response_revision:1150; number_of_response:1; }","duration":"185.916382ms","start":"2026-10-09T02:26:24.57227Z","end":"2026-10-09T02:26:24.758186Z","steps":["trace[294983163] 'process raft request' (duration: 185.571554ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:24.758392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.290076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:26:24.758437Z","caller":"traceutil/trace.go:171","msg":"trace[1047960457] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1151; }","duration":"180.381207ms","start":"2026-10-09T02:26:24.578043Z","end":"2026-10-09T02:26:24.758424Z","steps":["trace[1047960457] 'agreement among raft nodes before linearized reading' (duration: 180.259495ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:24.758616Z","caller":"traceutil/trace.go:171","msg":"trace[1703878953] transaction","detail":"{read_only:false; response_revision:1151; number_of_response:1; }","duration":"186.220328ms","start":"2026-10-09T02:26:24.572378Z","end":"2026-10-09T02:26:24.758598Z","steps":["trace[1703878953] 'process raft request' (duration: 185.670746ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:25.121126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.520758ms","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-10-09T02:26:25.121204Z","caller":"traceutil/trace.go:171","msg":"trace[913003155] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1151; }","duration":"166.664831ms","start":"2026-10-09T02:26:24.954519Z","end":"2026-10-09T02:26:25.121184Z","steps":["trace[913003155] 'count revisions from in-memory index tree' (duration: 166.408585ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:26.265924Z","caller":"traceutil/trace.go:171","msg":"trace[1231224472] transaction","detail":"{read_only:false; response_revision:1152; number_of_response:1; }","duration":"383.168055ms","start":"2026-10-09T02:26:25.882722Z","end":"2026-10-09T02:26:26.26589Z","steps":["trace[1231224472] 'process raft request' (duration: 382.893839ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:26.266103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:25.882694Z","time spent":"383.30044ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-09T02:26:26.516906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.607427ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-09T02:26:26.517139Z","caller":"traceutil/trace.go:171","msg":"trace[1245604979] transaction","detail":"{read_only:false; response_revision:1153; number_of_response:1; }","duration":"216.200789ms","start":"2026-10-09T02:26:26.300883Z","end":"2026-10-09T02:26:26.517084Z","steps":["trace[1245604979] 'process raft request' (duration: 71.264515ms)","trace[1245604979] 'compare' (duration: 144.343851ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:26:26.959373Z","caller":"traceutil/trace.go:171","msg":"trace[1406933339] transaction","detail":"{read_only:false; response_revision:1157; number_of_response:1; }","duration":"163.188943ms","start":"2026-10-09T02:26:26.796167Z","end":"2026-10-09T02:26:26.959356Z","steps":["trace[1406933339] 'process raft request' (duration: 163.128841ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:26.959662Z","caller":"traceutil/trace.go:171","msg":"trace[1845712121] transaction","detail":"{read_only:false; response_revision:1158; number_of_response:1; }","duration":"163.119161ms","start":"2026-10-09T02:26:26.796414Z","end":"2026-10-09T02:26:26.959533Z","steps":["trace[1845712121] 'process raft request' (duration: 162.904037ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:26.959737Z","caller":"traceutil/trace.go:171","msg":"trace[1332913531] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"163.216403ms","start":"2026-10-09T02:26:26.796506Z","end":"2026-10-09T02:26:26.959722Z","steps":["trace[1332913531] 'process raft request' (duration: 162.998879ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:26.959405Z","caller":"traceutil/trace.go:171","msg":"trace[1092851500] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"163.322945ms","start":"2026-10-09T02:26:26.796071Z","end":"2026-10-09T02:26:26.959394Z","steps":["trace[1092851500] 'process raft request' (duration: 163.189982ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:26.960397Z","caller":"traceutil/trace.go:171","msg":"trace[2105416975] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"163.356827ms","start":"2026-10-09T02:26:26.79596Z","end":"2026-10-09T02:26:26.959316Z","steps":["trace[2105416975] 'process raft request' (duration: 155.46921ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:27.433173Z","caller":"traceutil/trace.go:171","msg":"trace[1204485482] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"107.943426ms","start":"2026-10-09T02:26:27.325211Z","end":"2026-10-09T02:26:27.433154Z","steps":["trace[1204485482] 'process raft request' (duration: 92.250475ms)","trace[1204485482] 'compare' (duration: 15.594159ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:26:35.373206Z","caller":"traceutil/trace.go:171","msg":"trace[1936653138] linearizableReadLoop","detail":"{readStateIndex:1272; appliedIndex:1271; }","duration":"312.158287ms","start":"2026-10-09T02:26:35.061021Z","end":"2026-10-09T02:26:35.373179Z","steps":["trace[1936653138] 'read index received' (duration: 311.907922ms)","trace[1936653138] 'applied index is now lower than readState.Index' (duration: 249.245µs)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:26:35.373244Z","caller":"traceutil/trace.go:171","msg":"trace[679984253] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"342.133467ms","start":"2026-10-09T02:26:35.031072Z","end":"2026-10-09T02:26:35.373206Z","steps":["trace[679984253] 'process raft request' (duration: 341.947913ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:35.373431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:35.031042Z","time spent":"342.26485ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-09T02:26:35.37356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.518725ms","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-10-09T02:26:35.373615Z","caller":"traceutil/trace.go:171","msg":"trace[1386584175] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1220; }","duration":"312.658227ms","start":"2026-10-09T02:26:35.060944Z","end":"2026-10-09T02:26:35.373602Z","steps":["trace[1386584175] 'agreement among raft nodes before linearized reading' (duration: 312.406902ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:35.373666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:35.06093Z","time spent":"312.7286ms","remote":"127.0.0.1:51910","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-10-09T02:26:35.373693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.467831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-10-09T02:26:35.373556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.977423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-09T02:26:35.373749Z","caller":"traceutil/trace.go:171","msg":"trace[1359365123] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1220; }","duration":"311.537132ms","start":"2026-10-09T02:26:35.062194Z","end":"2026-10-09T02:26:35.373731Z","steps":["trace[1359365123] 'agreement among raft nodes before linearized reading' (duration: 311.41705ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:35.373761Z","caller":"traceutil/trace.go:171","msg":"trace[1963091232] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1220; }","duration":"312.226019ms","start":"2026-10-09T02:26:35.061524Z","end":"2026-10-09T02:26:35.37375Z","steps":["trace[1963091232] 'agreement among raft nodes before linearized reading' (duration: 311.854281ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:35.373791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:35.061513Z","time spent":"312.269829ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-09T02:26:35.373892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:35.062186Z","time spent":"311.600983ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-09T02:26:35.373942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.356532ms","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-10-09T02:26:35.374002Z","caller":"traceutil/trace.go:171","msg":"trace[1898761930] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1220; }","duration":"312.438444ms","start":"2026-10-09T02:26:35.061546Z","end":"2026-10-09T02:26:35.373984Z","steps":["trace[1898761930] 'agreement among raft nodes before linearized reading' (duration: 312.258269ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:35.374063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:35.061534Z","time spent":"312.498115ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-09T02:26:35.947243Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14256884722654445432,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-09T02:26:36.286791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.34889ms","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-10-09T02:26:36.286904Z","caller":"traceutil/trace.go:171","msg":"trace[970587322] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1220; }","duration":"605.473083ms","start":"2026-10-09T02:26:35.681414Z","end":"2026-10-09T02:26:36.286887Z","steps":["trace[970587322] 'range keys from in-memory index tree' (duration: 605.333258ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:36.288346Z","caller":"traceutil/trace.go:171","msg":"trace[1178492142] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"909.711832ms","start":"2026-10-09T02:26:35.378604Z","end":"2026-10-09T02:26:36.288316Z","steps":["trace[1178492142] 'process raft request' (duration: 909.574989ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:36.288494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:35.378573Z","time spent":"909.851435ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:26:36.290352Z","caller":"traceutil/trace.go:171","msg":"trace[1790065288] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"911.185965ms","start":"2026-10-09T02:26:35.379147Z","end":"2026-10-09T02:26:36.290333Z","steps":["trace[1790065288] 'process raft request' (duration: 910.878348ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:36.290464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:35.37913Z","time spent":"911.267357ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:26:36.29059Z","caller":"traceutil/trace.go:171","msg":"trace[180674845] linearizableReadLoop","detail":"{readStateIndex:1276; appliedIndex:1272; }","duration":"843.629992ms","start":"2026-10-09T02:26:35.446939Z","end":"2026-10-09T02:26:36.290569Z","steps":["trace[180674845] 'read index received' (duration: 841.356641ms)","trace[180674845] 'applied index is now lower than readState.Index' (duration: 2.271971ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:26:36.290772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.842677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-09T02:26:36.290961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.193618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-10-09T02:26:36.290972Z","caller":"traceutil/trace.go:171","msg":"trace[110159418] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"911.588204ms","start":"2026-10-09T02:26:35.379362Z","end":"2026-10-09T02:26:36.29095Z","steps":["trace[110159418] 'process raft request' (duration: 910.752056ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:36.291032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.962303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:26:36.291059Z","caller":"traceutil/trace.go:171","msg":"trace[244455387] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1224; }","duration":"211.014633ms","start":"2026-10-09T02:26:36.080035Z","end":"2026-10-09T02:26:36.291049Z","steps":["trace[244455387] 'agreement among raft nodes before linearized reading' (duration: 210.975242ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:36.291085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:35.37935Z","time spent":"911.668007ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:26:36.290992Z","caller":"traceutil/trace.go:171","msg":"trace[365689856] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1224; }","duration":"644.256231ms","start":"2026-10-09T02:26:35.646724Z","end":"2026-10-09T02:26:36.290981Z","steps":["trace[365689856] 'agreement among raft nodes before linearized reading' (duration: 644.108146ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:36.291487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:35.646703Z","time spent":"644.769332ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-10-09T02:26:36.291573Z","caller":"traceutil/trace.go:171","msg":"trace[503931208] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"912.188208ms","start":"2026-10-09T02:26:35.379361Z","end":"2026-10-09T02:26:36.291549Z","steps":["trace[503931208] 'process raft request' (duration: 911.124964ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:36.291665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:35.379336Z","time spent":"912.28063ms","remote":"127.0.0.1:51910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-09T02:26:36.291699Z","caller":"traceutil/trace.go:171","msg":"trace[684009792] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1224; }","duration":"843.915359ms","start":"2026-10-09T02:26:35.446879Z","end":"2026-10-09T02:26:36.290795Z","steps":["trace[684009792] 'agreement among raft nodes before linearized reading' (duration: 843.860197ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:36.29174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-09T02:26:35.446837Z","time spent":"844.892071ms","remote":"127.0.0.1:51658","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-10-09T02:26:38.502695Z","caller":"traceutil/trace.go:171","msg":"trace[238826874] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"205.886698ms","start":"2026-10-09T02:26:38.296775Z","end":"2026-10-09T02:26:38.502662Z","steps":["trace[238826874] 'process raft request' (duration: 205.465099ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:38.502573Z","caller":"traceutil/trace.go:171","msg":"trace[1678340552] linearizableReadLoop","detail":"{readStateIndex:1298; appliedIndex:1297; }","duration":"204.719712ms","start":"2026-10-09T02:26:38.297799Z","end":"2026-10-09T02:26:38.502518Z","steps":["trace[1678340552] 'read index received' (duration: 204.597509ms)","trace[1678340552] 'applied index is now lower than readState.Index' (duration: 121.173µs)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:26:38.50301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.180241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-09T02:26:38.503094Z","caller":"traceutil/trace.go:171","msg":"trace[791743379] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1245; }","duration":"205.323185ms","start":"2026-10-09T02:26:38.297748Z","end":"2026-10-09T02:26:38.503071Z","steps":["trace[791743379] 'agreement among raft nodes before linearized reading' (duration: 205.036699ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:38.504472Z","caller":"traceutil/trace.go:171","msg":"trace[136180516] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"206.319608ms","start":"2026-10-09T02:26:38.298122Z","end":"2026-10-09T02:26:38.504441Z","steps":["trace[136180516] 'process raft request' (duration: 206.162724ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:38.504593Z","caller":"traceutil/trace.go:171","msg":"trace[183753678] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"204.739772ms","start":"2026-10-09T02:26:38.299835Z","end":"2026-10-09T02:26:38.504575Z","steps":["trace[183753678] 'process raft request' (duration: 204.547418ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:26:38.504661Z","caller":"traceutil/trace.go:171","msg":"trace[752016339] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"169.257318ms","start":"2026-10-09T02:26:38.335352Z","end":"2026-10-09T02:26:38.504609Z","steps":["trace[752016339] 'process raft request' (duration: 169.066103ms)"],"step_count":1} {"level":"warn","ts":"2026-10-09T02:26:38.505107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.797086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:26:38.505157Z","caller":"traceutil/trace.go:171","msg":"trace[1793688834] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1248; }","duration":"188.884238ms","start":"2026-10-09T02:26:38.31626Z","end":"2026-10-09T02:26:38.505144Z","steps":["trace[1793688834] 'agreement among raft nodes before linearized reading' (duration: 188.231883ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:27:25.081159Z","caller":"traceutil/trace.go:171","msg":"trace[664598669] transaction","detail":"{read_only:false; response_revision:1464; number_of_response:1; }","duration":"122.669555ms","start":"2026-10-09T02:27:24.958464Z","end":"2026-10-09T02:27:25.081134Z","steps":["trace[664598669] 'process raft request' (duration: 90.422163ms)","trace[664598669] 'compare' (duration: 32.084608ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:27:25.081463Z","caller":"traceutil/trace.go:171","msg":"trace[1130088916] transaction","detail":"{read_only:false; response_revision:1465; number_of_response:1; }","duration":"122.050052ms","start":"2026-10-09T02:27:24.959398Z","end":"2026-10-09T02:27:25.081448Z","steps":["trace[1130088916] 'process raft request' (duration: 121.696944ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:27:35.222612Z","caller":"traceutil/trace.go:171","msg":"trace[1423097552] transaction","detail":"{read_only:false; response_revision:1509; number_of_response:1; }","duration":"135.562256ms","start":"2026-10-09T02:27:35.087029Z","end":"2026-10-09T02:27:35.222592Z","steps":["trace[1423097552] 'process raft request' (duration: 135.368442ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:27:35.362819Z","caller":"traceutil/trace.go:171","msg":"trace[1136153483] transaction","detail":"{read_only:false; response_revision:1511; number_of_response:1; }","duration":"135.648047ms","start":"2026-10-09T02:27:35.227132Z","end":"2026-10-09T02:27:35.36278Z","steps":["trace[1136153483] 'process raft request' (duration: 72.773085ms)","trace[1136153483] 'compare' (duration: 62.737429ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:27:35.551386Z","caller":"traceutil/trace.go:171","msg":"trace[1055004276] linearizableReadLoop","detail":"{readStateIndex:1576; appliedIndex:1575; }","duration":"105.7393ms","start":"2026-10-09T02:27:35.445622Z","end":"2026-10-09T02:27:35.551361Z","steps":["trace[1055004276] 'read index received' (duration: 51.10247ms)","trace[1055004276] 'applied index is now lower than readState.Index' (duration: 54.63585ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:27:35.55146Z","caller":"traceutil/trace.go:171","msg":"trace[1412196711] transaction","detail":"{read_only:false; response_revision:1512; number_of_response:1; }","duration":"127.917685ms","start":"2026-10-09T02:27:35.423506Z","end":"2026-10-09T02:27:35.551424Z","steps":["trace[1412196711] 'process raft request' (duration: 73.275495ms)","trace[1412196711] 'compare' (duration: 54.463156ms)"],"step_count":2} {"level":"warn","ts":"2026-10-09T02:27:35.551508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.865093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-09T02:27:35.551541Z","caller":"traceutil/trace.go:171","msg":"trace[1671822350] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1512; }","duration":"105.962995ms","start":"2026-10-09T02:27:35.445568Z","end":"2026-10-09T02:27:35.551531Z","steps":["trace[1671822350] 'agreement among raft nodes before linearized reading' (duration: 105.882143ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:28:53.771496Z","caller":"traceutil/trace.go:171","msg":"trace[1389549203] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"100.635124ms","start":"2026-10-09T02:28:53.670827Z","end":"2026-10-09T02:28:53.771462Z","steps":["trace[1389549203] 'process raft request' (duration: 29.304823ms)","trace[1389549203] 'compare' (duration: 70.914862ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:29:07.815052Z","caller":"traceutil/trace.go:171","msg":"trace[205164896] transaction","detail":"{read_only:false; response_revision:1933; number_of_response:1; }","duration":"144.250296ms","start":"2026-10-09T02:29:07.670711Z","end":"2026-10-09T02:29:07.814961Z","steps":["trace[205164896] 'process raft request' (duration: 125.440517ms)","trace[205164896] 'compare' (duration: 18.618145ms)"],"step_count":2} {"level":"info","ts":"2026-10-09T02:29:27.992378Z","caller":"traceutil/trace.go:171","msg":"trace[867265815] transaction","detail":"{read_only:false; response_revision:2025; number_of_response:1; }","duration":"111.116177ms","start":"2026-10-09T02:29:27.881238Z","end":"2026-10-09T02:29:27.992354Z","steps":["trace[867265815] 'process raft request' (duration: 110.983235ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:31:11.229563Z","caller":"traceutil/trace.go:171","msg":"trace[1275759654] transaction","detail":"{read_only:false; response_revision:2521; number_of_response:1; }","duration":"182.123745ms","start":"2026-10-09T02:31:11.047416Z","end":"2026-10-09T02:31:11.22954Z","steps":["trace[1275759654] 'process raft request' (duration: 182.009263ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:31:16.943779Z","caller":"traceutil/trace.go:171","msg":"trace[159153785] transaction","detail":"{read_only:false; response_revision:2553; number_of_response:1; }","duration":"226.457011ms","start":"2026-10-09T02:31:16.717296Z","end":"2026-10-09T02:31:16.943753Z","steps":["trace[159153785] 'process raft request' (duration: 225.95443ms)"],"step_count":1} {"level":"info","ts":"2026-10-09T02:31:16.943788Z","caller":"traceutil/trace.go:171","msg":"trace[301242562] transaction","detail":"{read_only:false; response_revision:2552; number_of_response:1; }","duration":"226.685766ms","start":"2026-10-09T02:31:16.717065Z","end":"2026-10-09T02:31:16.943751Z","steps":["trace[301242562] 'process raft request' (duration: 172.074052ms)","trace[301242562] 'compare' (duration: 53.865858ms)"],"step_count":2}