{"level":"warn","ts":"2026-10-14T17:42:49.693801Z","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-14T17:42:49.693945Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.176: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.176:2380","--initial-cluster=instance=https://162.253.55.176:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.176:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.176: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-14T17:42:49.694124Z","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-14T17:42:49.694165Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.176:2380"]} {"level":"info","ts":"2026-10-14T17:42:49.69423Z","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-14T17:42:49.694915Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.176:2379"]} {"level":"info","ts":"2026-10-14T17:42:49.695039Z","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.176:2380"],"listen-peer-urls":["https://162.253.55.176:2380"],"advertise-client-urls":["https://162.253.55.176:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.176:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.176: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-14T17:42:49.697733Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.423123ms"} {"level":"info","ts":"2026-10-14T17:42:49.706048Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"590b810b00f00655","cluster-id":"dcc6923d0deac545"} {"level":"info","ts":"2026-10-14T17:42:49.706121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 switched to configuration voters=()"} {"level":"info","ts":"2026-10-14T17:42:49.706153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became follower at term 0"} {"level":"info","ts":"2026-10-14T17:42:49.706171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 590b810b00f00655 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-14T17:42:49.706178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became follower at term 1"} {"level":"info","ts":"2026-10-14T17:42:49.706223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 switched to configuration voters=(6416363978379757141)"} {"level":"warn","ts":"2026-10-14T17:42:49.711236Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-14T17:42:49.712539Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-14T17:42:49.713638Z","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-14T17:42:49.715592Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"590b810b00f00655","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-14T17:42:49.715749Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"590b810b00f00655","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-14T17:42:49.71595Z","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-14T17:42:49.716578Z","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-14T17:42:49.716607Z","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-14T17:42:49.716877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 switched to configuration voters=(6416363978379757141)"} {"level":"info","ts":"2026-10-14T17:42:49.717022Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dcc6923d0deac545","local-member-id":"590b810b00f00655","added-peer-id":"590b810b00f00655","added-peer-peer-urls":["https://162.253.55.176:2380"]} {"level":"info","ts":"2026-10-14T17:42:49.719151Z","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-14T17:42:49.719292Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.176:2380"} {"level":"info","ts":"2026-10-14T17:42:49.719314Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.176:2380"} {"level":"info","ts":"2026-10-14T17:42:49.719452Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"590b810b00f00655","initial-advertise-peer-urls":["https://162.253.55.176:2380"],"listen-peer-urls":["https://162.253.55.176:2380"],"advertise-client-urls":["https://162.253.55.176:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.176:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-14T17:42:49.719488Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-14T17:42:49.807313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 is starting a new election at term 1"} {"level":"info","ts":"2026-10-14T17:42:49.807351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-14T17:42:49.807366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 received MsgPreVoteResp from 590b810b00f00655 at term 1"} {"level":"info","ts":"2026-10-14T17:42:49.80738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became candidate at term 2"} {"level":"info","ts":"2026-10-14T17:42:49.807477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 received MsgVoteResp from 590b810b00f00655 at term 2"} {"level":"info","ts":"2026-10-14T17:42:49.807507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became leader at term 2"} {"level":"info","ts":"2026-10-14T17:42:49.807519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 590b810b00f00655 elected leader 590b810b00f00655 at term 2"} {"level":"info","ts":"2026-10-14T17:42:49.808417Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"590b810b00f00655","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.176:2379]}","request-path":"/0/members/590b810b00f00655/attributes","cluster-id":"dcc6923d0deac545","publish-timeout":"7s"} {"level":"info","ts":"2026-10-14T17:42:49.808481Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T17:42:49.808566Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T17:42:49.808889Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T17:42:49.808967Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-14T17:42:49.809019Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-14T17:42:49.816089Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dcc6923d0deac545","local-member-id":"590b810b00f00655","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T17:42:49.816672Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T17:42:49.816987Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T17:42:49.817132Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.176:2379"} {"level":"info","ts":"2026-10-14T17:42:49.81889Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-10-14T17:42:55.018249Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":456448214212308016,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-14T17:42:55.408964Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.073591581s","expected-duration":"1s"} {"level":"info","ts":"2026-10-14T17:42:55.409511Z","caller":"traceutil/trace.go:171","msg":"trace[1455878465] transaction","detail":"{read_only:false; response_revision:245; number_of_response:1; }","duration":"1.074281426s","start":"2026-10-14T17:42:54.33519Z","end":"2026-10-14T17:42:55.409471Z","steps":["trace[1455878465] 'process raft request' (duration: 1.074054751s)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:42:55.410334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:42:54.335163Z","time spent":"1.074438129s","remote":"127.0.0.1:51492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3695,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T17:42:55.448009Z","caller":"traceutil/trace.go:171","msg":"trace[1963623961] linearizableReadLoop","detail":"{readStateIndex:253; appliedIndex:251; }","duration":"930.344887ms","start":"2026-10-14T17:42:54.517644Z","end":"2026-10-14T17:42:55.447989Z","steps":["trace[1963623961] 'read index received' (duration: 891.781074ms)","trace[1963623961] 'applied index is now lower than readState.Index' (duration: 38.562963ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:42:55.448108Z","caller":"traceutil/trace.go:171","msg":"trace[881515161] transaction","detail":"{read_only:false; response_revision:246; number_of_response:1; }","duration":"617.086965ms","start":"2026-10-14T17:42:54.830996Z","end":"2026-10-14T17:42:55.448083Z","steps":["trace[881515161] 'process raft request' (duration: 616.910241ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:42:55.448253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:42:54.830962Z","time spent":"617.200647ms","remote":"127.0.0.1:51502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T17:42:55.448252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.856839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T17:42:55.448354Z","caller":"traceutil/trace.go:171","msg":"trace[1697586181] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:246; }","duration":"249.046203ms","start":"2026-10-14T17:42:55.199275Z","end":"2026-10-14T17:42:55.448321Z","steps":["trace[1697586181] 'agreement among raft nodes before linearized reading' (duration: 248.839758ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:42:55.448288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"930.626753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T17:42:55.448547Z","caller":"traceutil/trace.go:171","msg":"trace[206209068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:246; }","duration":"930.894008ms","start":"2026-10-14T17:42:54.517607Z","end":"2026-10-14T17:42:55.448501Z","steps":["trace[206209068] 'agreement among raft nodes before linearized reading' (duration: 930.488169ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:42:55.448597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:42:54.517586Z","time spent":"930.998721ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-14T17:43:30.436243Z","caller":"traceutil/trace.go:171","msg":"trace[1004646266] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"101.568284ms","start":"2026-10-14T17:43:30.334646Z","end":"2026-10-14T17:43:30.436215Z","steps":["trace[1004646266] 'process raft request' (duration: 101.426731ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:43:34.938813Z","caller":"traceutil/trace.go:171","msg":"trace[1159912725] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"130.467523ms","start":"2026-10-14T17:43:34.808316Z","end":"2026-10-14T17:43:34.938784Z","steps":["trace[1159912725] 'read index received' (duration: 107.23379ms)","trace[1159912725] 'applied index is now lower than readState.Index' (duration: 23.231413ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:43:34.938824Z","caller":"traceutil/trace.go:171","msg":"trace[1560576455] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"154.821021ms","start":"2026-10-14T17:43:34.783953Z","end":"2026-10-14T17:43:34.938774Z","steps":["trace[1560576455] 'process raft request' (duration: 131.532176ms)","trace[1560576455] 'compare' (duration: 23.153672ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T17:43:34.939205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.863932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-10-14T17:43:34.939256Z","caller":"traceutil/trace.go:171","msg":"trace[812583371] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:640; }","duration":"130.964664ms","start":"2026-10-14T17:43:34.808277Z","end":"2026-10-14T17:43:34.939241Z","steps":["trace[812583371] 'agreement among raft nodes before linearized reading' (duration: 130.609216ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:43:35.112111Z","caller":"traceutil/trace.go:171","msg":"trace[1398245496] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:664; }","duration":"165.004666ms","start":"2026-10-14T17:43:34.947071Z","end":"2026-10-14T17:43:35.112076Z","steps":["trace[1398245496] 'read index received' (duration: 162.328587ms)","trace[1398245496] 'applied index is now lower than readState.Index' (duration: 2.675139ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:43:35.112153Z","caller":"traceutil/trace.go:171","msg":"trace[1521407773] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"165.773282ms","start":"2026-10-14T17:43:34.946334Z","end":"2026-10-14T17:43:35.112108Z","steps":["trace[1521407773] 'process raft request' (duration: 163.058013ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:43:35.11233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.21222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31145"} {"level":"info","ts":"2026-10-14T17:43:35.112371Z","caller":"traceutil/trace.go:171","msg":"trace[171859734] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:642; }","duration":"165.319433ms","start":"2026-10-14T17:43:34.94704Z","end":"2026-10-14T17:43:35.112359Z","steps":["trace[171859734] 'agreement among raft nodes before linearized reading' (duration: 165.129189ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:43:35.112899Z","caller":"traceutil/trace.go:171","msg":"trace[1568801450] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"165.671011ms","start":"2026-10-14T17:43:34.947216Z","end":"2026-10-14T17:43:35.112887Z","steps":["trace[1568801450] 'process raft request' (duration: 165.447776ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:43:35.113285Z","caller":"traceutil/trace.go:171","msg":"trace[1720762642] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"130.895712ms","start":"2026-10-14T17:43:34.982377Z","end":"2026-10-14T17:43:35.113273Z","steps":["trace[1720762642] 'process raft request' (duration: 130.460033ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:43:42.007796Z","caller":"traceutil/trace.go:171","msg":"trace[1899880349] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"211.32599ms","start":"2026-10-14T17:43:41.796442Z","end":"2026-10-14T17:43:42.007768Z","steps":["trace[1899880349] 'process raft request' (duration: 211.189857ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:43:42.008025Z","caller":"traceutil/trace.go:171","msg":"trace[543096634] linearizableReadLoop","detail":"{readStateIndex:731; appliedIndex:731; }","duration":"211.418021ms","start":"2026-10-14T17:43:41.796588Z","end":"2026-10-14T17:43:42.008006Z","steps":["trace[543096634] 'read index received' (duration: 211.410291ms)","trace[543096634] 'applied index is now lower than readState.Index' (duration: 6.57µs)"],"step_count":2} {"level":"warn","ts":"2026-10-14T17:43:42.008148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.540374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-14T17:43:42.008184Z","caller":"traceutil/trace.go:171","msg":"trace[693273876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:707; }","duration":"211.607936ms","start":"2026-10-14T17:43:41.796565Z","end":"2026-10-14T17:43:42.008173Z","steps":["trace[693273876] 'agreement among raft nodes before linearized reading' (duration: 211.524274ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:43:42.028147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.522947ms","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-14T17:43:42.028159Z","caller":"traceutil/trace.go:171","msg":"trace[821735469] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"229.242085ms","start":"2026-10-14T17:43:41.798889Z","end":"2026-10-14T17:43:42.028131Z","steps":["trace[821735469] 'process raft request' (duration: 229.02629ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:43:42.028224Z","caller":"traceutil/trace.go:171","msg":"trace[374473788] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:708; }","duration":"136.6506ms","start":"2026-10-14T17:43:41.891555Z","end":"2026-10-14T17:43:42.028206Z","steps":["trace[374473788] 'agreement among raft nodes before linearized reading' (duration: 136.502116ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:43:42.454473Z","caller":"traceutil/trace.go:171","msg":"trace[634121527] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"234.789388ms","start":"2026-10-14T17:43:42.219659Z","end":"2026-10-14T17:43:42.454448Z","steps":["trace[634121527] 'process raft request' (duration: 234.645245ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:43:42.713282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.28542ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T17:43:42.713393Z","caller":"traceutil/trace.go:171","msg":"trace[1830841545] linearizableReadLoop","detail":"{readStateIndex:736; appliedIndex:735; }","duration":"204.48274ms","start":"2026-10-14T17:43:42.508891Z","end":"2026-10-14T17:43:42.713374Z","steps":["trace[1830841545] 'read index received' (duration: 88.778162ms)","trace[1830841545] 'applied index is now lower than readState.Index' (duration: 115.703238ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T17:43:42.713541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.663004ms","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-14T17:43:42.713576Z","caller":"traceutil/trace.go:171","msg":"trace[1310071173] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:712; }","duration":"204.697145ms","start":"2026-10-14T17:43:42.50887Z","end":"2026-10-14T17:43:42.713567Z","steps":["trace[1310071173] 'agreement among raft nodes before linearized reading' (duration: 204.548271ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:43:42.713684Z","caller":"traceutil/trace.go:171","msg":"trace[1247743736] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"366.692694ms","start":"2026-10-14T17:43:42.346908Z","end":"2026-10-14T17:43:42.713601Z","steps":["trace[1247743736] 'process raft request' (duration: 250.833953ms)","trace[1247743736] 'compare' (duration: 115.177586ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T17:43:42.71393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:43:42.346884Z","time spent":"366.900769ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T17:43:58.088221Z","caller":"traceutil/trace.go:171","msg":"trace[958644952] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"196.371844ms","start":"2026-10-14T17:43:57.891823Z","end":"2026-10-14T17:43:58.088195Z","steps":["trace[958644952] 'process raft request' (duration: 196.21069ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:43:58.387683Z","caller":"traceutil/trace.go:171","msg":"trace[1267285498] linearizableReadLoop","detail":"{readStateIndex:852; appliedIndex:850; }","duration":"310.11352ms","start":"2026-10-14T17:43:58.077531Z","end":"2026-10-14T17:43:58.387644Z","steps":["trace[1267285498] 'read index received' (duration: 10.575334ms)","trace[1267285498] 'applied index is now lower than readState.Index' (duration: 299.536666ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:43:58.387912Z","caller":"traceutil/trace.go:171","msg":"trace[476571512] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"466.528851ms","start":"2026-10-14T17:43:57.921334Z","end":"2026-10-14T17:43:58.387863Z","steps":["trace[476571512] 'process raft request' (duration: 466.091801ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:43:58.387975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.404717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T17:43:58.38802Z","caller":"traceutil/trace.go:171","msg":"trace[346806502] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:823; }","duration":"310.53149ms","start":"2026-10-14T17:43:58.077474Z","end":"2026-10-14T17:43:58.388006Z","steps":["trace[346806502] 'agreement among raft nodes before linearized reading' (duration: 310.363596ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:43:58.388064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:43:58.077457Z","time spent":"310.595261ms","remote":"127.0.0.1:51710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"warn","ts":"2026-10-14T17:43:58.38813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.020257ms","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-14T17:43:58.388144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:43:57.921314Z","time spent":"466.707174ms","remote":"127.0.0.1:51502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T17:43:58.388199Z","caller":"traceutil/trace.go:171","msg":"trace[138948654] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:823; }","duration":"253.12316ms","start":"2026-10-14T17:43:58.135055Z","end":"2026-10-14T17:43:58.388179Z","steps":["trace[138948654] 'agreement among raft nodes before linearized reading' (duration: 252.957676ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:43:58.388227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.710929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-10-14T17:43:58.388257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.055487ms","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-14T17:43:58.388294Z","caller":"traceutil/trace.go:171","msg":"trace[636612821] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:823; }","duration":"308.826132ms","start":"2026-10-14T17:43:58.079447Z","end":"2026-10-14T17:43:58.388273Z","steps":["trace[636612821] 'agreement among raft nodes before linearized reading' (duration: 308.503805ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:43:58.388308Z","caller":"traceutil/trace.go:171","msg":"trace[1082362401] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:823; }","duration":"248.143639ms","start":"2026-10-14T17:43:58.14015Z","end":"2026-10-14T17:43:58.388294Z","steps":["trace[1082362401] 'agreement among raft nodes before linearized reading' (duration: 248.020247ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:43:58.388346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:43:58.079411Z","time spent":"308.921604ms","remote":"127.0.0.1:51574","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-14T17:43:58.388112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.744692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T17:43:58.388489Z","caller":"traceutil/trace.go:171","msg":"trace[595093946] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:823; }","duration":"249.200962ms","start":"2026-10-14T17:43:58.139274Z","end":"2026-10-14T17:43:58.388475Z","steps":["trace[595093946] 'agreement among raft nodes before linearized reading' (duration: 248.730562ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:44:38.846564Z","caller":"traceutil/trace.go:171","msg":"trace[1934544671] linearizableReadLoop","detail":"{readStateIndex:1143; appliedIndex:1142; }","duration":"213.964934ms","start":"2026-10-14T17:44:38.632577Z","end":"2026-10-14T17:44:38.846541Z","steps":["trace[1934544671] 'read index received' (duration: 213.780629ms)","trace[1934544671] 'applied index is now lower than readState.Index' (duration: 183.025µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:44:38.846733Z","caller":"traceutil/trace.go:171","msg":"trace[711028152] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"282.610532ms","start":"2026-10-14T17:44:38.564077Z","end":"2026-10-14T17:44:38.846687Z","steps":["trace[711028152] 'process raft request' (duration: 282.287255ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:44:38.846899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.309871ms","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-14T17:44:38.846937Z","caller":"traceutil/trace.go:171","msg":"trace[1690580703] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1104; }","duration":"214.403653ms","start":"2026-10-14T17:44:38.632521Z","end":"2026-10-14T17:44:38.846925Z","steps":["trace[1690580703] 'agreement among raft nodes before linearized reading' (duration: 214.175648ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:44:38.887237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.715232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-14T17:44:38.887339Z","caller":"traceutil/trace.go:171","msg":"trace[1243444811] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1105; }","duration":"168.885036ms","start":"2026-10-14T17:44:38.718426Z","end":"2026-10-14T17:44:38.887311Z","steps":["trace[1243444811] 'agreement among raft nodes before linearized reading' (duration: 168.640261ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:44:38.887512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.950591ms","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-14T17:44:38.887539Z","caller":"traceutil/trace.go:171","msg":"trace[1249206661] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1105; }","duration":"161.019942ms","start":"2026-10-14T17:44:38.726509Z","end":"2026-10-14T17:44:38.887529Z","steps":["trace[1249206661] 'agreement among raft nodes before linearized reading' (duration: 160.9168ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:44:38.887802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.14637ms","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-14T17:44:38.887833Z","caller":"traceutil/trace.go:171","msg":"trace[896007019] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1105; }","duration":"168.242192ms","start":"2026-10-14T17:44:38.719581Z","end":"2026-10-14T17:44:38.887823Z","steps":["trace[896007019] 'agreement among raft nodes before linearized reading' (duration: 168.14693ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:44:55.179806Z","caller":"traceutil/trace.go:171","msg":"trace[809380632] linearizableReadLoop","detail":"{readStateIndex:1214; appliedIndex:1212; }","duration":"110.949519ms","start":"2026-10-14T17:44:55.068838Z","end":"2026-10-14T17:44:55.179787Z","steps":["trace[809380632] 'read index received' (duration: 63.747689ms)","trace[809380632] 'applied index is now lower than readState.Index' (duration: 47.20077ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:44:55.179854Z","caller":"traceutil/trace.go:171","msg":"trace[2029260290] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"135.23669ms","start":"2026-10-14T17:44:55.044592Z","end":"2026-10-14T17:44:55.179829Z","steps":["trace[2029260290] 'process raft request' (duration: 88.001339ms)","trace[2029260290] 'compare' (duration: 47.007146ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:44:55.17988Z","caller":"traceutil/trace.go:171","msg":"trace[1388076621] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"121.395051ms","start":"2026-10-14T17:44:55.058453Z","end":"2026-10-14T17:44:55.179848Z","steps":["trace[1388076621] 'process raft request' (duration: 121.286419ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:44:55.180012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.162353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-10-14T17:44:55.180056Z","caller":"traceutil/trace.go:171","msg":"trace[1753182678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1170; }","duration":"111.298617ms","start":"2026-10-14T17:44:55.068741Z","end":"2026-10-14T17:44:55.18004Z","steps":["trace[1753182678] 'agreement among raft nodes before linearized reading' (duration: 111.168744ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:45:09.053423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.053261ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-14T17:45:09.430446Z","caller":"traceutil/trace.go:171","msg":"trace[273246658] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"181.273934ms","start":"2026-10-14T17:45:09.249151Z","end":"2026-10-14T17:45:09.430425Z","steps":["trace[273246658] 'process raft request' (duration: 112.504354ms)","trace[273246658] 'compare' (duration: 68.638787ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:45:09.430552Z","caller":"traceutil/trace.go:171","msg":"trace[628553069] linearizableReadLoop","detail":"{readStateIndex:1321; appliedIndex:1319; }","duration":"109.296342ms","start":"2026-10-14T17:45:09.32124Z","end":"2026-10-14T17:45:09.430536Z","steps":["trace[628553069] 'read index received' (duration: 40.42423ms)","trace[628553069] 'applied index is now lower than readState.Index' (duration: 68.871252ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:45:09.430672Z","caller":"traceutil/trace.go:171","msg":"trace[782524979] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"180.435285ms","start":"2026-10-14T17:45:09.250227Z","end":"2026-10-14T17:45:09.430662Z","steps":["trace[782524979] 'process raft request' (duration: 180.169049ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:45:09.430895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.63831ms","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-14T17:45:09.430969Z","caller":"traceutil/trace.go:171","msg":"trace[1453591633] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1274; }","duration":"109.763343ms","start":"2026-10-14T17:45:09.321188Z","end":"2026-10-14T17:45:09.430952Z","steps":["trace[1453591633] 'agreement among raft nodes before linearized reading' (duration: 109.504227ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:45:09.455957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.46024ms","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-14T17:45:09.45604Z","caller":"traceutil/trace.go:171","msg":"trace[147484033] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1277; }","duration":"133.555882ms","start":"2026-10-14T17:45:09.322463Z","end":"2026-10-14T17:45:09.456019Z","steps":["trace[147484033] 'agreement among raft nodes before linearized reading' (duration: 133.322997ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:45:09.931131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.287976ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T17:45:09.931554Z","caller":"traceutil/trace.go:171","msg":"trace[1834484835] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"469.940137ms","start":"2026-10-14T17:45:09.46155Z","end":"2026-10-14T17:45:09.93149Z","steps":["trace[1834484835] 'process raft request' (duration: 198.209821ms)","trace[1834484835] 'compare' (duration: 271.112283ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T17:45:09.931657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:45:09.461494Z","time spent":"470.111001ms","remote":"127.0.0.1:51574","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-14T17:45:09.93199Z","caller":"traceutil/trace.go:171","msg":"trace[1848806407] linearizableReadLoop","detail":"{readStateIndex:1325; appliedIndex:1324; }","duration":"151.389318ms","start":"2026-10-14T17:45:09.779829Z","end":"2026-10-14T17:45:09.931218Z","steps":["trace[1848806407] 'read index received' (duration: 38.851µs)","trace[1848806407] 'applied index is now lower than readState.Index' (duration: 151.349247ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T17:45:09.932067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.240238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-14T17:45:09.932111Z","caller":"traceutil/trace.go:171","msg":"trace[2058319727] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1278; }","duration":"152.32973ms","start":"2026-10-14T17:45:09.779766Z","end":"2026-10-14T17:45:09.932096Z","steps":["trace[2058319727] 'agreement among raft nodes before linearized reading' (duration: 152.020853ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:49:34.867797Z","caller":"traceutil/trace.go:171","msg":"trace[1461101689] linearizableReadLoop","detail":"{readStateIndex:2620; appliedIndex:2619; }","duration":"157.878833ms","start":"2026-10-14T17:49:34.709893Z","end":"2026-10-14T17:49:34.867771Z","steps":["trace[1461101689] 'read index received' (duration: 157.615058ms)","trace[1461101689] 'applied index is now lower than readState.Index' (duration: 260.455µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:49:34.867851Z","caller":"traceutil/trace.go:171","msg":"trace[897414654] transaction","detail":"{read_only:false; response_revision:2519; number_of_response:1; }","duration":"168.61108ms","start":"2026-10-14T17:49:34.699209Z","end":"2026-10-14T17:49:34.86782Z","steps":["trace[897414654] 'process raft request' (duration: 168.396636ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:49:34.867964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.050077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T17:49:34.86803Z","caller":"traceutil/trace.go:171","msg":"trace[1834660264] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2519; }","duration":"158.16651ms","start":"2026-10-14T17:49:34.70985Z","end":"2026-10-14T17:49:34.868016Z","steps":["trace[1834660264] 'agreement among raft nodes before linearized reading' (duration: 158.057167ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:49:34.868518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.992224ms","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-14T17:49:34.868587Z","caller":"traceutil/trace.go:171","msg":"trace[986393500] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2519; }","duration":"101.089237ms","start":"2026-10-14T17:49:34.76748Z","end":"2026-10-14T17:49:34.868569Z","steps":["trace[986393500] 'agreement among raft nodes before linearized reading' (duration: 100.877762ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:49:34.868932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.452829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T17:49:34.869222Z","caller":"traceutil/trace.go:171","msg":"trace[1862023322] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:2519; }","duration":"155.797847ms","start":"2026-10-14T17:49:34.713405Z","end":"2026-10-14T17:49:34.869203Z","steps":["trace[1862023322] 'agreement among raft nodes before linearized reading' (duration: 154.886907ms)"],"step_count":1}