{"level":"warn","ts":"2026-10-26T13:52:29.097518Z","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-26T13:52:29.097613Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.148: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.148:2380","--initial-cluster=instance=https://162.253.55.148:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.148:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.148: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-26T13:52:29.097743Z","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-26T13:52:29.097761Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.148:2380"]} {"level":"info","ts":"2026-10-26T13:52:29.097781Z","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-26T13:52:29.098552Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.148:2379"]} {"level":"info","ts":"2026-10-26T13:52:29.098642Z","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.148:2380"],"listen-peer-urls":["https://162.253.55.148:2380"],"advertise-client-urls":["https://162.253.55.148:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.148:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.148: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-26T13:52:29.101776Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.857911ms"} {"level":"info","ts":"2026-10-26T13:52:29.111283Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a6342599e225e01b","cluster-id":"8ad3da7aa894cc05"} {"level":"info","ts":"2026-10-26T13:52:29.111368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b switched to configuration voters=()"} {"level":"info","ts":"2026-10-26T13:52:29.111391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became follower at term 0"} {"level":"info","ts":"2026-10-26T13:52:29.111401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a6342599e225e01b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-26T13:52:29.111408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became follower at term 1"} {"level":"info","ts":"2026-10-26T13:52:29.111438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b switched to configuration voters=(11976238651939348507)"} {"level":"warn","ts":"2026-10-26T13:52:29.117256Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-26T13:52:29.11877Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-26T13:52:29.120458Z","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-26T13:52:29.122412Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a6342599e225e01b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-26T13:52:29.125845Z","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-26T13:52:29.126329Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a6342599e225e01b","initial-advertise-peer-urls":["https://162.253.55.148:2380"],"listen-peer-urls":["https://162.253.55.148:2380"],"advertise-client-urls":["https://162.253.55.148:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.148:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-26T13:52:29.126356Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-26T13:52:29.12649Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a6342599e225e01b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-26T13:52:29.126611Z","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-26T13:52:29.126722Z","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-26T13:52:29.126762Z","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-26T13:52:29.126919Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.148:2380"} {"level":"info","ts":"2026-10-26T13:52:29.126953Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.148:2380"} {"level":"info","ts":"2026-10-26T13:52:29.127099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b switched to configuration voters=(11976238651939348507)"} {"level":"info","ts":"2026-10-26T13:52:29.127184Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8ad3da7aa894cc05","local-member-id":"a6342599e225e01b","added-peer-id":"a6342599e225e01b","added-peer-peer-urls":["https://162.253.55.148:2380"]} {"level":"info","ts":"2026-10-26T13:52:29.511648Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b is starting a new election at term 1"} {"level":"info","ts":"2026-10-26T13:52:29.511755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became pre-candidate at term 1"} {"level":"info","ts":"2026-10-26T13:52:29.511789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b received MsgPreVoteResp from a6342599e225e01b at term 1"} {"level":"info","ts":"2026-10-26T13:52:29.511812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became candidate at term 2"} {"level":"info","ts":"2026-10-26T13:52:29.511823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b received MsgVoteResp from a6342599e225e01b at term 2"} {"level":"info","ts":"2026-10-26T13:52:29.511945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became leader at term 2"} {"level":"info","ts":"2026-10-26T13:52:29.511961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a6342599e225e01b elected leader a6342599e225e01b at term 2"} {"level":"info","ts":"2026-10-26T13:52:29.513009Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T13:52:29.513987Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a6342599e225e01b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.148:2379]}","request-path":"/0/members/a6342599e225e01b/attributes","cluster-id":"8ad3da7aa894cc05","publish-timeout":"7s"} {"level":"info","ts":"2026-10-26T13:52:29.514079Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-26T13:52:29.514246Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-26T13:52:29.514269Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-26T13:52:29.514779Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8ad3da7aa894cc05","local-member-id":"a6342599e225e01b","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T13:52:29.514914Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T13:52:29.514954Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T13:52:29.517228Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.148:2379"} {"level":"info","ts":"2026-10-26T13:52:29.513991Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-26T13:52:29.520198Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-26T13:52:31.522826Z","caller":"traceutil/trace.go:171","msg":"trace[1145650783] linearizableReadLoop","detail":"{readStateIndex:90; appliedIndex:89; }","duration":"209.912484ms","start":"2026-10-26T13:52:31.312886Z","end":"2026-10-26T13:52:31.522799Z","steps":["trace[1145650783] 'read index received' (duration: 131.750131ms)","trace[1145650783] 'applied index is now lower than readState.Index' (duration: 78.161263ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T13:52:31.522967Z","caller":"traceutil/trace.go:171","msg":"trace[2029117371] transaction","detail":"{read_only:false; response_revision:85; number_of_response:1; }","duration":"242.934605ms","start":"2026-10-26T13:52:31.28002Z","end":"2026-10-26T13:52:31.522954Z","steps":["trace[2029117371] 'process raft request' (duration: 164.691151ms)","trace[2029117371] 'compare' (duration: 77.948287ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T13:52:31.523185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.687668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-26T13:52:31.523284Z","caller":"traceutil/trace.go:171","msg":"trace[757150141] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:85; }","duration":"133.836752ms","start":"2026-10-26T13:52:31.389427Z","end":"2026-10-26T13:52:31.523264Z","steps":["trace[757150141] 'agreement among raft nodes before linearized reading' (duration: 133.569486ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T13:52:31.523278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.335514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-26T13:52:31.523397Z","caller":"traceutil/trace.go:171","msg":"trace[1128523340] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:85; }","duration":"210.510108ms","start":"2026-10-26T13:52:31.312862Z","end":"2026-10-26T13:52:31.523372Z","steps":["trace[1128523340] 'agreement among raft nodes before linearized reading' (duration: 210.151719ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T13:53:02.484029Z","caller":"traceutil/trace.go:171","msg":"trace[943435204] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"100.566624ms","start":"2026-10-26T13:53:02.383439Z","end":"2026-10-26T13:53:02.484006Z","steps":["trace[943435204] 'process raft request' (duration: 100.441441ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T13:53:18.066547Z","caller":"traceutil/trace.go:171","msg":"trace[999175322] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"175.298229ms","start":"2026-10-26T13:53:17.891215Z","end":"2026-10-26T13:53:18.066513Z","steps":["trace[999175322] 'process raft request' (duration: 174.669433ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T13:53:18.440281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.192157ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-26T13:53:18.440569Z","caller":"traceutil/trace.go:171","msg":"trace[309057071] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:676; }","duration":"235.938825ms","start":"2026-10-26T13:53:18.204609Z","end":"2026-10-26T13:53:18.440548Z","steps":["trace[309057071] 'read index received' (duration: 358.908µs)","trace[309057071] 'applied index is now lower than readState.Index' (duration: 235.578777ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T13:53:18.440696Z","caller":"traceutil/trace.go:171","msg":"trace[1578238577] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"243.435218ms","start":"2026-10-26T13:53:18.197196Z","end":"2026-10-26T13:53:18.440631Z","steps":["trace[1578238577] 'process raft request' (duration: 243.199353ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T13:53:18.440722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.078139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T13:53:18.440809Z","caller":"traceutil/trace.go:171","msg":"trace[565775512] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:651; }","duration":"236.210332ms","start":"2026-10-26T13:53:18.204576Z","end":"2026-10-26T13:53:18.440786Z","steps":["trace[565775512] 'agreement among raft nodes before linearized reading' (duration: 236.051218ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T13:53:18.950571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.741431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-krrgw\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-26T13:53:18.950667Z","caller":"traceutil/trace.go:171","msg":"trace[1848297917] range","detail":"{range_begin:/registry/pods/kube-system/cilium-krrgw; range_end:; response_count:1; response_revision:651; }","duration":"451.883785ms","start":"2026-10-26T13:53:18.498762Z","end":"2026-10-26T13:53:18.950645Z","steps":["trace[1848297917] 'range keys from in-memory index tree' (duration: 451.562957ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T13:53:18.950745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T13:53:18.49874Z","time spent":"451.990668ms","remote":"127.0.0.1:40230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-krrgw\" "} {"level":"info","ts":"2026-10-26T13:53:19.024646Z","caller":"traceutil/trace.go:171","msg":"trace[514837568] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"183.899908ms","start":"2026-10-26T13:53:18.840727Z","end":"2026-10-26T13:53:19.024626Z","steps":["trace[514837568] 'process raft request' (duration: 183.429917ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T13:53:34.749979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.995894ms","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-26T13:53:34.750079Z","caller":"traceutil/trace.go:171","msg":"trace[1072167978] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:816; }","duration":"293.156918ms","start":"2026-10-26T13:53:34.456903Z","end":"2026-10-26T13:53:34.75006Z","steps":["trace[1072167978] 'range keys from in-memory index tree' (duration: 292.796309ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T13:53:34.750104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.297203ms","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-26T13:53:34.75019Z","caller":"traceutil/trace.go:171","msg":"trace[726180870] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:816; }","duration":"236.425327ms","start":"2026-10-26T13:53:34.513744Z","end":"2026-10-26T13:53:34.750169Z","steps":["trace[726180870] 'range keys from in-memory index tree' (duration: 236.032207ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T13:53:34.824436Z","caller":"traceutil/trace.go:171","msg":"trace[73700402] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"194.127236ms","start":"2026-10-26T13:53:34.630282Z","end":"2026-10-26T13:53:34.824409Z","steps":["trace[73700402] 'process raft request' (duration: 193.956042ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T13:54:17.130494Z","caller":"traceutil/trace.go:171","msg":"trace[1733168950] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"269.114564ms","start":"2026-10-26T13:54:16.861286Z","end":"2026-10-26T13:54:17.1304Z","steps":["trace[1733168950] 'process raft request' (duration: 268.921319ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T13:54:17.337521Z","caller":"traceutil/trace.go:171","msg":"trace[567950820] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"203.411664ms","start":"2026-10-26T13:54:17.134088Z","end":"2026-10-26T13:54:17.3375Z","steps":["trace[567950820] 'process raft request' (duration: 203.369193ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T13:54:17.337735Z","caller":"traceutil/trace.go:171","msg":"trace[293527121] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"203.918356ms","start":"2026-10-26T13:54:17.133786Z","end":"2026-10-26T13:54:17.337705Z","steps":["trace[293527121] 'process raft request' (duration: 104.375432ms)","trace[293527121] 'compare' (duration: 99.182515ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T13:54:33.549482Z","caller":"traceutil/trace.go:171","msg":"trace[1355676514] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"128.655351ms","start":"2026-10-26T13:54:33.420803Z","end":"2026-10-26T13:54:33.549459Z","steps":["trace[1355676514] 'process raft request' (duration: 128.514578ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T13:54:33.830744Z","caller":"traceutil/trace.go:171","msg":"trace[1456125246] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"408.709424ms","start":"2026-10-26T13:54:33.422009Z","end":"2026-10-26T13:54:33.830719Z","steps":["trace[1456125246] 'process raft request' (duration: 345.587497ms)","trace[1456125246] 'compare' (duration: 62.977524ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T13:54:33.830925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.604019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5317"} {"level":"info","ts":"2026-10-26T13:54:33.830972Z","caller":"traceutil/trace.go:171","msg":"trace[1057389013] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1179; }","duration":"289.702501ms","start":"2026-10-26T13:54:33.541258Z","end":"2026-10-26T13:54:33.830961Z","steps":["trace[1057389013] 'agreement among raft nodes before linearized reading' (duration: 289.542407ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T13:54:33.831154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T13:54:33.421993Z","time spent":"408.800466ms","remote":"127.0.0.1:40304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T13:54:33.830739Z","caller":"traceutil/trace.go:171","msg":"trace[335456538] linearizableReadLoop","detail":"{readStateIndex:1226; appliedIndex:1224; }","duration":"289.389384ms","start":"2026-10-26T13:54:33.5413Z","end":"2026-10-26T13:54:33.830689Z","steps":["trace[335456538] 'read index received' (duration: 8.03594ms)","trace[335456538] 'applied index is now lower than readState.Index' (duration: 281.352424ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T13:54:34.615046Z","caller":"traceutil/trace.go:171","msg":"trace[980306602] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"125.578508ms","start":"2026-10-26T13:54:34.489446Z","end":"2026-10-26T13:54:34.615025Z","steps":["trace[980306602] 'process raft request' (duration: 125.468556ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T13:54:48.858955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.2089ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-26T13:54:48.85914Z","caller":"traceutil/trace.go:171","msg":"trace[1337432195] linearizableReadLoop","detail":"{readStateIndex:1334; appliedIndex:1333; }","duration":"336.390909ms","start":"2026-10-26T13:54:48.522729Z","end":"2026-10-26T13:54:48.85912Z","steps":["trace[1337432195] 'read index received' (duration: 86.959203ms)","trace[1337432195] 'applied index is now lower than readState.Index' (duration: 249.429956ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T13:54:48.859447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.694576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-10-26T13:54:48.859533Z","caller":"traceutil/trace.go:171","msg":"trace[1449416843] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1283; }","duration":"336.835409ms","start":"2026-10-26T13:54:48.522679Z","end":"2026-10-26T13:54:48.859515Z","steps":["trace[1449416843] 'agreement among raft nodes before linearized reading' (duration: 336.519072ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T13:54:48.859585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T13:54:48.522638Z","time spent":"336.937482ms","remote":"127.0.0.1:40304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":559,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "}