{"level":"warn","ts":"2026-02-04T10:59:11.562112Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-04T10:59:11.562224Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.49: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.49:2380","--initial-cluster=instance=https://162.253.55.49:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.49:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.49: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-02-04T10:59:11.5623Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-04T10:59:11.562313Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.49:2380"]}
{"level":"info","ts":"2026-02-04T10:59:11.562333Z","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-02-04T10:59:11.567167Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.49:2379"]}
{"level":"info","ts":"2026-02-04T10:59:11.573303Z","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":2,"max-cpu-available":2,"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.49:2380"],"listen-peer-urls":["https://162.253.55.49:2380"],"advertise-client-urls":["https://162.253.55.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.49: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-02-04T10:59:11.581866Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.21898ms"}
{"level":"info","ts":"2026-02-04T10:59:11.600884Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6a9ba61e55fef5be","cluster-id":"9612db6e19ac6ce7"}
{"level":"info","ts":"2026-02-04T10:59:11.600985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be switched to configuration voters=()"}
{"level":"info","ts":"2026-02-04T10:59:11.60101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be became follower at term 0"}
{"level":"info","ts":"2026-02-04T10:59:11.601018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6a9ba61e55fef5be [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-04T10:59:11.601027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be became follower at term 1"}
{"level":"info","ts":"2026-02-04T10:59:11.60106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be switched to configuration voters=(7681916238632515006)"}
{"level":"warn","ts":"2026-02-04T10:59:11.613992Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-04T10:59:11.623309Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-04T10:59:11.628924Z","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-02-04T10:59:11.633046Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6a9ba61e55fef5be","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-04T10:59:11.633746Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6a9ba61e55fef5be","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-04T10:59:11.634084Z","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-02-04T10:59:11.634135Z","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-02-04T10:59:11.634748Z","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-02-04T10:59:11.635164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be switched to configuration voters=(7681916238632515006)"}
{"level":"info","ts":"2026-02-04T10:59:11.636471Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9612db6e19ac6ce7","local-member-id":"6a9ba61e55fef5be","added-peer-id":"6a9ba61e55fef5be","added-peer-peer-urls":["https://162.253.55.49:2380"]}
{"level":"info","ts":"2026-02-04T10:59:11.647685Z","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-02-04T10:59:11.647898Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6a9ba61e55fef5be","initial-advertise-peer-urls":["https://162.253.55.49:2380"],"listen-peer-urls":["https://162.253.55.49:2380"],"advertise-client-urls":["https://162.253.55.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-04T10:59:11.647981Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-04T10:59:11.652344Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.49:2380"}
{"level":"info","ts":"2026-02-04T10:59:11.652393Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.49:2380"}
{"level":"info","ts":"2026-02-04T10:59:12.401669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be is starting a new election at term 1"}
{"level":"info","ts":"2026-02-04T10:59:12.401756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-04T10:59:12.401789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be received MsgPreVoteResp from 6a9ba61e55fef5be at term 1"}
{"level":"info","ts":"2026-02-04T10:59:12.401904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be became candidate at term 2"}
{"level":"info","ts":"2026-02-04T10:59:12.401922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be received MsgVoteResp from 6a9ba61e55fef5be at term 2"}
{"level":"info","ts":"2026-02-04T10:59:12.401957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be became leader at term 2"}
{"level":"info","ts":"2026-02-04T10:59:12.401973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6a9ba61e55fef5be elected leader 6a9ba61e55fef5be at term 2"}
{"level":"info","ts":"2026-02-04T10:59:12.403181Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-04T10:59:12.405507Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9612db6e19ac6ce7","local-member-id":"6a9ba61e55fef5be","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-04T10:59:12.405566Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6a9ba61e55fef5be","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.49:2379]}","request-path":"/0/members/6a9ba61e55fef5be/attributes","cluster-id":"9612db6e19ac6ce7","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-04T10:59:12.405714Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-04T10:59:12.40841Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-04T10:59:12.408425Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-04T10:59:12.408825Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-04T10:59:12.411159Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.49:2379"}
{"level":"info","ts":"2026-02-04T10:59:12.411295Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-04T10:59:12.411311Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-04T10:59:12.413976Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-04T10:59:44.012611Z","caller":"traceutil/trace.go:171","msg":"trace[1102967698] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"128.12771ms","start":"2026-02-04T10:59:43.884466Z","end":"2026-02-04T10:59:44.012593Z","steps":["trace[1102967698] 'process raft request'  (duration: 128.032468ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T10:59:48.783348Z","caller":"traceutil/trace.go:171","msg":"trace[1446021617] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"340.711791ms","start":"2026-02-04T10:59:48.44262Z","end":"2026-02-04T10:59:48.783332Z","steps":["trace[1446021617] 'process raft request'  (duration: 340.603288ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T10:59:48.783843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T10:59:48.442609Z","time spent":"340.971216ms","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:524 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-04T10:59:48.950378Z","caller":"traceutil/trace.go:171","msg":"trace[772722130] linearizableReadLoop","detail":"{readStateIndex:551; appliedIndex:549; }","duration":"502.939906ms","start":"2026-02-04T10:59:48.447418Z","end":"2026-02-04T10:59:48.950358Z","steps":["trace[772722130] 'read index received'  (duration: 335.858213ms)","trace[772722130] 'applied index is now lower than readState.Index'  (duration: 167.080843ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T10:59:48.950628Z","caller":"traceutil/trace.go:171","msg":"trace[405164411] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"506.775961ms","start":"2026-02-04T10:59:48.44384Z","end":"2026-02-04T10:59:48.950616Z","steps":["trace[405164411] 'process raft request'  (duration: 437.060579ms)","trace[405164411] 'compare'  (duration: 69.015626ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T10:59:48.95082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T10:59:48.443834Z","time spent":"506.827303ms","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:523 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-04T10:59:48.951596Z","caller":"traceutil/trace.go:171","msg":"trace[1274802763] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"483.273444ms","start":"2026-02-04T10:59:48.468306Z","end":"2026-02-04T10:59:48.95158Z","steps":["trace[1274802763] 'process raft request'  (duration: 482.005296ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T10:59:48.951674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T10:59:48.468298Z","time spent":"483.337815ms","remote":"127.0.0.1:43236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:535 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4443 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-02-04T10:59:48.951901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.476101ms","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-02-04T10:59:48.951952Z","caller":"traceutil/trace.go:171","msg":"trace[1399614930] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:538; }","duration":"504.551432ms","start":"2026-02-04T10:59:48.447391Z","end":"2026-02-04T10:59:48.951943Z","steps":["trace[1399614930] 'agreement among raft nodes before linearized reading'  (duration: 504.410179ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T10:59:48.951986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T10:59:48.447387Z","time spent":"504.592203ms","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-04T10:59:48.952126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.9288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T10:59:48.952161Z","caller":"traceutil/trace.go:171","msg":"trace[1605880505] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:538; }","duration":"483.980511ms","start":"2026-02-04T10:59:48.468171Z","end":"2026-02-04T10:59:48.952152Z","steps":["trace[1605880505] 'agreement among raft nodes before linearized reading'  (duration: 483.92998ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T10:59:48.952194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T10:59:48.46816Z","time spent":"484.026661ms","remote":"127.0.0.1:33088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 "}
{"level":"warn","ts":"2026-02-04T10:59:48.952449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.34978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T10:59:48.952486Z","caller":"traceutil/trace.go:171","msg":"trace[501785428] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:538; }","duration":"426.392581ms","start":"2026-02-04T10:59:48.526084Z","end":"2026-02-04T10:59:48.952477Z","steps":["trace[501785428] 'agreement among raft nodes before linearized reading'  (duration: 426.33911ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T10:59:48.952514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T10:59:48.526082Z","time spent":"426.424442ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T10:59:48.952637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.548094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T10:59:48.95269Z","caller":"traceutil/trace.go:171","msg":"trace[228126956] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:538; }","duration":"426.608995ms","start":"2026-02-04T10:59:48.526073Z","end":"2026-02-04T10:59:48.952682Z","steps":["trace[228126956] 'agreement among raft nodes before linearized reading'  (duration: 426.542064ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T10:59:48.95273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T10:59:48.52607Z","time spent":"426.651796ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 "}
{"level":"warn","ts":"2026-02-04T10:59:48.956216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.776387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T10:59:48.956294Z","caller":"traceutil/trace.go:171","msg":"trace[1176012496] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:538; }","duration":"450.864829ms","start":"2026-02-04T10:59:48.505422Z","end":"2026-02-04T10:59:48.956287Z","steps":["trace[1176012496] 'agreement among raft nodes before linearized reading'  (duration: 450.773477ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T10:59:48.956314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T10:59:48.505418Z","time spent":"450.890609ms","remote":"127.0.0.1:33100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 "}
{"level":"warn","ts":"2026-02-04T10:59:48.956392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.813512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T10:59:48.956409Z","caller":"traceutil/trace.go:171","msg":"trace[569146025] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:538; }","duration":"452.837862ms","start":"2026-02-04T10:59:48.503567Z","end":"2026-02-04T10:59:48.956405Z","steps":["trace[569146025] 'agreement among raft nodes before linearized reading'  (duration: 452.812952ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T10:59:48.956427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T10:59:48.503563Z","time spent":"452.854933ms","remote":"127.0.0.1:33100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T10:59:48.956488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.065958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T10:59:48.956504Z","caller":"traceutil/trace.go:171","msg":"trace[1094126828] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:538; }","duration":"453.098929ms","start":"2026-02-04T10:59:48.503401Z","end":"2026-02-04T10:59:48.9565Z","steps":["trace[1094126828] 'agreement among raft nodes before linearized reading'  (duration: 453.076518ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T10:59:48.956517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T10:59:48.503393Z","time spent":"453.11999ms","remote":"127.0.0.1:33100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":113,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 "}
{"level":"warn","ts":"2026-02-04T10:59:48.956577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.00685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T10:59:48.956592Z","caller":"traceutil/trace.go:171","msg":"trace[1815187584] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:538; }","duration":"488.027711ms","start":"2026-02-04T10:59:48.468561Z","end":"2026-02-04T10:59:48.956588Z","steps":["trace[1815187584] 'agreement among raft nodes before linearized reading'  (duration: 488.00421ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T10:59:48.956605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T10:59:48.468559Z","time spent":"488.042111ms","remote":"127.0.0.1:33088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T10:59:48.956678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.122833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T10:59:48.956695Z","caller":"traceutil/trace.go:171","msg":"trace[1469878800] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:538; }","duration":"488.147224ms","start":"2026-02-04T10:59:48.468544Z","end":"2026-02-04T10:59:48.956691Z","steps":["trace[1469878800] 'agreement among raft nodes before linearized reading'  (duration: 488.123223ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T10:59:48.956707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T10:59:48.46854Z","time spent":"488.163874ms","remote":"127.0.0.1:33088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 "}
{"level":"warn","ts":"2026-02-04T10:59:48.952854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.792629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T10:59:48.956985Z","caller":"traceutil/trace.go:171","msg":"trace[560509279] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:538; }","duration":"430.942182ms","start":"2026-02-04T10:59:48.526038Z","end":"2026-02-04T10:59:48.95698Z","steps":["trace[560509279] 'agreement among raft nodes before linearized reading'  (duration: 426.79596ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T10:59:48.957008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T10:59:48.526025Z","time spent":"430.976453ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 "}
{"level":"info","ts":"2026-02-04T10:59:49.097436Z","caller":"traceutil/trace.go:171","msg":"trace[1136827819] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"129.839309ms","start":"2026-02-04T10:59:48.967567Z","end":"2026-02-04T10:59:49.097407Z","steps":["trace[1136827819] 'process raft request'  (duration: 117.676966ms)","trace[1136827819] 'compare'  (duration: 12.097621ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T10:59:49.512712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.266576ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17707762481795069329 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:529 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-04T10:59:49.513049Z","caller":"traceutil/trace.go:171","msg":"trace[1942457794] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"339.400102ms","start":"2026-02-04T10:59:49.173631Z","end":"2026-02-04T10:59:49.513031Z","steps":["trace[1942457794] 'process raft request'  (duration: 230.573584ms)","trace[1942457794] 'compare'  (duration: 108.127603ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T10:59:49.513112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T10:59:49.173622Z","time spent":"339.458333ms","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:529 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-04T10:59:50.791734Z","caller":"traceutil/trace.go:171","msg":"trace[2095996877] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"177.984336ms","start":"2026-02-04T10:59:50.61373Z","end":"2026-02-04T10:59:50.791714Z","steps":["trace[2095996877] 'process raft request'  (duration: 177.860663ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T10:59:50.792057Z","caller":"traceutil/trace.go:171","msg":"trace[858217812] linearizableReadLoop","detail":"{readStateIndex:558; appliedIndex:558; }","duration":"176.121524ms","start":"2026-02-04T10:59:50.615922Z","end":"2026-02-04T10:59:50.792044Z","steps":["trace[858217812] 'read index received'  (duration: 176.117124ms)","trace[858217812] 'applied index is now lower than readState.Index'  (duration: 3.76µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T10:59:50.792231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.296179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/cilium-config\" ","response":"range_response_count:1 size:6534"}
{"level":"info","ts":"2026-02-04T10:59:50.792259Z","caller":"traceutil/trace.go:171","msg":"trace[2066065376] range","detail":"{range_begin:/registry/configmaps/kube-system/cilium-config; range_end:; response_count:1; response_revision:544; }","duration":"176.365321ms","start":"2026-02-04T10:59:50.615887Z","end":"2026-02-04T10:59:50.792252Z","steps":["trace[2066065376] 'agreement among raft nodes before linearized reading'  (duration: 176.214167ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:01.900253Z","caller":"traceutil/trace.go:171","msg":"trace[986244134] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"257.764563ms","start":"2026-02-04T11:00:01.642467Z","end":"2026-02-04T11:00:01.900231Z","steps":["trace[986244134] 'process raft request'  (duration: 257.591769ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:01.900415Z","caller":"traceutil/trace.go:171","msg":"trace[88234564] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:641; }","duration":"168.027324ms","start":"2026-02-04T11:00:01.732377Z","end":"2026-02-04T11:00:01.900405Z","steps":["trace[88234564] 'read index received'  (duration: 168.018004ms)","trace[88234564] 'applied index is now lower than readState.Index'  (duration: 4.14µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:00:01.900878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.483344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-04T11:00:01.902032Z","caller":"traceutil/trace.go:171","msg":"trace[798904998] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:623; }","duration":"169.685641ms","start":"2026-02-04T11:00:01.732332Z","end":"2026-02-04T11:00:01.902017Z","steps":["trace[798904998] 'agreement among raft nodes before linearized reading'  (duration: 168.226768ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:02.119083Z","caller":"traceutil/trace.go:171","msg":"trace[1391298707] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"212.804367ms","start":"2026-02-04T11:00:01.906263Z","end":"2026-02-04T11:00:02.119068Z","steps":["trace[1391298707] 'process raft request'  (duration: 211.228941ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:12.445093Z","caller":"traceutil/trace.go:171","msg":"trace[648133987] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"255.358859ms","start":"2026-02-04T11:00:12.189717Z","end":"2026-02-04T11:00:12.445076Z","steps":["trace[648133987] 'process raft request'  (duration: 255.267057ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:27.367199Z","caller":"traceutil/trace.go:171","msg":"trace[545153216] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"116.975309ms","start":"2026-02-04T11:00:27.250204Z","end":"2026-02-04T11:00:27.36718Z","steps":["trace[545153216] 'process raft request'  (duration: 116.865637ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:28.653133Z","caller":"traceutil/trace.go:171","msg":"trace[888044994] linearizableReadLoop","detail":"{readStateIndex:773; appliedIndex:772; }","duration":"115.586787ms","start":"2026-02-04T11:00:28.537529Z","end":"2026-02-04T11:00:28.653116Z","steps":["trace[888044994] 'read index received'  (duration: 115.487405ms)","trace[888044994] 'applied index is now lower than readState.Index'  (duration: 98.622µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:00:28.653264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.716241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-04T11:00:28.653284Z","caller":"traceutil/trace.go:171","msg":"trace[618560163] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:749; }","duration":"115.778192ms","start":"2026-02-04T11:00:28.5375Z","end":"2026-02-04T11:00:28.653279Z","steps":["trace[618560163] 'agreement among raft nodes before linearized reading'  (duration: 115.6788ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:28.653353Z","caller":"traceutil/trace.go:171","msg":"trace[1600569212] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"234.061919ms","start":"2026-02-04T11:00:28.419269Z","end":"2026-02-04T11:00:28.653331Z","steps":["trace[1600569212] 'process raft request'  (duration: 233.752502ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:28.807344Z","caller":"traceutil/trace.go:171","msg":"trace[1969284302] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"151.282426ms","start":"2026-02-04T11:00:28.656034Z","end":"2026-02-04T11:00:28.807317Z","steps":["trace[1969284302] 'process raft request'  (duration: 140.857532ms)","trace[1969284302] 'compare'  (duration: 10.325652ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:00:31.094656Z","caller":"traceutil/trace.go:171","msg":"trace[1544598105] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"208.315942ms","start":"2026-02-04T11:00:30.88632Z","end":"2026-02-04T11:00:31.094636Z","steps":["trace[1544598105] 'process raft request'  (duration: 207.903233ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:48.283795Z","caller":"traceutil/trace.go:171","msg":"trace[1505069356] transaction","detail":"{read_only:false; response_revision:855; number_of_response:1; }","duration":"200.467006ms","start":"2026-02-04T11:00:48.083314Z","end":"2026-02-04T11:00:48.283781Z","steps":["trace[1505069356] 'process raft request'  (duration: 200.380834ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:03.415735Z","caller":"traceutil/trace.go:171","msg":"trace[1291163698] linearizableReadLoop","detail":"{readStateIndex:936; appliedIndex:935; }","duration":"101.983133ms","start":"2026-02-04T11:01:03.313738Z","end":"2026-02-04T11:01:03.415721Z","steps":["trace[1291163698] 'read index received'  (duration: 101.83309ms)","trace[1291163698] 'applied index is now lower than readState.Index'  (duration: 149.563µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:03.415911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.145217ms","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-02-04T11:01:03.415928Z","caller":"traceutil/trace.go:171","msg":"trace[915163398] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:903; }","duration":"102.198688ms","start":"2026-02-04T11:01:03.313724Z","end":"2026-02-04T11:01:03.415923Z","steps":["trace[915163398] 'agreement among raft nodes before linearized reading'  (duration: 102.065786ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:03.416151Z","caller":"traceutil/trace.go:171","msg":"trace[1453022322] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"107.626988ms","start":"2026-02-04T11:01:03.308519Z","end":"2026-02-04T11:01:03.416145Z","steps":["trace[1453022322] 'process raft request'  (duration: 107.106507ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:03.579452Z","caller":"traceutil/trace.go:171","msg":"trace[1636744184] linearizableReadLoop","detail":"{readStateIndex:937; appliedIndex:936; }","duration":"140.144847ms","start":"2026-02-04T11:01:03.439284Z","end":"2026-02-04T11:01:03.579428Z","steps":["trace[1636744184] 'read index received'  (duration: 116.871576ms)","trace[1636744184] 'applied index is now lower than readState.Index'  (duration: 23.27209ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:01:03.579521Z","caller":"traceutil/trace.go:171","msg":"trace[1885800471] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"157.299111ms","start":"2026-02-04T11:01:03.422194Z","end":"2026-02-04T11:01:03.579493Z","steps":["trace[1885800471] 'process raft request'  (duration: 134.00242ms)","trace[1885800471] 'compare'  (duration: 22.997524ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:03.579657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.360071ms","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-02-04T11:01:03.57968Z","caller":"traceutil/trace.go:171","msg":"trace[2129304017] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:904; }","duration":"140.416773ms","start":"2026-02-04T11:01:03.439257Z","end":"2026-02-04T11:01:03.579673Z","steps":["trace[2129304017] 'agreement among raft nodes before linearized reading'  (duration: 140.29696ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:03.579767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.864165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:03.579801Z","caller":"traceutil/trace.go:171","msg":"trace[812824361] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:904; }","duration":"116.945037ms","start":"2026-02-04T11:01:03.462849Z","end":"2026-02-04T11:01:03.579794Z","steps":["trace[812824361] 'agreement among raft nodes before linearized reading'  (duration: 116.888325ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:05.20603Z","caller":"traceutil/trace.go:171","msg":"trace[1331876944] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"385.797815ms","start":"2026-02-04T11:01:04.82022Z","end":"2026-02-04T11:01:05.206018Z","steps":["trace[1331876944] 'process raft request'  (duration: 385.499529ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:05.206134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:04.820205Z","time spent":"385.879758ms","remote":"127.0.0.1:43242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11172,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-gh6lj\" mod_revision:821 > success:<request_put:<key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-gh6lj\" value_size:11108 >> failure:<request_range:<key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-gh6lj\" > >"}
{"level":"warn","ts":"2026-02-04T11:01:05.335451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.032922ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17707762481795070187 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-nodeplugin-http-metrics\" mod_revision:826 > success:<request_put:<key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-nodeplugin-http-metrics\" value_size:829 >> failure:<request_range:<key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-nodeplugin-http-metrics\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-04T11:01:05.335609Z","caller":"traceutil/trace.go:171","msg":"trace[1594332669] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"123.389122ms","start":"2026-02-04T11:01:05.212191Z","end":"2026-02-04T11:01:05.33558Z","steps":["trace[1594332669] 'process raft request'  (duration: 13.145645ms)","trace[1594332669] 'compare'  (duration: 109.801887ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:01:05.339459Z","caller":"traceutil/trace.go:171","msg":"trace[138570870] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"121.738064ms","start":"2026-02-04T11:01:05.217675Z","end":"2026-02-04T11:01:05.339413Z","steps":["trace[138570870] 'process raft request'  (duration: 121.687623ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:05.339634Z","caller":"traceutil/trace.go:171","msg":"trace[1523741166] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"122.722807ms","start":"2026-02-04T11:01:05.216898Z","end":"2026-02-04T11:01:05.339621Z","steps":["trace[1523741166] 'process raft request'  (duration: 122.321067ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:13.765447Z","caller":"traceutil/trace.go:171","msg":"trace[1606410577] linearizableReadLoop","detail":"{readStateIndex:1020; appliedIndex:1019; }","duration":"142.9601ms","start":"2026-02-04T11:01:13.622472Z","end":"2026-02-04T11:01:13.765432Z","steps":["trace[1606410577] 'read index received'  (duration: 65.961727ms)","trace[1606410577] 'applied index is now lower than readState.Index'  (duration: 76.997703ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:13.765681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.195785ms","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-02-04T11:01:13.765714Z","caller":"traceutil/trace.go:171","msg":"trace[1412940938] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:985; }","duration":"143.252017ms","start":"2026-02-04T11:01:13.622452Z","end":"2026-02-04T11:01:13.765704Z","steps":["trace[1412940938] 'agreement among raft nodes before linearized reading'  (duration: 143.105143ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:13.766235Z","caller":"traceutil/trace.go:171","msg":"trace[421626294] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"149.276122ms","start":"2026-02-04T11:01:13.616949Z","end":"2026-02-04T11:01:13.766225Z","steps":["trace[421626294] 'process raft request'  (duration: 71.537022ms)","trace[421626294] 'compare'  (duration: 76.831909ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:13.766242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.742931ms","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-02-04T11:01:13.76651Z","caller":"traceutil/trace.go:171","msg":"trace[228817000] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:985; }","duration":"141.021627ms","start":"2026-02-04T11:01:13.625471Z","end":"2026-02-04T11:01:13.766493Z","steps":["trace[228817000] 'agreement among raft nodes before linearized reading'  (duration: 140.676069ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:13.906899Z","caller":"traceutil/trace.go:171","msg":"trace[1000462650] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"125.276984ms","start":"2026-02-04T11:01:13.781607Z","end":"2026-02-04T11:01:13.906884Z","steps":["trace[1000462650] 'process raft request'  (duration: 125.244614ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:13.907257Z","caller":"traceutil/trace.go:171","msg":"trace[1690007758] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"135.078053ms","start":"2026-02-04T11:01:13.77217Z","end":"2026-02-04T11:01:13.907248Z","steps":["trace[1690007758] 'process raft request'  (duration: 127.692427ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:44.04197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.678767849s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-04T11:02:44.046422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.92001811s","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-02-04T11:02:44.046966Z","caller":"traceutil/trace.go:171","msg":"trace[1561167198] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1345; }","duration":"2.683135888s","start":"2026-02-04T11:02:41.363176Z","end":"2026-02-04T11:02:44.046312Z","steps":["trace[1561167198] 'range keys from in-memory index tree'  (duration: 2.678753439s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:44.04778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"894.825373ms","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-02-04T11:02:44.047805Z","caller":"traceutil/trace.go:171","msg":"trace[1114425436] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1345; }","duration":"894.882393ms","start":"2026-02-04T11:02:43.152914Z","end":"2026-02-04T11:02:44.047797Z","steps":["trace[1114425436] 'range keys from in-memory index tree'  (duration: 894.774821ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:44.047837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:43.152902Z","time spent":"894.929905ms","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}
{"level":"warn","ts":"2026-02-04T11:02:44.042153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.061095542s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-04T11:02:44.052106Z","caller":"traceutil/trace.go:171","msg":"trace[45138447] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1345; }","duration":"1.071066737s","start":"2026-02-04T11:02:42.981017Z","end":"2026-02-04T11:02:44.052084Z","steps":["trace[45138447] 'count revisions from in-memory index tree'  (duration: 1.06101837s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:44.052135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:42.981004Z","time spent":"1.071117518s","remote":"127.0.0.1:43510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":3,"response size":30,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:02:44.042642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.14384294s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-04T11:02:44.052807Z","caller":"traceutil/trace.go:171","msg":"trace[600478027] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1345; }","duration":"2.154030559s","start":"2026-02-04T11:02:41.898768Z","end":"2026-02-04T11:02:44.052798Z","steps":["trace[600478027] 'range keys from in-memory index tree'  (duration: 2.143710387s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:44.052885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:41.898755Z","time spent":"2.15412014s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-04T11:02:44.04287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.934093545s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"}
{"level":"info","ts":"2026-02-04T11:02:44.053396Z","caller":"traceutil/trace.go:171","msg":"trace[1027017278] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1345; }","duration":"1.944652312s","start":"2026-02-04T11:02:42.108735Z","end":"2026-02-04T11:02:44.053387Z","steps":["trace[1027017278] 'range keys from in-memory index tree'  (duration: 1.933980902s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:44.053489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:42.108717Z","time spent":"1.944761715s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"info","ts":"2026-02-04T11:02:44.0593Z","caller":"traceutil/trace.go:171","msg":"trace[885225657] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1345; }","duration":"1.920061801s","start":"2026-02-04T11:02:42.126377Z","end":"2026-02-04T11:02:44.046439Z","steps":["trace[885225657] 'range keys from in-memory index tree'  (duration: 1.91645748s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:44.059451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:42.126368Z","time spent":"1.933036272s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-04T11:02:44.059668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.864936713s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-04T11:02:44.059738Z","caller":"traceutil/trace.go:171","msg":"trace[1035191793] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1345; }","duration":"1.865040436s","start":"2026-02-04T11:02:42.19469Z","end":"2026-02-04T11:02:44.059731Z","steps":["trace[1035191793] 'count revisions from in-memory index tree'  (duration: 1.864849751s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:44.059922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:42.194671Z","time spent":"1.865241571s","remote":"127.0.0.1:43250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":4,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:02:44.060217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.694568962s","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-02-04T11:02:44.06027Z","caller":"traceutil/trace.go:171","msg":"trace[1506001498] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1345; }","duration":"1.694629504s","start":"2026-02-04T11:02:42.365633Z","end":"2026-02-04T11:02:44.060263Z","steps":["trace[1506001498] 'range keys from in-memory index tree'  (duration: 1.694509641s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:44.060297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:42.36563Z","time spent":"1.694661914s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-04T11:02:44.060386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.694791917s","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-02-04T11:02:44.060431Z","caller":"traceutil/trace.go:171","msg":"trace[1527427871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1345; }","duration":"1.694865639s","start":"2026-02-04T11:02:42.36556Z","end":"2026-02-04T11:02:44.060426Z","steps":["trace[1527427871] 'range keys from in-memory index tree'  (duration: 1.694680255s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:44.060457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:42.365545Z","time spent":"1.69490672s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-04T11:02:44.060523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.598700422s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:02:44.060554Z","caller":"traceutil/trace.go:171","msg":"trace[358141284] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1345; }","duration":"1.598760794s","start":"2026-02-04T11:02:42.461788Z","end":"2026-02-04T11:02:44.060549Z","steps":["trace[358141284] 'range keys from in-memory index tree'  (duration: 1.598648461s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:44.060599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:42.461776Z","time spent":"1.598818505s","remote":"127.0.0.1:43110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-04T11:02:44.061393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.26164009s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:527"}
{"level":"info","ts":"2026-02-04T11:02:44.06144Z","caller":"traceutil/trace.go:171","msg":"trace[1674533014] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1345; }","duration":"1.261709912s","start":"2026-02-04T11:02:42.799722Z","end":"2026-02-04T11:02:44.061432Z","steps":["trace[1674533014] 'range keys from in-memory index tree'  (duration: 1.261567879s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:44.061818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:42.799709Z","time spent":"1.262101061s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":550,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-04T11:02:44.061921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.195533378s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-04T11:02:44.061986Z","caller":"traceutil/trace.go:171","msg":"trace[252543052] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1345; }","duration":"1.195634551s","start":"2026-02-04T11:02:42.866346Z","end":"2026-02-04T11:02:44.06198Z","steps":["trace[252543052] 'range keys from in-memory index tree'  (duration: 1.195435677s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:44.064685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:42.866326Z","time spent":"1.195680892s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-04T11:02:48.58726Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071301,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:02:49.097696Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071301,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:02:49.597787Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071301,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:02:50.098385Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071301,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:02:50.599516Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071301,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:02:51.100541Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071301,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:02:51.4629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000431814s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:02:51.464695Z","caller":"traceutil/trace.go:171","msg":"trace[1723773065] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.002271345s","start":"2026-02-04T11:02:49.46241Z","end":"2026-02-04T11:02:51.464681Z","steps":["trace[1723773065] 'agreement among raft nodes before linearized reading'  (duration: 2.000446914s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:51.466696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:49.462402Z","time spent":"2.00428221s","remote":"127.0.0.1:43110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/04 11:02:51 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:02:51.601563Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071301,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:02:52.102659Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071301,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:02:52.602966Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071301,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:02:53.078705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:48.079103Z","time spent":"4.99959578s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:02:53.095925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.998836113s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:02:53.096015Z","caller":"traceutil/trace.go:171","msg":"trace[1892270767] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.998934155s","start":"2026-02-04T11:02:48.097053Z","end":"2026-02-04T11:02:53.095987Z","steps":["trace[1892270767] 'agreement among raft nodes before linearized reading'  (duration: 4.998831662s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:53.096069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:48.097037Z","time spent":"4.999022417s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-04T11:02:53.099514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.000542631s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:02:53.09957Z","caller":"traceutil/trace.go:171","msg":"trace[502708600] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"5.000621863s","start":"2026-02-04T11:02:48.098934Z","end":"2026-02-04T11:02:53.099556Z","steps":["trace[502708600] 'agreement among raft nodes before linearized reading'  (duration: 5.000548462s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:53.099609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:48.098928Z","time spent":"5.000669744s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-04T11:02:53.103987Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071301,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:02:53.464494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000657619s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:02:53.464595Z","caller":"traceutil/trace.go:171","msg":"trace[2082405450] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000896264s","start":"2026-02-04T11:02:51.46367Z","end":"2026-02-04T11:02:53.464566Z","steps":["trace[2082405450] 'agreement among raft nodes before linearized reading'  (duration: 2.000781581s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:53.464697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:51.463654Z","time spent":"2.000987966s","remote":"127.0.0.1:43116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-04T11:02:53.604606Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071301,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:02:54.105673Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071301,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:02:54.60576Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071301,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:02:55.087023Z","caller":"etcdserver/v3_server.go:909","msg":"timed out waiting for read index response (local node might have slow network)","timeout":"7s"}
{"level":"warn","ts":"2026-02-04T11:02:55.087392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.000896513s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-02-04T11:02:55.087566Z","caller":"traceutil/trace.go:171","msg":"trace[1221156454] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; }","duration":"7.001024795s","start":"2026-02-04T11:02:48.086441Z","end":"2026-02-04T11:02:55.087466Z","steps":["trace[1221156454] 'agreement among raft nodes before linearized reading'  (duration: 7.000919983s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:55.087743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:48.086429Z","time spent":"7.001180409s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}
{"level":"warn","ts":"2026-02-04T11:02:55.477065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000299021s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:02:55.477138Z","caller":"traceutil/trace.go:171","msg":"trace[1053026438] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000423683s","start":"2026-02-04T11:02:53.476697Z","end":"2026-02-04T11:02:55.47712Z","steps":["trace[1053026438] 'agreement among raft nodes before linearized reading'  (duration: 2.000314371s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:55.477186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:53.476645Z","time spent":"2.000527705s","remote":"127.0.0.1:43110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-04T11:02:55.588144Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071308,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:02:56.089103Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071308,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:02:56.207558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:49.20745Z","time spent":"7.000100375s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:02:56.589955Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071308,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:02:57.090643Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071308,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:02:57.478164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000468774s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:02:57.478619Z","caller":"traceutil/trace.go:171","msg":"trace[1745057103] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000966056s","start":"2026-02-04T11:02:55.477633Z","end":"2026-02-04T11:02:57.4786Z","steps":["trace[1745057103] 'agreement among raft nodes before linearized reading'  (duration: 2.000491615s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:57.479023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:55.47762Z","time spent":"2.001387215s","remote":"127.0.0.1:43116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/04 11:02:57 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:02:57.591997Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071308,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:02:57.886072Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"75be9c284e627ccd","error":"etcdserver: request timed out"}
{"level":"warn","ts":"2026-02-04T11:02:58.076972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.93241965s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:02:58.077067Z","caller":"traceutil/trace.go:171","msg":"trace[553741245] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"2.932582523s","start":"2026-02-04T11:02:55.144466Z","end":"2026-02-04T11:02:58.077048Z","steps":["trace[553741245] 'agreement among raft nodes before linearized reading'  (duration: 2.93246793s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:58.077126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:55.144439Z","time spent":"2.932678005s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
2026/02/04 11:02:58 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:02:58.086583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"994.785966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:02:58.086647Z","caller":"traceutil/trace.go:171","msg":"trace[1944739289] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; }","duration":"994.868188ms","start":"2026-02-04T11:02:57.091752Z","end":"2026-02-04T11:02:58.08662Z","steps":["trace[1944739289] 'agreement among raft nodes before linearized reading'  (duration: 994.810136ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:58.08668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:57.091736Z","time spent":"994.93794ms","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}
2026/02/04 11:02:58 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:02:58.09285Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071308,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:02:58.096447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.932143054s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:02:58.096476Z","caller":"traceutil/trace.go:171","msg":"trace[1633051124] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"2.932198076s","start":"2026-02-04T11:02:55.16427Z","end":"2026-02-04T11:02:58.096468Z","steps":["trace[1633051124] 'agreement among raft nodes before linearized reading'  (duration: 2.932166185s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:58.096498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:55.164257Z","time spent":"2.932235916s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
2026/02/04 11:02:58 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:02:58.101479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.000230451s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:02:58.101509Z","caller":"traceutil/trace.go:171","msg":"trace[169580471] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"3.000309773s","start":"2026-02-04T11:02:55.101192Z","end":"2026-02-04T11:02:58.101502Z","steps":["trace[169580471] 'agreement among raft nodes before linearized reading'  (duration: 3.000273552s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:58.101541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:55.101175Z","time spent":"3.000360114s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
2026/02/04 11:02:58 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:02:58.1189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.023494325s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:02:58.118981Z","caller":"traceutil/trace.go:171","msg":"trace[270329502] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; }","duration":"10.023601398s","start":"2026-02-04T11:02:48.09536Z","end":"2026-02-04T11:02:58.118961Z","steps":["trace[270329502] 'agreement among raft nodes before linearized reading'  (duration: 10.023500686s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:58.119037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:48.095355Z","time spent":"10.0236725s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
2026/02/04 11:02:58 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:02:58.211913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.119801316s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:02:58.211998Z","caller":"traceutil/trace.go:171","msg":"trace[1936259149] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; }","duration":"10.119918548s","start":"2026-02-04T11:02:48.092062Z","end":"2026-02-04T11:02:58.211981Z","steps":["trace[1936259149] 'agreement among raft nodes before linearized reading'  (duration: 10.119809905s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:58.212048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:48.092056Z","time spent":"10.119983839s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
2026/02/04 11:02:58 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:02:58.264028Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"10.184548969s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-04T11:02:58.273063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:51.272523Z","time spent":"7.000537505s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:02:58.311417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:53.468948Z","time spent":"4.842465466s","remote":"127.0.0.1:43154","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-02-04T11:02:58.312097Z","caller":"traceutil/trace.go:171","msg":"trace[518057485] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1365; }","duration":"2.06536435s","start":"2026-02-04T11:02:56.246715Z","end":"2026-02-04T11:02:58.312079Z","steps":["trace[518057485] 'process raft request'  (duration: 2.064328288s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:58.312208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:56.246692Z","time spent":"2.065452752s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":69,"response count":0,"response size":720,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1336 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-04T11:02:58.316775Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"5.37529ms","request":"header:<ID:17707762481795071310 > lease_revoke:<id:75be9c284e627ccd>","response":"size:28","error":"lease not found"}
{"level":"warn","ts":"2026-02-04T11:02:58.3172Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"75be9c284e627ccd","error":"lease not found"}
{"level":"info","ts":"2026-02-04T11:02:58.317327Z","caller":"traceutil/trace.go:171","msg":"trace[857623487] transaction","detail":"{read_only:false; response_revision:1366; number_of_response:1; }","duration":"219.360431ms","start":"2026-02-04T11:02:58.097952Z","end":"2026-02-04T11:02:58.317312Z","steps":["trace[857623487] 'process raft request'  (duration: 218.88601ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:02:58.317411Z","caller":"traceutil/trace.go:171","msg":"trace[990062381] transaction","detail":"{read_only:false; response_revision:1367; number_of_response:1; }","duration":"214.637585ms","start":"2026-02-04T11:02:58.102767Z","end":"2026-02-04T11:02:58.317405Z","steps":["trace[990062381] 'process raft request'  (duration: 214.176915ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:02:58.317562Z","caller":"traceutil/trace.go:171","msg":"trace[849365622] linearizableReadLoop","detail":"{readStateIndex:1423; appliedIndex:1417; }","duration":"3.230379203s","start":"2026-02-04T11:02:55.087176Z","end":"2026-02-04T11:02:58.317555Z","steps":["trace[849365622] 'read index received'  (duration: 3.18163031s)","trace[849365622] 'applied index is now lower than readState.Index'  (duration: 48.748223ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:02:58.317748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.464995036s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:02:58.317776Z","caller":"traceutil/trace.go:171","msg":"trace[1588343826] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1370; }","duration":"3.465069018s","start":"2026-02-04T11:02:54.8527Z","end":"2026-02-04T11:02:58.317769Z","steps":["trace[1588343826] 'agreement among raft nodes before linearized reading'  (duration: 3.465019317s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:58.317804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:54.852648Z","time spent":"3.465149579s","remote":"127.0.0.1:43512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:02:58.317896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.949303451s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kubeadm-config\" ","response":"range_response_count:1 size:999"}
{"level":"info","ts":"2026-02-04T11:02:58.317918Z","caller":"traceutil/trace.go:171","msg":"trace[1351244078] range","detail":"{range_begin:/registry/configmaps/kube-system/kubeadm-config; range_end:; response_count:1; response_revision:1370; }","duration":"3.949370522s","start":"2026-02-04T11:02:54.368542Z","end":"2026-02-04T11:02:58.317912Z","steps":["trace[1351244078] 'agreement among raft nodes before linearized reading'  (duration: 3.949331241s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:58.317939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:54.3685Z","time spent":"3.949433953s","remote":"127.0.0.1:43178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":1022,"request content":"key:\"/registry/configmaps/kube-system/kubeadm-config\" "}
{"level":"warn","ts":"2026-02-04T11:02:58.318042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.917070779s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-04T11:02:58.318064Z","caller":"traceutil/trace.go:171","msg":"trace[1440924253] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1370; }","duration":"4.91712299s","start":"2026-02-04T11:02:53.400936Z","end":"2026-02-04T11:02:58.318059Z","steps":["trace[1440924253] 'agreement among raft nodes before linearized reading'  (duration: 4.917069709s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:58.318085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:53.400899Z","time spent":"4.917180921s","remote":"127.0.0.1:43260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":42,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:02:58.318169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.201065739s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:02:58.31819Z","caller":"traceutil/trace.go:171","msg":"trace[875583997] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1370; }","duration":"5.20111194s","start":"2026-02-04T11:02:53.117073Z","end":"2026-02-04T11:02:58.318185Z","steps":["trace[875583997] 'agreement among raft nodes before linearized reading'  (duration: 5.201079219s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:58.318211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:53.11706Z","time spent":"5.201146291s","remote":"127.0.0.1:43346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:02:58.31835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.468279588s","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:536"}
{"level":"info","ts":"2026-02-04T11:02:58.318372Z","caller":"traceutil/trace.go:171","msg":"trace[151964337] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1370; }","duration":"7.468326248s","start":"2026-02-04T11:02:50.85004Z","end":"2026-02-04T11:02:58.318366Z","steps":["trace[151964337] 'agreement among raft nodes before linearized reading'  (duration: 7.468252366s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:58.318393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:50.850026Z","time spent":"7.468362s","remote":"127.0.0.1:43314","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\" "}
{"level":"warn","ts":"2026-02-04T11:02:58.318466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.132702361s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-04T11:02:58.318494Z","caller":"traceutil/trace.go:171","msg":"trace[329765354] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1370; }","duration":"8.132757083s","start":"2026-02-04T11:02:50.185731Z","end":"2026-02-04T11:02:58.318488Z","steps":["trace[329765354] 'agreement among raft nodes before linearized reading'  (duration: 8.132708422s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:58.318517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:50.185715Z","time spent":"8.132796873s","remote":"127.0.0.1:43396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":30,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:02:58.318604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.901276191s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-04T11:02:58.318626Z","caller":"traceutil/trace.go:171","msg":"trace[596507517] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1370; }","duration":"8.901368954s","start":"2026-02-04T11:02:49.417251Z","end":"2026-02-04T11:02:58.31862Z","steps":["trace[596507517] 'agreement among raft nodes before linearized reading'  (duration: 8.901326633s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:58.318647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:49.417228Z","time spent":"8.901413344s","remote":"127.0.0.1:43534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":23,"response size":30,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:02:58.318743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.235959528s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"}
{"level":"info","ts":"2026-02-04T11:02:58.318764Z","caller":"traceutil/trace.go:171","msg":"trace[1977190790] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1370; }","duration":"9.23602981s","start":"2026-02-04T11:02:49.082729Z","end":"2026-02-04T11:02:58.318759Z","steps":["trace[1977190790] 'agreement among raft nodes before linearized reading'  (duration: 9.235978729s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:58.318784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:49.08271Z","time spent":"9.236069832s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-04T11:02:58.318881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.239896938s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:527"}
{"level":"info","ts":"2026-02-04T11:02:58.318901Z","caller":"traceutil/trace.go:171","msg":"trace[2022851556] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1370; }","duration":"9.239933259s","start":"2026-02-04T11:02:49.078963Z","end":"2026-02-04T11:02:58.318896Z","steps":["trace[2022851556] 'agreement among raft nodes before linearized reading'  (duration: 9.239870746s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:58.318918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:49.078959Z","time spent":"9.23995424s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":550,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-04T11:02:58.319005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.24044219s","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:510"}
{"level":"info","ts":"2026-02-04T11:02:58.319026Z","caller":"traceutil/trace.go:171","msg":"trace[95288721] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1370; }","duration":"9.24046268s","start":"2026-02-04T11:02:49.078558Z","end":"2026-02-04T11:02:58.319021Z","steps":["trace[95288721] 'agreement among raft nodes before linearized reading'  (duration: 9.240412709s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:58.319042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:49.078526Z","time spent":"9.240511542s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-04T11:02:58.319129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.805462153s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.49\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-02-04T11:02:58.319149Z","caller":"traceutil/trace.go:171","msg":"trace[1274296194] range","detail":"{range_begin:/registry/masterleases/162.253.55.49; range_end:; response_count:1; response_revision:1370; }","duration":"2.805521314s","start":"2026-02-04T11:02:55.513623Z","end":"2026-02-04T11:02:58.319144Z","steps":["trace[1274296194] 'agreement among raft nodes before linearized reading'  (duration: 2.805472313s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:58.319221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:55.513602Z","time spent":"2.805561755s","remote":"127.0.0.1:43122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.49\" "}
{"level":"warn","ts":"2026-02-04T11:02:58.319595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.666901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:02:58.319622Z","caller":"traceutil/trace.go:171","msg":"trace[2645610] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1370; }","duration":"833.696562ms","start":"2026-02-04T11:02:57.485919Z","end":"2026-02-04T11:02:58.319615Z","steps":["trace[2645610] 'agreement among raft nodes before linearized reading'  (duration: 833.662381ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:58.319639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:57.485834Z","time spent":"833.801364ms","remote":"127.0.0.1:43116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-04T11:02:58.319708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"953.307935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:02:58.319731Z","caller":"traceutil/trace.go:171","msg":"trace[1848997492] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1370; }","duration":"953.367656ms","start":"2026-02-04T11:02:57.366358Z","end":"2026-02-04T11:02:58.319726Z","steps":["trace[1848997492] 'agreement among raft nodes before linearized reading'  (duration: 953.339415ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:58.319747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:57.366336Z","time spent":"953.406457ms","remote":"127.0.0.1:43110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-04T11:02:58.319819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.534541475s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-04T11:02:58.31984Z","caller":"traceutil/trace.go:171","msg":"trace[1146129376] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1370; }","duration":"2.534596305s","start":"2026-02-04T11:02:55.785239Z","end":"2026-02-04T11:02:58.319835Z","steps":["trace[1146129376] 'agreement among raft nodes before linearized reading'  (duration: 2.534563345s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:58.319857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:55.785221Z","time spent":"2.534631037s","remote":"127.0.0.1:33126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":2,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "}
{"level":"info","ts":"2026-02-04T11:03:18.594276Z","caller":"traceutil/trace.go:171","msg":"trace[879744857] linearizableReadLoop","detail":"{readStateIndex:1540; appliedIndex:1539; }","duration":"184.07347ms","start":"2026-02-04T11:03:18.410179Z","end":"2026-02-04T11:03:18.594253Z","steps":["trace[879744857] 'read index received'  (duration: 183.871315ms)","trace[879744857] 'applied index is now lower than readState.Index'  (duration: 201.205µs)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:03:18.594604Z","caller":"traceutil/trace.go:171","msg":"trace[1956713505] transaction","detail":"{read_only:false; response_revision:1476; number_of_response:1; }","duration":"191.319651ms","start":"2026-02-04T11:03:18.403271Z","end":"2026-02-04T11:03:18.594591Z","steps":["trace[1956713505] 'process raft request'  (duration: 190.838931ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:18.594921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.730444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"}
{"level":"info","ts":"2026-02-04T11:03:18.594957Z","caller":"traceutil/trace.go:171","msg":"trace[1205040289] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1476; }","duration":"184.794525ms","start":"2026-02-04T11:03:18.410152Z","end":"2026-02-04T11:03:18.594947Z","steps":["trace[1205040289] 'agreement among raft nodes before linearized reading'  (duration: 184.639352ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:18.595158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.385898ms","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:510"}
{"level":"info","ts":"2026-02-04T11:03:18.595189Z","caller":"traceutil/trace.go:171","msg":"trace[1391879593] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1476; }","duration":"181.44087ms","start":"2026-02-04T11:03:18.413737Z","end":"2026-02-04T11:03:18.595178Z","steps":["trace[1391879593] 'agreement among raft nodes before linearized reading'  (duration: 181.349427ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:18.595656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.159796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:527"}
{"level":"info","ts":"2026-02-04T11:03:18.595747Z","caller":"traceutil/trace.go:171","msg":"trace[1035999608] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1476; }","duration":"153.257358ms","start":"2026-02-04T11:03:18.442473Z","end":"2026-02-04T11:03:18.595731Z","steps":["trace[1035999608] 'agreement among raft nodes before linearized reading'  (duration: 153.105765ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:18.595921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.272805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:03:18.59604Z","caller":"traceutil/trace.go:171","msg":"trace[641583236] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1476; }","duration":"135.394348ms","start":"2026-02-04T11:03:18.460635Z","end":"2026-02-04T11:03:18.596029Z","steps":["trace[641583236] 'agreement among raft nodes before linearized reading'  (duration: 135.256065ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:18.596742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.695454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:1 size:212"}
{"level":"info","ts":"2026-02-04T11:03:18.596857Z","caller":"traceutil/trace.go:171","msg":"trace[628933863] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:1; response_revision:1476; }","duration":"156.835088ms","start":"2026-02-04T11:03:18.440007Z","end":"2026-02-04T11:03:18.596842Z","steps":["trace[628933863] 'agreement among raft nodes before linearized reading'  (duration: 156.403828ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:19.119046Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071638,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:19.619603Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071638,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:20.120454Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071638,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:20.620853Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071638,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:21.121934Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071638,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:21.462396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000227619s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:03:21.462469Z","caller":"traceutil/trace.go:171","msg":"trace[1442781899] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000339091s","start":"2026-02-04T11:03:19.462113Z","end":"2026-02-04T11:03:21.462452Z","steps":["trace[1442781899] 'agreement among raft nodes before linearized reading'  (duration: 2.000248869s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:21.462512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:19.4621Z","time spent":"2.000404683s","remote":"127.0.0.1:43110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/04 11:03:21 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:03:21.622732Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071638,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:22.124047Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071638,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:22.624795Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071638,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:23.12531Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071638,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:23.463037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999788648s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:03:23.46313Z","caller":"traceutil/trace.go:171","msg":"trace[340197316] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000344831s","start":"2026-02-04T11:03:21.462766Z","end":"2026-02-04T11:03:23.463111Z","steps":["trace[340197316] 'agreement among raft nodes before linearized reading'  (duration: 1.999816689s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:23.463185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:21.462753Z","time spent":"2.000417692s","remote":"127.0.0.1:43116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/04 11:03:23 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:03:23.60404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:18.605772Z","time spent":"4.998261151s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
2026/02/04 11:03:23 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:03:23.625826Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071638,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:24.125952Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071638,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:24.561298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999283152s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:03:24.561359Z","caller":"traceutil/trace.go:171","msg":"trace[1104651076] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999381014s","start":"2026-02-04T11:03:19.561963Z","end":"2026-02-04T11:03:24.561344Z","steps":["trace[1104651076] 'agreement among raft nodes before linearized reading'  (duration: 4.999305043s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:24.561399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:19.561948Z","time spent":"4.999440645s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-04T11:03:24.604195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999805215s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:03:24.604243Z","caller":"traceutil/trace.go:171","msg":"trace[871827169] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999881786s","start":"2026-02-04T11:03:19.604349Z","end":"2026-02-04T11:03:24.60423Z","steps":["trace[871827169] 'agreement among raft nodes before linearized reading'  (duration: 4.999827735s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:24.604278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:19.604339Z","time spent":"4.999930548s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
2026/02/04 11:03:24 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:03:24.626846Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071638,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:25.127271Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071638,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:25.468315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999977143s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:03:25.468411Z","caller":"traceutil/trace.go:171","msg":"trace[423787781] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000123496s","start":"2026-02-04T11:03:23.468273Z","end":"2026-02-04T11:03:25.468397Z","steps":["trace[423787781] 'agreement among raft nodes before linearized reading'  (duration: 2.000005864s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:25.468439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:23.468262Z","time spent":"2.000171937s","remote":"127.0.0.1:43110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-04T11:03:25.60836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:18.607227Z","time spent":"7.001127138s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:03:25.609846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:18.608913Z","time spent":"7.000930315s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:03:25.619215Z","caller":"etcdserver/v3_server.go:909","msg":"timed out waiting for read index response (local node might have slow network)","timeout":"7s"}
{"level":"warn","ts":"2026-02-04T11:03:25.619267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.001018925s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pvc-protection-controller\" ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-02-04T11:03:25.619296Z","caller":"traceutil/trace.go:171","msg":"trace[2092163862] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pvc-protection-controller; range_end:; }","duration":"7.001075336s","start":"2026-02-04T11:03:18.618209Z","end":"2026-02-04T11:03:25.619285Z","steps":["trace[2092163862] 'agreement among raft nodes before linearized reading'  (duration: 7.001039375s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:25.619317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:18.6182Z","time spent":"7.001110678s","remote":"127.0.0.1:43260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":0,"response size":0,"request content":"key:\"/registry/serviceaccounts/kube-system/pvc-protection-controller\" "}
{"level":"warn","ts":"2026-02-04T11:03:25.795205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:18.794661Z","time spent":"7.000540154s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:03:25.886052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:18.885709Z","time spent":"7.00033541s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:03:26.120241Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071646,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:26.620988Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071646,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:27.121156Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071646,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:27.468835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999988264s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:03:27.468923Z","caller":"traceutil/trace.go:171","msg":"trace[2009152386] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000111127s","start":"2026-02-04T11:03:25.468793Z","end":"2026-02-04T11:03:27.468904Z","steps":["trace[2009152386] 'agreement among raft nodes before linearized reading'  (duration: 1.999999814s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:27.46898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:25.468784Z","time spent":"2.000186288s","remote":"127.0.0.1:43116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/04 11:03:27 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:03:27.621594Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071646,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:27.922671Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"75be9c284e627de1","error":"etcdserver: request timed out"}
{"level":"warn","ts":"2026-02-04T11:03:28.121893Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071646,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:28.598268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.99307842s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:03:28.598345Z","caller":"traceutil/trace.go:171","msg":"trace[1703049055] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"2.993207273s","start":"2026-02-04T11:03:25.605119Z","end":"2026-02-04T11:03:28.598326Z","steps":["trace[1703049055] 'agreement among raft nodes before linearized reading'  (duration: 2.993112161s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:28.598391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:25.605102Z","time spent":"2.993280154s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
2026/02/04 11:03:28 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:03:28.62241Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071646,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:29.123388Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071646,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:29.2846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.007654039s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:03:29.284724Z","caller":"traceutil/trace.go:171","msg":"trace[1829626637] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; }","duration":"10.007803103s","start":"2026-02-04T11:03:19.276886Z","end":"2026-02-04T11:03:29.284689Z","steps":["trace[1829626637] 'agreement among raft nodes before linearized reading'  (duration: 10.00767955s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:29.284778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:19.27687Z","time spent":"10.007897504s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}
2026/02/04 11:03:29 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:03:29.477635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000946164s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:03:29.477781Z","caller":"traceutil/trace.go:171","msg":"trace[758608093] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001134969s","start":"2026-02-04T11:03:27.476598Z","end":"2026-02-04T11:03:29.477733Z","steps":["trace[758608093] 'agreement among raft nodes before linearized reading'  (duration: 2.000964665s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:29.477855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:27.476586Z","time spent":"2.001255571s","remote":"127.0.0.1:43110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-04T11:03:29.606219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.99710883s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:03:29.606431Z","caller":"traceutil/trace.go:171","msg":"trace[300973882] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"2.997392786s","start":"2026-02-04T11:03:26.609025Z","end":"2026-02-04T11:03:29.606418Z","steps":["trace[300973882] 'agreement among raft nodes before linearized reading'  (duration: 2.997145361s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:29.606521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:26.609002Z","time spent":"2.99750848s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
2026/02/04 11:03:29 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:03:29.624092Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071646,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:29.924682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.000471639s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:03:29.924748Z","caller":"traceutil/trace.go:171","msg":"trace[18067972] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; }","duration":"10.000592801s","start":"2026-02-04T11:03:19.924137Z","end":"2026-02-04T11:03:29.92473Z","steps":["trace[18067972] 'agreement among raft nodes before linearized reading'  (duration: 10.000493159s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:29.924804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:19.924122Z","time spent":"10.000658933s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
2026/02/04 11:03:29 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:03:29.93538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.001093953s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:03:29.935406Z","caller":"traceutil/trace.go:171","msg":"trace[179804428] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; }","duration":"10.001150514s","start":"2026-02-04T11:03:19.93425Z","end":"2026-02-04T11:03:29.9354Z","steps":["trace[179804428] 'agreement among raft nodes before linearized reading'  (duration: 10.001103113s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:29.935423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:19.934245Z","time spent":"10.001174554s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
2026/02/04 11:03:29 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:03:30.124556Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071646,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:30.62505Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071646,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:31.125614Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071646,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:31.478921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000666049s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:03:31.479019Z","caller":"traceutil/trace.go:171","msg":"trace[817044857] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000775962s","start":"2026-02-04T11:03:29.478204Z","end":"2026-02-04T11:03:31.478979Z","steps":["trace[817044857] 'agreement among raft nodes before linearized reading'  (duration: 2.00068262s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:31.479078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:29.478184Z","time spent":"2.000884554s","remote":"127.0.0.1:43116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/04 11:03:31 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:03:31.626081Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071646,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:32.126942Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071646,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:32.266536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000078626s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:03:32.266597Z","caller":"traceutil/trace.go:171","msg":"trace[1026375620] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000193188s","start":"2026-02-04T11:03:30.266386Z","end":"2026-02-04T11:03:32.266579Z","steps":["trace[1026375620] 'agreement among raft nodes before linearized reading'  (duration: 2.000118006s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:32.266651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:30.266368Z","time spent":"2.00027331s","remote":"127.0.0.1:43110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-04T11:03:32.619324Z","caller":"etcdserver/v3_server.go:909","msg":"timed out waiting for read index response (local node might have slow network)","timeout":"7s"}
{"level":"warn","ts":"2026-02-04T11:03:32.619477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.10418664s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.49\" ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-02-04T11:03:32.619519Z","caller":"traceutil/trace.go:171","msg":"trace[2141175805] range","detail":"{range_begin:/registry/masterleases/162.253.55.49; range_end:; }","duration":"7.104268472s","start":"2026-02-04T11:03:25.515233Z","end":"2026-02-04T11:03:32.619501Z","steps":["trace[2141175805] 'agreement among raft nodes before linearized reading'  (duration: 7.104208031s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:32.619561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:25.51522Z","time spent":"7.104332233s","remote":"127.0.0.1:43122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":0,"request content":"key:\"/registry/masterleases/162.253.55.49\" "}
{"level":"warn","ts":"2026-02-04T11:03:32.619614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.200829088s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-02-04T11:03:32.619634Z","caller":"traceutil/trace.go:171","msg":"trace[2023127275] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; }","duration":"7.20087921s","start":"2026-02-04T11:03:25.418749Z","end":"2026-02-04T11:03:32.619628Z","steps":["trace[2023127275] 'agreement among raft nodes before linearized reading'  (duration: 7.200852859s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:32.619661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:25.418736Z","time spent":"7.20091842s","remote":"127.0.0.1:43530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":0,"response size":0,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:03:32.619712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.995864953s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-02-04T11:03:32.619732Z","caller":"traceutil/trace.go:171","msg":"trace[831130123] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; }","duration":"8.995940405s","start":"2026-02-04T11:03:23.623785Z","end":"2026-02-04T11:03:32.619726Z","steps":["trace[831130123] 'agreement among raft nodes before linearized reading'  (duration: 8.995899594s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:32.619755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:23.623768Z","time spent":"8.995980615s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-04T11:03:32.619788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.013290205s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-02-04T11:03:32.619807Z","caller":"traceutil/trace.go:171","msg":"trace[1697740917] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; }","duration":"9.013334556s","start":"2026-02-04T11:03:23.606467Z","end":"2026-02-04T11:03:32.619801Z","steps":["trace[1697740917] 'agreement among raft nodes before linearized reading'  (duration: 9.013314175s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:32.619832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:23.606454Z","time spent":"9.013371997s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-04T11:03:32.61987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.153861258s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18910639b5c0fd56\" ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-02-04T11:03:32.619897Z","caller":"traceutil/trace.go:171","msg":"trace[1849360734] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18910639b5c0fd56; range_end:; }","duration":"9.153920049s","start":"2026-02-04T11:03:23.465969Z","end":"2026-02-04T11:03:32.619889Z","steps":["trace[1849360734] 'agreement among raft nodes before linearized reading'  (duration: 9.153892539s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:32.619927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:23.465953Z","time spent":"9.15396499s","remote":"127.0.0.1:43154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":0,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18910639b5c0fd56\" "}
{"level":"warn","ts":"2026-02-04T11:03:32.619986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.015199099s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-02-04T11:03:32.620007Z","caller":"traceutil/trace.go:171","msg":"trace[1064912736] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; }","duration":"10.015276691s","start":"2026-02-04T11:03:22.604725Z","end":"2026-02-04T11:03:32.620001Z","steps":["trace[1064912736] 'agreement among raft nodes before linearized reading'  (duration: 10.01525223s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:32.620052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:22.604706Z","time spent":"10.015319221s","remote":"127.0.0.1:43174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":0,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:03:32.620085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"11.549444596s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-02-04T11:03:32.620106Z","caller":"traceutil/trace.go:171","msg":"trace[416749347] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; }","duration":"11.549489316s","start":"2026-02-04T11:03:21.07061Z","end":"2026-02-04T11:03:32.620099Z","steps":["trace[416749347] 'agreement among raft nodes before linearized reading'  (duration: 11.549467306s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:32.620128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:21.070595Z","time spent":"11.549526827s","remote":"127.0.0.1:43316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":0,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:03:32.620163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.29326462s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-02-04T11:03:32.620193Z","caller":"traceutil/trace.go:171","msg":"trace[1457208407] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; }","duration":"12.293308481s","start":"2026-02-04T11:03:20.326869Z","end":"2026-02-04T11:03:32.620177Z","steps":["trace[1457208407] 'agreement among raft nodes before linearized reading'  (duration: 12.29328551s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:32.620218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:20.326853Z","time spent":"12.293358003s","remote":"127.0.0.1:50108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":0,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:03:32.620285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.859402639s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-02-04T11:03:32.620315Z","caller":"traceutil/trace.go:171","msg":"trace[1056755732] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; }","duration":"12.859476351s","start":"2026-02-04T11:03:19.760833Z","end":"2026-02-04T11:03:32.620309Z","steps":["trace[1056755732] 'agreement among raft nodes before linearized reading'  (duration: 12.85943014s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:32.620347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:19.760819Z","time spent":"12.859521321s","remote":"127.0.0.1:33060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":0,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:03:32.800724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:25.799669Z","time spent":"7.001050486s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:03:32.889607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:25.88929Z","time spent":"7.00031376s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:03:33.119901Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071655,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:33.487051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000031224s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:03:33.487171Z","caller":"traceutil/trace.go:171","msg":"trace[1464520257] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000166067s","start":"2026-02-04T11:03:31.486981Z","end":"2026-02-04T11:03:33.487147Z","steps":["trace[1464520257] 'agreement among raft nodes before linearized reading'  (duration: 2.000027244s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:33.487228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:31.486951Z","time spent":"2.00026791s","remote":"127.0.0.1:43110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-04T11:03:33.598715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:28.600217Z","time spent":"4.998494615s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
2026/02/04 11:03:33 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:03:33.620463Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071655,"retry-timeout":"500ms"}
2026/02/04 11:03:33 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:03:34.121066Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071655,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:34.607686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:29.609049Z","time spent":"4.998630298s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:03:34.621868Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071655,"retry-timeout":"500ms"}
2026/02/04 11:03:34 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:03:34.933376Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"75be9c284e627de1","error":"etcdserver: request timed out"}
{"level":"warn","ts":"2026-02-04T11:03:35.122694Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071655,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:35.488801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00031444s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:03:35.488888Z","caller":"traceutil/trace.go:171","msg":"trace[1153277996] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000446634s","start":"2026-02-04T11:03:33.488422Z","end":"2026-02-04T11:03:35.488869Z","steps":["trace[1153277996] 'agreement among raft nodes before linearized reading'  (duration: 2.000336571s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:35.488949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:33.488407Z","time spent":"2.000532775s","remote":"127.0.0.1:43116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-04T11:03:35.62377Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071655,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:36.12482Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071655,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:36.625542Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071655,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:36.932016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:29.93161Z","time spent":"7.000399792s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:03:36.936514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:29.935472Z","time spent":"7.001038415s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:03:37.125719Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071655,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:37.496451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999963243s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:03:37.496572Z","caller":"traceutil/trace.go:171","msg":"trace[362193512] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000143517s","start":"2026-02-04T11:03:35.4964Z","end":"2026-02-04T11:03:37.496544Z","steps":["trace[362193512] 'agreement among raft nodes before linearized reading'  (duration: 1.999981093s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:37.496637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:35.496389Z","time spent":"2.000229799s","remote":"127.0.0.1:43110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-04T11:03:37.626833Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071655,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:37.938551Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"75be9c284e627e43","error":"etcdserver: request timed out"}
{"level":"warn","ts":"2026-02-04T11:03:38.127308Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762481795071655,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:03:38.474654Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"19.855642278s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-04T11:03:38.492793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:33.695725Z","time spent":"4.797061925s","remote":"127.0.0.1:34656","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-02-04T11:03:38.490964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"17.127590863s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:03:38.499104Z","caller":"traceutil/trace.go:171","msg":"trace[494021349] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1477; }","duration":"17.135736095s","start":"2026-02-04T11:03:21.363351Z","end":"2026-02-04T11:03:38.499088Z","steps":["trace[494021349] 'range keys from in-memory index tree'  (duration: 17.127576282s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:38.493007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.087553497s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:03:38.499241Z","caller":"traceutil/trace.go:171","msg":"trace[2018403147] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1477; }","duration":"2.093798238s","start":"2026-02-04T11:03:36.405436Z","end":"2026-02-04T11:03:38.499234Z","steps":["trace[2018403147] 'range keys from in-memory index tree'  (duration: 2.087542467s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:38.535126Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"16.781µs","request":"header:<ID:17707762481795071649 > lease_revoke:<id:75be9c284e627de1>","response":"size:28","error":"lease not found"}
{"level":"info","ts":"2026-02-04T11:03:38.540766Z","caller":"traceutil/trace.go:171","msg":"trace[807698747] transaction","detail":"{read_only:false; response_revision:1487; number_of_response:1; }","duration":"5.91261815s","start":"2026-02-04T11:03:32.628133Z","end":"2026-02-04T11:03:38.540751Z","steps":["trace[807698747] 'process raft request'  (duration: 5.91214422s)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:03:38.540745Z","caller":"traceutil/trace.go:171","msg":"trace[1547179739] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1487; }","duration":"5.647538254s","start":"2026-02-04T11:03:32.893116Z","end":"2026-02-04T11:03:38.540654Z","steps":["trace[1547179739] 'process raft request'  (duration: 5.647430942s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:38.540829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:32.628109Z","time spent":"5.912689151s","remote":"127.0.0.1:43154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":857,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-controller-manager-instance.189106417e31bfab\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-controller-manager-instance.189106417e31bfab\" value_size:761 lease:8484390444940295498 >> failure:<>"}
{"level":"warn","ts":"2026-02-04T11:03:38.541061Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"11.701µs","request":"header:<ID:17707762481795071662 > lease_revoke:<id:75be9c284e627de1>","response":"size:28","error":"lease not found"}
{"level":"warn","ts":"2026-02-04T11:03:38.541078Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"2.31µs","request":"header:<ID:17707762481795071663 > lease_revoke:<id:75be9c284e627e43>","response":"size:28","error":"lease not found"}
{"level":"info","ts":"2026-02-04T11:03:38.541104Z","caller":"traceutil/trace.go:171","msg":"trace[1045100089] linearizableReadLoop","detail":"{readStateIndex:1563; appliedIndex:1541; }","duration":"5.921687984s","start":"2026-02-04T11:03:32.61941Z","end":"2026-02-04T11:03:38.541098Z","steps":["trace[1045100089] 'read index received'  (duration: 5.855383686s)","trace[1045100089] 'applied index is now lower than readState.Index'  (duration: 66.303718ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:03:38.541174Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"75be9c284e627de1","error":"lease not found"}
{"level":"warn","ts":"2026-02-04T11:03:38.541185Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"75be9c284e627e43","error":"lease not found"}
{"level":"warn","ts":"2026-02-04T11:03:38.541214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.636563619s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:03:38.541227Z","caller":"traceutil/trace.go:171","msg":"trace[876481625] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1490; }","duration":"6.63660213s","start":"2026-02-04T11:03:31.90462Z","end":"2026-02-04T11:03:38.541222Z","steps":["trace[876481625] 'agreement among raft nodes before linearized reading'  (duration: 6.63657119s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:38.541242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:31.904605Z","time spent":"6.636632981s","remote":"127.0.0.1:50084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:03:38.541314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:32.893089Z","time spent":"5.647739529s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":69,"response count":0,"response size":721,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1441 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-04T11:03:38.541392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"11.01160876s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-04T11:03:38.541405Z","caller":"traceutil/trace.go:171","msg":"trace[737801609] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1490; }","duration":"11.01164217s","start":"2026-02-04T11:03:27.529759Z","end":"2026-02-04T11:03:38.541402Z","steps":["trace[737801609] 'agreement among raft nodes before linearized reading'  (duration: 11.01161707s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:38.541418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:27.529749Z","time spent":"11.011665282s","remote":"127.0.0.1:43368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":14,"response size":30,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:03:38.541482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.222425348s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-04T11:03:38.541499Z","caller":"traceutil/trace.go:171","msg":"trace[2089218659] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1490; }","duration":"5.222473309s","start":"2026-02-04T11:03:33.319018Z","end":"2026-02-04T11:03:38.541492Z","steps":["trace[2089218659] 'agreement among raft nodes before linearized reading'  (duration: 5.222452959s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:38.541512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:33.319Z","time spent":"5.222508221s","remote":"127.0.0.1:33088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:03:38.541629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.530386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-04T11:03:38.541668Z","caller":"traceutil/trace.go:171","msg":"trace[776754155] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1490; }","duration":"294.583868ms","start":"2026-02-04T11:03:38.247055Z","end":"2026-02-04T11:03:38.541639Z","steps":["trace[776754155] 'agreement among raft nodes before linearized reading'  (duration: 294.562057ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:03:38.541678Z","caller":"traceutil/trace.go:171","msg":"trace[1762112307] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1487; }","duration":"5.737697356s","start":"2026-02-04T11:03:32.803959Z","end":"2026-02-04T11:03:38.541656Z","steps":["trace[1762112307] 'process raft request'  (duration: 5.736528769s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:38.54173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.128434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:03:38.541744Z","caller":"traceutil/trace.go:171","msg":"trace[338222021] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1490; }","duration":"794.179195ms","start":"2026-02-04T11:03:37.74756Z","end":"2026-02-04T11:03:38.541739Z","steps":["trace[338222021] 'agreement among raft nodes before linearized reading'  (duration: 794.159374ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:38.541756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:37.747538Z","time spent":"794.215906ms","remote":"127.0.0.1:43110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-04T11:03:38.541744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:32.803937Z","time spent":"5.737772918s","remote":"127.0.0.1:43314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":45,"response count":0,"response size":570,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1438 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-04T11:03:38.541811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.043945857s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:03:38.541823Z","caller":"traceutil/trace.go:171","msg":"trace[826687610] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1490; }","duration":"1.044005929s","start":"2026-02-04T11:03:37.497813Z","end":"2026-02-04T11:03:38.541819Z","steps":["trace[826687610] 'agreement among raft nodes before linearized reading'  (duration: 1.043988838s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:38.541834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:37.497793Z","time spent":"1.04403792s","remote":"127.0.0.1:43116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-04T11:03:38.54135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.059097598s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7036"}
{"level":"info","ts":"2026-02-04T11:03:38.541873Z","caller":"traceutil/trace.go:171","msg":"trace[1592609576] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:1490; }","duration":"7.05964628s","start":"2026-02-04T11:03:31.482217Z","end":"2026-02-04T11:03:38.541863Z","steps":["trace[1592609576] 'agreement among raft nodes before linearized reading'  (duration: 7.059081597s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:38.54189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.025960667s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.49\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:03:38.541905Z","caller":"traceutil/trace.go:171","msg":"trace[2047847398] range","detail":"{range_begin:/registry/masterleases/162.253.55.49; range_end:; response_count:0; response_revision:1490; }","duration":"3.025976257s","start":"2026-02-04T11:03:35.515923Z","end":"2026-02-04T11:03:38.5419Z","steps":["trace[2047847398] 'agreement among raft nodes before linearized reading'  (duration: 3.025954737s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:38.541916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:35.515877Z","time spent":"3.026036729s","remote":"127.0.0.1:43122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/162.253.55.49\" "}
{"level":"warn","ts":"2026-02-04T11:03:38.541918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:31.482202Z","time spent":"7.059700621s","remote":"127.0.0.1:43242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7059,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "}
{"level":"warn","ts":"2026-02-04T11:03:38.541973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.296312572s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:03:38.541985Z","caller":"traceutil/trace.go:171","msg":"trace[482546756] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1490; }","duration":"3.296378333s","start":"2026-02-04T11:03:35.245603Z","end":"2026-02-04T11:03:38.541982Z","steps":["trace[482546756] 'agreement among raft nodes before linearized reading'  (duration: 3.296357693s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:38.541998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:35.245584Z","time spent":"3.296409274s","remote":"127.0.0.1:43284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:03:38.542069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.770026748s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:03:38.542081Z","caller":"traceutil/trace.go:171","msg":"trace[860612980] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1490; }","duration":"3.770081049s","start":"2026-02-04T11:03:34.771997Z","end":"2026-02-04T11:03:38.542078Z","steps":["trace[860612980] 'agreement among raft nodes before linearized reading'  (duration: 3.770047039s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:38.542096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:34.771966Z","time spent":"3.770125501s","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:03:38.541368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.512139321s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:03:38.542197Z","caller":"traceutil/trace.go:171","msg":"trace[1506066470] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1490; }","duration":"7.5130142s","start":"2026-02-04T11:03:31.029169Z","end":"2026-02-04T11:03:38.542183Z","steps":["trace[1506066470] 'agreement among raft nodes before linearized reading'  (duration: 7.512189201s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:03:38.54224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:03:31.029147Z","time spent":"7.513079402s","remote":"127.0.0.1:50094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "}