{"level":"warn","ts":"2026-10-13T12:55:33.357887Z","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-13T12:55:33.358003Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.34: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.34:2380","--initial-cluster=instance=https://162.253.55.34:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.34:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.34: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-13T12:55:33.358079Z","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-13T12:55:33.358089Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.34:2380"]} {"level":"info","ts":"2026-10-13T12:55:33.358105Z","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-13T12:55:33.358889Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.34:2379"]} {"level":"info","ts":"2026-10-13T12:55:33.358997Z","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.34:2380"],"listen-peer-urls":["https://162.253.55.34:2380"],"advertise-client-urls":["https://162.253.55.34:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.34:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.34: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-13T12:55:33.361838Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.5963ms"} {"level":"info","ts":"2026-10-13T12:55:33.366753Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3ce80082388a7ba5","cluster-id":"32cae298a1245280"} {"level":"info","ts":"2026-10-13T12:55:33.366798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 switched to configuration voters=()"} {"level":"info","ts":"2026-10-13T12:55:33.366812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 became follower at term 0"} {"level":"info","ts":"2026-10-13T12:55:33.36682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3ce80082388a7ba5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-13T12:55:33.366829Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 became follower at term 1"} {"level":"info","ts":"2026-10-13T12:55:33.366854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 switched to configuration voters=(4388758396166896549)"} {"level":"warn","ts":"2026-10-13T12:55:33.371701Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-13T12:55:33.373092Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-13T12:55:33.375032Z","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-13T12:55:33.377148Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3ce80082388a7ba5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-13T12:55:33.377281Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3ce80082388a7ba5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-13T12:55:33.381493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 switched to configuration voters=(4388758396166896549)"} {"level":"info","ts":"2026-10-13T12:55:33.377484Z","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-13T12:55:33.381934Z","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-13T12:55:33.381971Z","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-13T12:55:33.382062Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"32cae298a1245280","local-member-id":"3ce80082388a7ba5","added-peer-id":"3ce80082388a7ba5","added-peer-peer-urls":["https://162.253.55.34:2380"]} {"level":"info","ts":"2026-10-13T12:55:33.38409Z","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-13T12:55:33.384312Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.34:2380"} {"level":"info","ts":"2026-10-13T12:55:33.384339Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.34:2380"} {"level":"info","ts":"2026-10-13T12:55:33.38444Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3ce80082388a7ba5","initial-advertise-peer-urls":["https://162.253.55.34:2380"],"listen-peer-urls":["https://162.253.55.34:2380"],"advertise-client-urls":["https://162.253.55.34:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.34:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-13T12:55:33.38446Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-13T12:55:33.56883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 is starting a new election at term 1"} {"level":"info","ts":"2026-10-13T12:55:33.568884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-13T12:55:33.568978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 received MsgPreVoteResp from 3ce80082388a7ba5 at term 1"} {"level":"info","ts":"2026-10-13T12:55:33.569001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 became candidate at term 2"} {"level":"info","ts":"2026-10-13T12:55:33.569174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 received MsgVoteResp from 3ce80082388a7ba5 at term 2"} {"level":"info","ts":"2026-10-13T12:55:33.569196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 became leader at term 2"} {"level":"info","ts":"2026-10-13T12:55:33.569206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3ce80082388a7ba5 elected leader 3ce80082388a7ba5 at term 2"} {"level":"info","ts":"2026-10-13T12:55:33.571375Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3ce80082388a7ba5","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.34:2379]}","request-path":"/0/members/3ce80082388a7ba5/attributes","cluster-id":"32cae298a1245280","publish-timeout":"7s"} {"level":"info","ts":"2026-10-13T12:55:33.571709Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T12:55:33.571806Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T12:55:33.572249Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T12:55:33.572608Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-13T12:55:33.57269Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-13T12:55:33.574124Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"32cae298a1245280","local-member-id":"3ce80082388a7ba5","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T12:55:33.574248Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T12:55:33.574368Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T12:55:33.575872Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-13T12:55:33.577137Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.34:2379"} {"level":"info","ts":"2026-10-13T12:56:24.297695Z","caller":"traceutil/trace.go:171","msg":"trace[1385459814] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"207.287756ms","start":"2026-10-13T12:56:24.090338Z","end":"2026-10-13T12:56:24.297626Z","steps":["trace[1385459814] 'process raft request' (duration: 206.544749ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:56:24.863882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.984361ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-13T12:56:24.864021Z","caller":"traceutil/trace.go:171","msg":"trace[477176] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"466.829193ms","start":"2026-10-13T12:56:24.397169Z","end":"2026-10-13T12:56:24.863998Z","steps":["trace[477176] 'process raft request' (duration: 284.929111ms)","trace[477176] 'compare' (duration: 180.436789ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T12:56:24.864096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T12:56:24.397147Z","time spent":"466.923455ms","remote":"127.0.0.1:45564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T12:57:18.965988Z","caller":"traceutil/trace.go:171","msg":"trace[329073914] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"132.164932ms","start":"2026-10-13T12:57:18.833783Z","end":"2026-10-13T12:57:18.965948Z","steps":["trace[329073914] 'process raft request' (duration: 131.964787ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:57:20.57756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.944403ms","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-13T12:57:20.577635Z","caller":"traceutil/trace.go:171","msg":"trace[1618348724] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1092; }","duration":"299.058066ms","start":"2026-10-13T12:57:20.278558Z","end":"2026-10-13T12:57:20.577616Z","steps":["trace[1618348724] 'range keys from in-memory index tree' (duration: 298.80679ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:57:20.76357Z","caller":"traceutil/trace.go:171","msg":"trace[1928292226] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"181.175673ms","start":"2026-10-13T12:57:20.582361Z","end":"2026-10-13T12:57:20.763537Z","steps":["trace[1928292226] 'process raft request' (duration: 181.03554ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:57:20.766144Z","caller":"traceutil/trace.go:171","msg":"trace[1832251783] linearizableReadLoop","detail":"{readStateIndex:1135; appliedIndex:1133; }","duration":"136.071182ms","start":"2026-10-13T12:57:20.630024Z","end":"2026-10-13T12:57:20.766096Z","steps":["trace[1832251783] 'read index received' (duration: 133.457852ms)","trace[1832251783] 'applied index is now lower than readState.Index' (duration: 2.61237ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T12:57:20.766487Z","caller":"traceutil/trace.go:171","msg":"trace[314692681] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"183.573989ms","start":"2026-10-13T12:57:20.5829Z","end":"2026-10-13T12:57:20.766474Z","steps":["trace[314692681] 'process raft request' (duration: 183.021497ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:57:20.766847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.815909ms","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-13T12:57:20.766894Z","caller":"traceutil/trace.go:171","msg":"trace[769578916] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1094; }","duration":"136.945262ms","start":"2026-10-13T12:57:20.629937Z","end":"2026-10-13T12:57:20.766882Z","steps":["trace[769578916] 'agreement among raft nodes before linearized reading' (duration: 136.755338ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:57:37.375033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.588743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T12:57:37.375122Z","caller":"traceutil/trace.go:171","msg":"trace[338513281] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1167; }","duration":"101.765907ms","start":"2026-10-13T12:57:37.273335Z","end":"2026-10-13T12:57:37.375101Z","steps":["trace[338513281] 'count revisions from in-memory index tree' (duration: 101.4799ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:57:37.537709Z","caller":"traceutil/trace.go:171","msg":"trace[984938680] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"149.842637ms","start":"2026-10-13T12:57:37.387813Z","end":"2026-10-13T12:57:37.537655Z","steps":["trace[984938680] 'process raft request' (duration: 149.633752ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:57:37.666096Z","caller":"traceutil/trace.go:171","msg":"trace[757094254] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"120.111972ms","start":"2026-10-13T12:57:37.545943Z","end":"2026-10-13T12:57:37.666055Z","steps":["trace[757094254] 'process raft request' (duration: 104.451051ms)","trace[757094254] 'compare' (duration: 15.425075ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T12:57:38.971841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.255493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T12:57:38.971939Z","caller":"traceutil/trace.go:171","msg":"trace[1048404380] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1174; }","duration":"100.387527ms","start":"2026-10-13T12:57:38.871529Z","end":"2026-10-13T12:57:38.971916Z","steps":["trace[1048404380] 'range keys from in-memory index tree' (duration: 100.197272ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:57:38.972306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.712447ms","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-13T12:57:38.972446Z","caller":"traceutil/trace.go:171","msg":"trace[692699620] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1174; }","duration":"101.924352ms","start":"2026-10-13T12:57:38.870493Z","end":"2026-10-13T12:57:38.972418Z","steps":["trace[692699620] 'range keys from in-memory index tree' (duration: 101.40136ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:57:38.972964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.068054ms","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-13T12:57:38.973093Z","caller":"traceutil/trace.go:171","msg":"trace[472124325] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1174; }","duration":"118.249938ms","start":"2026-10-13T12:57:38.854813Z","end":"2026-10-13T12:57:38.973063Z","steps":["trace[472124325] 'range keys from in-memory index tree' (duration: 116.944269ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:57:39.071936Z","caller":"traceutil/trace.go:171","msg":"trace[1630158033] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"130.754907ms","start":"2026-10-13T12:57:38.941145Z","end":"2026-10-13T12:57:39.0719Z","steps":["trace[1630158033] 'process raft request' (duration: 130.552402ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:57:39.096711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.112677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T12:57:39.096812Z","caller":"traceutil/trace.go:171","msg":"trace[1075092114] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1175; }","duration":"122.303082ms","start":"2026-10-13T12:57:38.974482Z","end":"2026-10-13T12:57:39.096785Z","steps":["trace[1075092114] 'agreement among raft nodes before linearized reading' (duration: 97.391137ms)","trace[1075092114] 'range keys from in-memory index tree' (duration: 24.728072ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T12:57:39.10176Z","caller":"traceutil/trace.go:171","msg":"trace[495059954] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"122.644189ms","start":"2026-10-13T12:57:38.979093Z","end":"2026-10-13T12:57:39.101737Z","steps":["trace[495059954] 'process raft request' (duration: 121.460882ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:57:39.101902Z","caller":"traceutil/trace.go:171","msg":"trace[1075158236] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"122.650849ms","start":"2026-10-13T12:57:38.979241Z","end":"2026-10-13T12:57:39.101892Z","steps":["trace[1075158236] 'process raft request' (duration: 122.144058ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:57:39.101982Z","caller":"traceutil/trace.go:171","msg":"trace[1225317865] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"122.499696ms","start":"2026-10-13T12:57:38.979474Z","end":"2026-10-13T12:57:39.101973Z","steps":["trace[1225317865] 'process raft request' (duration: 121.994384ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:57:39.102266Z","caller":"traceutil/trace.go:171","msg":"trace[2133331875] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"121.731928ms","start":"2026-10-13T12:57:38.98051Z","end":"2026-10-13T12:57:39.102242Z","steps":["trace[2133331875] 'process raft request' (duration: 121.000341ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:57:39.258761Z","caller":"traceutil/trace.go:171","msg":"trace[355257213] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"146.345047ms","start":"2026-10-13T12:57:39.112382Z","end":"2026-10-13T12:57:39.258727Z","steps":["trace[355257213] 'process raft request' (duration: 146.120701ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:57:52.0949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.505031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T12:57:52.095013Z","caller":"traceutil/trace.go:171","msg":"trace[1617691137] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1266; }","duration":"189.682586ms","start":"2026-10-13T12:57:51.905307Z","end":"2026-10-13T12:57:52.094989Z","steps":["trace[1617691137] 'range keys from in-memory index tree' (duration: 189.41627ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T12:57:52.09522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.41669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-10-13T12:57:52.095334Z","caller":"traceutil/trace.go:171","msg":"trace[1684047457] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1266; }","duration":"173.570954ms","start":"2026-10-13T12:57:51.921735Z","end":"2026-10-13T12:57:52.095306Z","steps":["trace[1684047457] 'range keys from in-memory index tree' (duration: 173.188205ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:57:52.208481Z","caller":"traceutil/trace.go:171","msg":"trace[2019885173] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"107.982691ms","start":"2026-10-13T12:57:52.100473Z","end":"2026-10-13T12:57:52.208456Z","steps":["trace[2019885173] 'process raft request' (duration: 107.821757ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:57:52.574382Z","caller":"traceutil/trace.go:171","msg":"trace[1989049478] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"286.712125ms","start":"2026-10-13T12:57:52.287622Z","end":"2026-10-13T12:57:52.574334Z","steps":["trace[1989049478] 'process raft request' (duration: 284.925583ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:57:52.574505Z","caller":"traceutil/trace.go:171","msg":"trace[1019584199] linearizableReadLoop","detail":"{readStateIndex:1316; appliedIndex:1315; }","duration":"226.633839ms","start":"2026-10-13T12:57:52.347819Z","end":"2026-10-13T12:57:52.574453Z","steps":["trace[1019584199] 'read index received' (duration: 224.766356ms)","trace[1019584199] 'applied index is now lower than readState.Index' (duration: 1.865613ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T12:57:52.578257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.597918ms","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":"warn","ts":"2026-10-13T12:57:52.57833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.498398ms","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-13T12:57:52.578397Z","caller":"traceutil/trace.go:171","msg":"trace[218293435] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1268; }","duration":"200.778073ms","start":"2026-10-13T12:57:52.377597Z","end":"2026-10-13T12:57:52.578375Z","steps":["trace[218293435] 'agreement among raft nodes before linearized reading' (duration: 200.443675ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T12:57:52.578423Z","caller":"traceutil/trace.go:171","msg":"trace[375953078] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1268; }","duration":"230.667802ms","start":"2026-10-13T12:57:52.347739Z","end":"2026-10-13T12:57:52.578407Z","steps":["trace[375953078] 'agreement among raft nodes before linearized reading' (duration: 226.902185ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T13:02:06.704904Z","caller":"traceutil/trace.go:171","msg":"trace[511722599] linearizableReadLoop","detail":"{readStateIndex:2533; appliedIndex:2531; }","duration":"173.619274ms","start":"2026-10-13T13:02:06.531249Z","end":"2026-10-13T13:02:06.704868Z","steps":["trace[511722599] 'read index received' (duration: 25.025925ms)","trace[511722599] 'applied index is now lower than readState.Index' (duration: 148.591949ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T13:02:06.705134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.408026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T13:02:06.705037Z","caller":"traceutil/trace.go:171","msg":"trace[450458361] transaction","detail":"{read_only:false; response_revision:2434; number_of_response:1; }","duration":"174.339731ms","start":"2026-10-13T13:02:06.530614Z","end":"2026-10-13T13:02:06.704954Z","steps":["trace[450458361] 'process raft request' (duration: 140.017451ms)","trace[450458361] 'compare' (duration: 34.045813ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T13:02:06.705267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.985502ms","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-13T13:02:06.705194Z","caller":"traceutil/trace.go:171","msg":"trace[849166978] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:2434; }","duration":"132.517608ms","start":"2026-10-13T13:02:06.572661Z","end":"2026-10-13T13:02:06.705179Z","steps":["trace[849166978] 'agreement among raft nodes before linearized reading' (duration: 132.397175ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T13:02:06.705355Z","caller":"traceutil/trace.go:171","msg":"trace[1510804523] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2434; }","duration":"174.131675ms","start":"2026-10-13T13:02:06.531206Z","end":"2026-10-13T13:02:06.705338Z","steps":["trace[1510804523] 'agreement among raft nodes before linearized reading' (duration: 173.849559ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T13:02:40.399623Z","caller":"traceutil/trace.go:171","msg":"trace[722729555] transaction","detail":"{read_only:false; response_revision:2621; number_of_response:1; }","duration":"103.623654ms","start":"2026-10-13T13:02:40.295961Z","end":"2026-10-13T13:02:40.399585Z","steps":["trace[722729555] 'process raft request' (duration: 103.435219ms)"],"step_count":1}