{"level":"warn","ts":"2026-04-07T15:17:51.218162Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T15:17:51.218253Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.128: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://199.19.213.128:2380","--initial-cluster=instance=https://199.19.213.128:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.128:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.128: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-04-07T15:17:51.218319Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T15:17:51.218331Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.128:2380"]} {"level":"info","ts":"2026-04-07T15:17:51.21835Z","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-04-07T15:17:51.218953Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.128:2379"]} {"level":"info","ts":"2026-04-07T15:17:51.219023Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.128:2380"],"listen-peer-urls":["https://199.19.213.128:2380"],"advertise-client-urls":["https://199.19.213.128:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.128:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.128: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-04-07T15:17:52.775519Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.556289369s"} {"level":"info","ts":"2026-04-07T15:17:53.434518Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a463a6aa9b462de2","cluster-id":"cd3d14b8ed85e2f2"} {"level":"info","ts":"2026-04-07T15:17:53.434656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T15:17:53.434705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 became follower at term 0"} {"level":"info","ts":"2026-04-07T15:17:53.434761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a463a6aa9b462de2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T15:17:53.434813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 became follower at term 1"} {"level":"info","ts":"2026-04-07T15:17:53.434896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 switched to configuration voters=(11845494696594255330)"} {"level":"warn","ts":"2026-04-07T15:17:53.491701Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T15:17:53.495487Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T15:17:53.496504Z","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-04-07T15:17:53.499442Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a463a6aa9b462de2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T15:17:53.499838Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a463a6aa9b462de2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T15:17:53.499991Z","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-04-07T15:17:53.500905Z","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-04-07T15:17:53.501085Z","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-04-07T15:17:53.501912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 switched to configuration voters=(11845494696594255330)"} {"level":"info","ts":"2026-04-07T15:17:53.502066Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cd3d14b8ed85e2f2","local-member-id":"a463a6aa9b462de2","added-peer-id":"a463a6aa9b462de2","added-peer-peer-urls":["https://199.19.213.128:2380"]} {"level":"info","ts":"2026-04-07T15:17:53.505331Z","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-04-07T15:17:53.505481Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.128:2380"} {"level":"info","ts":"2026-04-07T15:17:53.505558Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.128:2380"} {"level":"info","ts":"2026-04-07T15:17:53.506018Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a463a6aa9b462de2","initial-advertise-peer-urls":["https://199.19.213.128:2380"],"listen-peer-urls":["https://199.19.213.128:2380"],"advertise-client-urls":["https://199.19.213.128:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.128:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T15:17:53.506098Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T15:17:53.688323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T15:17:53.688381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T15:17:53.688417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 received MsgPreVoteResp from a463a6aa9b462de2 at term 1"} {"level":"info","ts":"2026-04-07T15:17:53.688437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 became candidate at term 2"} {"level":"info","ts":"2026-04-07T15:17:53.688455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 received MsgVoteResp from a463a6aa9b462de2 at term 2"} {"level":"info","ts":"2026-04-07T15:17:53.688471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a463a6aa9b462de2 became leader at term 2"} {"level":"info","ts":"2026-04-07T15:17:53.688484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a463a6aa9b462de2 elected leader a463a6aa9b462de2 at term 2"} {"level":"info","ts":"2026-04-07T15:17:53.689465Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T15:17:53.689463Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a463a6aa9b462de2","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.128:2379]}","request-path":"/0/members/a463a6aa9b462de2/attributes","cluster-id":"cd3d14b8ed85e2f2","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T15:17:53.68948Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T15:17:53.689504Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T15:17:53.689847Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T15:17:53.689913Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T15:17:53.690629Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cd3d14b8ed85e2f2","local-member-id":"a463a6aa9b462de2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T15:17:53.690836Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T15:17:53.69088Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T15:17:53.693369Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.128:2379"} {"level":"info","ts":"2026-04-07T15:17:53.69359Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T15:18:17.454448Z","caller":"traceutil/trace.go:171","msg":"trace[743863100] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"123.04982ms","start":"2026-04-07T15:18:17.33137Z","end":"2026-04-07T15:18:17.454419Z","steps":["trace[743863100] 'process raft request' (duration: 122.851136ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:18:23.042071Z","caller":"traceutil/trace.go:171","msg":"trace[423455084] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"142.133423ms","start":"2026-04-07T15:18:22.899914Z","end":"2026-04-07T15:18:23.042047Z","steps":["trace[423455084] 'process raft request' (duration: 85.510503ms)","trace[423455084] 'compare' (duration: 56.508427ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:18:23.073759Z","caller":"traceutil/trace.go:171","msg":"trace[1064165915] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"158.290459ms","start":"2026-04-07T15:18:22.915431Z","end":"2026-04-07T15:18:23.073722Z","steps":["trace[1064165915] 'process raft request' (duration: 157.820457ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:18:23.07465Z","caller":"traceutil/trace.go:171","msg":"trace[2063518979] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"123.908833ms","start":"2026-04-07T15:18:22.95072Z","end":"2026-04-07T15:18:23.074629Z","steps":["trace[2063518979] 'process raft request' (duration: 123.804861ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:18:23.07467Z","caller":"traceutil/trace.go:171","msg":"trace[1533122174] transaction","detail":"{read_only:false; number_of_response:1; response_revision:558; }","duration":"144.417862ms","start":"2026-04-07T15:18:22.930229Z","end":"2026-04-07T15:18:23.074647Z","steps":["trace[1533122174] 'process raft request' (duration: 143.315394ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:18:23.258509Z","caller":"traceutil/trace.go:171","msg":"trace[2076661841] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"128.324216ms","start":"2026-04-07T15:18:23.130161Z","end":"2026-04-07T15:18:23.258485Z","steps":["trace[2076661841] 'process raft request' (duration: 124.079407ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:18:23.259364Z","caller":"traceutil/trace.go:171","msg":"trace[1697857958] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"109.267486ms","start":"2026-04-07T15:18:23.150079Z","end":"2026-04-07T15:18:23.259346Z","steps":["trace[1697857958] 'process raft request' (duration: 109.056811ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:18:28.629518Z","caller":"traceutil/trace.go:171","msg":"trace[10376433] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"337.072167ms","start":"2026-04-07T15:18:28.292415Z","end":"2026-04-07T15:18:28.629487Z","steps":["trace[10376433] 'process raft request' (duration: 336.455561ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:18:28.630118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:18:28.292373Z","time spent":"337.227011ms","remote":"127.0.0.1:49236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036265,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T15:18:29.507405Z","caller":"traceutil/trace.go:171","msg":"trace[800366824] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"201.328207ms","start":"2026-04-07T15:18:29.306049Z","end":"2026-04-07T15:18:29.507377Z","steps":["trace[800366824] 'process raft request' (duration: 201.202653ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:18:30.265194Z","caller":"traceutil/trace.go:171","msg":"trace[1200011288] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"248.642177ms","start":"2026-04-07T15:18:30.016514Z","end":"2026-04-07T15:18:30.265156Z","steps":["trace[1200011288] 'read index received' (duration: 161.221824ms)","trace[1200011288] 'applied index is now lower than readState.Index' (duration: 87.418703ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:18:30.2658Z","caller":"traceutil/trace.go:171","msg":"trace[1132482410] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"356.001504ms","start":"2026-04-07T15:18:29.909745Z","end":"2026-04-07T15:18:30.265747Z","steps":["trace[1132482410] 'process raft request' (duration: 268.178191ms)","trace[1132482410] 'compare' (duration: 86.335745ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T15:18:30.266001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:18:29.909717Z","time spent":"356.181539ms","remote":"127.0.0.1:49236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036317,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T15:18:30.265942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.345745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-07T15:18:30.26619Z","caller":"traceutil/trace.go:171","msg":"trace[856865408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:620; }","duration":"249.687713ms","start":"2026-04-07T15:18:30.016477Z","end":"2026-04-07T15:18:30.266165Z","steps":["trace[856865408] 'agreement among raft nodes before linearized reading' (duration: 249.160981ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:18:30.266524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.070597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-07T15:18:30.266597Z","caller":"traceutil/trace.go:171","msg":"trace[1980270381] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:620; }","duration":"228.18952ms","start":"2026-04-07T15:18:30.038385Z","end":"2026-04-07T15:18:30.266575Z","steps":["trace[1980270381] 'agreement among raft nodes before linearized reading' (duration: 227.931894ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:18:31.756282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.329147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:18:31.756365Z","caller":"traceutil/trace.go:171","msg":"trace[1469382198] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:657; }","duration":"126.48559ms","start":"2026-04-07T15:18:31.629863Z","end":"2026-04-07T15:18:31.756349Z","steps":["trace[1469382198] 'range keys from in-memory index tree' (duration: 126.219522ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:18:45.488696Z","caller":"traceutil/trace.go:171","msg":"trace[1650193640] linearizableReadLoop","detail":"{readStateIndex:806; appliedIndex:805; }","duration":"232.79094ms","start":"2026-04-07T15:18:45.255882Z","end":"2026-04-07T15:18:45.488673Z","steps":["trace[1650193640] 'read index received' (duration: 232.595235ms)","trace[1650193640] 'applied index is now lower than readState.Index' (duration: 194.835µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T15:18:45.488822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.919813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:18:45.488802Z","caller":"traceutil/trace.go:171","msg":"trace[1025082810] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"312.852343ms","start":"2026-04-07T15:18:45.175913Z","end":"2026-04-07T15:18:45.488765Z","steps":["trace[1025082810] 'process raft request' (duration: 312.624797ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:18:45.488857Z","caller":"traceutil/trace.go:171","msg":"trace[363051253] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:780; }","duration":"233.008935ms","start":"2026-04-07T15:18:45.255837Z","end":"2026-04-07T15:18:45.488846Z","steps":["trace[363051253] 'agreement among raft nodes before linearized reading' (duration: 232.935543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:18:45.489006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:18:45.175885Z","time spent":"313.000246ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T15:18:45.621261Z","caller":"traceutil/trace.go:171","msg":"trace[765119095] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"107.326736ms","start":"2026-04-07T15:18:45.513912Z","end":"2026-04-07T15:18:45.621239Z","steps":["trace[765119095] 'process raft request' (duration: 106.280169ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:18:58.56234Z","caller":"traceutil/trace.go:171","msg":"trace[1574487895] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"108.345223ms","start":"2026-04-07T15:18:58.453969Z","end":"2026-04-07T15:18:58.562314Z","steps":["trace[1574487895] 'process raft request' (duration: 108.174108ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:18:58.582347Z","caller":"traceutil/trace.go:171","msg":"trace[1358777791] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"125.788341ms","start":"2026-04-07T15:18:58.456531Z","end":"2026-04-07T15:18:58.582319Z","steps":["trace[1358777791] 'process raft request' (duration: 125.618206ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:19:20.22198Z","caller":"traceutil/trace.go:171","msg":"trace[657347258] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"127.639139ms","start":"2026-04-07T15:19:20.09432Z","end":"2026-04-07T15:19:20.221959Z","steps":["trace[657347258] 'process raft request' (duration: 127.498916ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:19:21.073472Z","caller":"traceutil/trace.go:171","msg":"trace[270932084] linearizableReadLoop","detail":"{readStateIndex:1034; appliedIndex:1033; }","duration":"417.599552ms","start":"2026-04-07T15:19:20.65585Z","end":"2026-04-07T15:19:21.07345Z","steps":["trace[270932084] 'read index received' (duration: 417.401276ms)","trace[270932084] 'applied index is now lower than readState.Index' (duration: 197.596µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:19:21.073544Z","caller":"traceutil/trace.go:171","msg":"trace[1579464713] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"425.854745ms","start":"2026-04-07T15:19:20.647663Z","end":"2026-04-07T15:19:21.073518Z","steps":["trace[1579464713] 'process raft request' (duration: 425.648559ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:19:21.073674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.795947ms","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-04-07T15:19:21.073709Z","caller":"traceutil/trace.go:171","msg":"trace[1812775560] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:999; }","duration":"417.861719ms","start":"2026-04-07T15:19:20.655839Z","end":"2026-04-07T15:19:21.0737Z","steps":["trace[1812775560] 'agreement among raft nodes before linearized reading' (duration: 417.717325ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:19:21.073731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.543922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-07T15:19:21.073736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:19:20.655791Z","time spent":"417.938151ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-07T15:19:21.073766Z","caller":"traceutil/trace.go:171","msg":"trace[1565439839] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:999; }","duration":"147.637894ms","start":"2026-04-07T15:19:20.926119Z","end":"2026-04-07T15:19:21.073757Z","steps":["trace[1565439839] 'agreement among raft nodes before linearized reading' (duration: 147.529732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:19:21.073833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.563962ms","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-04-07T15:19:21.073911Z","caller":"traceutil/trace.go:171","msg":"trace[419937690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:999; }","duration":"393.701126ms","start":"2026-04-07T15:19:20.680193Z","end":"2026-04-07T15:19:21.073894Z","steps":["trace[419937690] 'agreement among raft nodes before linearized reading' (duration: 393.45321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:19:21.073953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:19:20.680165Z","time spent":"393.779847ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-07T15:19:21.074029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:19:20.647643Z","time spent":"425.966658ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T15:19:21.537898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.839092ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T15:19:21.538Z","caller":"traceutil/trace.go:171","msg":"trace[1703530217] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"460.283911ms","start":"2026-04-07T15:19:21.077697Z","end":"2026-04-07T15:19:21.537981Z","steps":["trace[1703530217] 'process raft request' (duration: 199.170102ms)","trace[1703530217] 'compare' (duration: 260.648997ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T15:19:21.538057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:19:21.077646Z","time spent":"460.384804ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T15:19:21.538962Z","caller":"traceutil/trace.go:171","msg":"trace[1041853557] linearizableReadLoop","detail":"{readStateIndex:1036; appliedIndex:1034; }","duration":"282.88679ms","start":"2026-04-07T15:19:21.256057Z","end":"2026-04-07T15:19:21.538944Z","steps":["trace[1041853557] 'read index received' (duration: 20.821007ms)","trace[1041853557] 'applied index is now lower than readState.Index' (duration: 262.065123ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:19:21.539058Z","caller":"traceutil/trace.go:171","msg":"trace[540969649] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"460.029026ms","start":"2026-04-07T15:19:21.079021Z","end":"2026-04-07T15:19:21.53905Z","steps":["trace[540969649] 'process raft request' (duration: 459.833071ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:19:21.539149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:19:21.079004Z","time spent":"460.076597ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T15:19:21.539244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.154208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:19:21.539335Z","caller":"traceutil/trace.go:171","msg":"trace[1868896433] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1001; }","duration":"283.302701ms","start":"2026-04-07T15:19:21.256008Z","end":"2026-04-07T15:19:21.539311Z","steps":["trace[1868896433] 'agreement among raft nodes before linearized reading' (duration: 283.152497ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:19:43.831562Z","caller":"traceutil/trace.go:171","msg":"trace[887932131] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"157.982772ms","start":"2026-04-07T15:19:43.673557Z","end":"2026-04-07T15:19:43.83154Z","steps":["trace[887932131] 'process raft request' (duration: 157.830948ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:19:43.873493Z","caller":"traceutil/trace.go:171","msg":"trace[428902592] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"199.338267ms","start":"2026-04-07T15:19:43.674139Z","end":"2026-04-07T15:19:43.873477Z","steps":["trace[428902592] 'process raft request' (duration: 198.641069ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:19:44.041375Z","caller":"traceutil/trace.go:171","msg":"trace[798438997] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"163.487552ms","start":"2026-04-07T15:19:43.877846Z","end":"2026-04-07T15:19:44.041334Z","steps":["trace[798438997] 'process raft request' (duration: 163.131384ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:19:45.526922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.471673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:19:45.527028Z","caller":"traceutil/trace.go:171","msg":"trace[1795128798] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1077; }","duration":"203.973915ms","start":"2026-04-07T15:19:45.323015Z","end":"2026-04-07T15:19:45.526989Z","steps":["trace[1795128798] 'count revisions from in-memory index tree' (duration: 203.369111ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:19:46.198136Z","caller":"traceutil/trace.go:171","msg":"trace[1783544724] linearizableReadLoop","detail":"{readStateIndex:1119; appliedIndex:1118; }","duration":"149.222066ms","start":"2026-04-07T15:19:46.04889Z","end":"2026-04-07T15:19:46.198112Z","steps":["trace[1783544724] 'read index received' (duration: 149.048982ms)","trace[1783544724] 'applied index is now lower than readState.Index' (duration: 172.044µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:19:46.198251Z","caller":"traceutil/trace.go:171","msg":"trace[1427246014] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"288.534496ms","start":"2026-04-07T15:19:45.909684Z","end":"2026-04-07T15:19:46.198219Z","steps":["trace[1427246014] 'process raft request' (duration: 288.280059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:19:46.198444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.939504ms","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-04-07T15:19:46.198495Z","caller":"traceutil/trace.go:171","msg":"trace[908739465] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1079; }","duration":"143.116539ms","start":"2026-04-07T15:19:46.055364Z","end":"2026-04-07T15:19:46.19848Z","steps":["trace[908739465] 'agreement among raft nodes before linearized reading' (duration: 142.895033ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:19:46.198475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.054687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-07T15:19:46.198579Z","caller":"traceutil/trace.go:171","msg":"trace[1111153324] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1079; }","duration":"129.211421ms","start":"2026-04-07T15:19:46.069349Z","end":"2026-04-07T15:19:46.198561Z","steps":["trace[1111153324] 'agreement among raft nodes before linearized reading' (duration: 128.934533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:19:46.198981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.070397ms","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-04-07T15:19:46.199082Z","caller":"traceutil/trace.go:171","msg":"trace[2106968326] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1079; }","duration":"150.257292ms","start":"2026-04-07T15:19:46.048799Z","end":"2026-04-07T15:19:46.199057Z","steps":["trace[2106968326] 'agreement among raft nodes before linearized reading' (duration: 149.972635ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:19:46.35459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.016793ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T15:19:46.354832Z","caller":"traceutil/trace.go:171","msg":"trace[1327142317] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"150.741574ms","start":"2026-04-07T15:19:46.204047Z","end":"2026-04-07T15:19:46.354789Z","steps":["trace[1327142317] 'process raft request' (duration: 49.428963ms)","trace[1327142317] 'compare' (duration: 100.796228ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:19:46.354945Z","caller":"traceutil/trace.go:171","msg":"trace[746789717] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"150.319934ms","start":"2026-04-07T15:19:46.204604Z","end":"2026-04-07T15:19:46.354924Z","steps":["trace[746789717] 'process raft request' (duration: 150.16143ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:19:46.35494Z","caller":"traceutil/trace.go:171","msg":"trace[1027934727] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"150.314764ms","start":"2026-04-07T15:19:46.20457Z","end":"2026-04-07T15:19:46.354885Z","steps":["trace[1027934727] 'process raft request' (duration: 150.126959ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:19:47.592108Z","caller":"traceutil/trace.go:171","msg":"trace[33305485] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"185.361127ms","start":"2026-04-07T15:19:47.406717Z","end":"2026-04-07T15:19:47.592078Z","steps":["trace[33305485] 'process raft request' (duration: 185.109841ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:19:56.672654Z","caller":"traceutil/trace.go:171","msg":"trace[1902036568] linearizableReadLoop","detail":"{readStateIndex:1157; appliedIndex:1154; }","duration":"131.54455ms","start":"2026-04-07T15:19:56.541084Z","end":"2026-04-07T15:19:56.672628Z","steps":["trace[1902036568] 'read index received' (duration: 31.632575ms)","trace[1902036568] 'applied index is now lower than readState.Index' (duration: 99.910725ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:19:56.672735Z","caller":"traceutil/trace.go:171","msg":"trace[1864126566] transaction","detail":"{read_only:false; response_revision:1115; number_of_response:1; }","duration":"141.61379ms","start":"2026-04-07T15:19:56.53107Z","end":"2026-04-07T15:19:56.672684Z","steps":["trace[1864126566] 'process raft request' (duration: 141.402984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:19:56.673062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.95434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329948"} {"level":"info","ts":"2026-04-07T15:19:56.673166Z","caller":"traceutil/trace.go:171","msg":"trace[603980176] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1115; }","duration":"132.084704ms","start":"2026-04-07T15:19:56.541061Z","end":"2026-04-07T15:19:56.673145Z","steps":["trace[603980176] 'agreement among raft nodes before linearized reading' (duration: 131.729065ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:19:58.379684Z","caller":"traceutil/trace.go:171","msg":"trace[1032243645] linearizableReadLoop","detail":"{readStateIndex:1167; appliedIndex:1166; }","duration":"132.882124ms","start":"2026-04-07T15:19:58.246772Z","end":"2026-04-07T15:19:58.379654Z","steps":["trace[1032243645] 'read index received' (duration: 77.525568ms)","trace[1032243645] 'applied index is now lower than readState.Index' (duration: 55.354986ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:19:58.379757Z","caller":"traceutil/trace.go:171","msg":"trace[342474585] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"158.601037ms","start":"2026-04-07T15:19:58.221128Z","end":"2026-04-07T15:19:58.379729Z","steps":["trace[342474585] 'process raft request' (duration: 103.21912ms)","trace[342474585] 'compare' (duration: 55.149111ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T15:19:58.379838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.040709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:19:58.380575Z","caller":"traceutil/trace.go:171","msg":"trace[8200280] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1123; }","duration":"133.805498ms","start":"2026-04-07T15:19:58.246739Z","end":"2026-04-07T15:19:58.380544Z","steps":["trace[8200280] 'agreement among raft nodes before linearized reading' (duration: 133.017968ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:19:58.733622Z","caller":"traceutil/trace.go:171","msg":"trace[81026196] linearizableReadLoop","detail":"{readStateIndex:1200; appliedIndex:1196; }","duration":"177.179757ms","start":"2026-04-07T15:19:58.556415Z","end":"2026-04-07T15:19:58.733594Z","steps":["trace[81026196] 'read index received' (duration: 56.519527ms)","trace[81026196] 'applied index is now lower than readState.Index' (duration: 120.65891ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:19:58.734512Z","caller":"traceutil/trace.go:171","msg":"trace[604612713] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"194.204035ms","start":"2026-04-07T15:19:58.540261Z","end":"2026-04-07T15:19:58.734465Z","steps":["trace[604612713] 'process raft request' (duration: 193.163808ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:19:58.742234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.799699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/ceph-csi-rbd-provisioner\" ","response":"range_response_count:1 size:10872"} {"level":"info","ts":"2026-04-07T15:19:58.742294Z","caller":"traceutil/trace.go:171","msg":"trace[1369306227] range","detail":"{range_begin:/registry/deployments/kube-system/ceph-csi-rbd-provisioner; range_end:; response_count:1; response_revision:1155; }","duration":"185.893431ms","start":"2026-04-07T15:19:58.556386Z","end":"2026-04-07T15:19:58.742279Z","steps":["trace[1369306227] 'agreement among raft nodes before linearized reading' (duration: 178.772898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:19:58.74239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.007453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-07T15:19:58.74243Z","caller":"traceutil/trace.go:171","msg":"trace[782899206] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1159; }","duration":"165.074174ms","start":"2026-04-07T15:19:58.577348Z","end":"2026-04-07T15:19:58.742422Z","steps":["trace[782899206] 'agreement among raft nodes before linearized reading' (duration: 164.961501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:19:58.742944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.258423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-flz79\" ","response":"range_response_count:1 size:9695"} {"level":"info","ts":"2026-04-07T15:19:58.742973Z","caller":"traceutil/trace.go:171","msg":"trace[1574359853] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-flz79; range_end:; response_count:1; response_revision:1159; }","duration":"100.320975ms","start":"2026-04-07T15:19:58.642645Z","end":"2026-04-07T15:19:58.742966Z","steps":["trace[1574359853] 'agreement among raft nodes before linearized reading' (duration: 100.259603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:19:58.743087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.69106ms","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-04-07T15:19:58.743111Z","caller":"traceutil/trace.go:171","msg":"trace[1819332883] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1159; }","duration":"165.720981ms","start":"2026-04-07T15:19:58.577384Z","end":"2026-04-07T15:19:58.743105Z","steps":["trace[1819332883] 'agreement among raft nodes before linearized reading' (duration: 165.66739ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:20:02.761094Z","caller":"traceutil/trace.go:171","msg":"trace[2021295566] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"712.650895ms","start":"2026-04-07T15:20:02.048421Z","end":"2026-04-07T15:20:02.761072Z","steps":["trace[2021295566] 'process raft request' (duration: 712.512732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:02.761214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:02.048395Z","time spent":"712.756058ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T15:20:03.99059Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.21341681s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-07T15:20:04.269148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.424744ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-07T15:20:04.270252Z","caller":"traceutil/trace.go:171","msg":"trace[841509773] linearizableReadLoop","detail":"{readStateIndex:1229; appliedIndex:1227; }","duration":"1.76752176s","start":"2026-04-07T15:20:02.502712Z","end":"2026-04-07T15:20:04.270233Z","steps":["trace[841509773] 'read index received' (duration: 258.219615ms)","trace[841509773] 'applied index is now lower than readState.Index' (duration: 1.509301025s)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:20:04.270504Z","caller":"traceutil/trace.go:171","msg":"trace[1445068208] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"807.391427ms","start":"2026-04-07T15:20:03.463025Z","end":"2026-04-07T15:20:04.270416Z","steps":["trace[1445068208] 'process raft request' (duration: 807.030338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:04.270703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:03.462998Z","time spent":"807.575592ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T15:20:04.368578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.438868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T15:20:04.368632Z","caller":"traceutil/trace.go:171","msg":"trace[2115821931] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1184; }","duration":"353.544391ms","start":"2026-04-07T15:20:04.015073Z","end":"2026-04-07T15:20:04.368618Z","steps":["trace[2115821931] 'agreement among raft nodes before linearized reading' (duration: 255.363441ms)","trace[2115821931] 'count revisions from in-memory index tree' (duration: 98.099788ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T15:20:04.368663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:04.015052Z","time spent":"353.604023ms","remote":"127.0.0.1:49598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-04-07T15:20:04.368754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.866018869s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-07T15:20:04.368798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.599769376s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-07T15:20:04.368828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.512542889s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T15:20:04.368829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.552808417s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-07T15:20:04.368856Z","caller":"traceutil/trace.go:171","msg":"trace[2051945920] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1184; }","duration":"1.512602571s","start":"2026-04-07T15:20:02.856246Z","end":"2026-04-07T15:20:04.368848Z","steps":["trace[2051945920] 'agreement among raft nodes before linearized reading' (duration: 1.414206555s)","trace[2051945920] 'range keys from in-memory index tree' (duration: 98.361755ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T15:20:04.368771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.114858501s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:20:04.368866Z","caller":"traceutil/trace.go:171","msg":"trace[2084111652] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1184; }","duration":"1.5999022s","start":"2026-04-07T15:20:02.768944Z","end":"2026-04-07T15:20:04.368846Z","steps":["trace[2084111652] 'agreement among raft nodes before linearized reading' (duration: 1.501472433s)","trace[2084111652] 'range keys from in-memory index tree' (duration: 98.213101ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:20:04.368849Z","caller":"traceutil/trace.go:171","msg":"trace[1323282661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1184; }","duration":"1.866156732s","start":"2026-04-07T15:20:02.502669Z","end":"2026-04-07T15:20:04.368826Z","steps":["trace[1323282661] 'agreement among raft nodes before linearized reading' (duration: 1.767673254s)","trace[1323282661] 'range keys from in-memory index tree' (duration: 98.267062ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:20:04.368881Z","caller":"traceutil/trace.go:171","msg":"trace[1118601629] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1184; }","duration":"1.552884818s","start":"2026-04-07T15:20:02.81598Z","end":"2026-04-07T15:20:04.368865Z","steps":["trace[1118601629] 'agreement among raft nodes before linearized reading' (duration: 1.454482952s)","trace[1118601629] 'range keys from in-memory index tree' (duration: 98.243383ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T15:20:04.368902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:02.502652Z","time spent":"1.866245444s","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-07T15:20:04.3689Z","caller":"traceutil/trace.go:171","msg":"trace[2119668383] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1184; }","duration":"1.115022615s","start":"2026-04-07T15:20:03.25386Z","end":"2026-04-07T15:20:04.368883Z","steps":["trace[2119668383] 'agreement among raft nodes before linearized reading' (duration: 1.016584957s)","trace[2119668383] 'range keys from in-memory index tree' (duration: 98.286103ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T15:20:04.368919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:02.815968Z","time spent":"1.55294275s","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-07T15:20:04.368966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.552215272s","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-04-07T15:20:04.368993Z","caller":"traceutil/trace.go:171","msg":"trace[1736656325] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1184; }","duration":"1.552239782s","start":"2026-04-07T15:20:02.816746Z","end":"2026-04-07T15:20:04.368986Z","steps":["trace[1736656325] 'agreement among raft nodes before linearized reading' (duration: 1.453713613s)","trace[1736656325] 'range keys from in-memory index tree' (duration: 98.456198ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T15:20:04.368883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:02.85623Z","time spent":"1.512648632s","remote":"127.0.0.1:49126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T15:20:04.369014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:02.816711Z","time spent":"1.552299323s","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-07T15:20:04.369005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:03.253844Z","time spent":"1.115139648s","remote":"127.0.0.1:49130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T15:20:04.368913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:02.768926Z","time spent":"1.599979742s","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-07T15:20:04.516093Z","caller":"traceutil/trace.go:171","msg":"trace[967373854] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"142.672697ms","start":"2026-04-07T15:20:04.373399Z","end":"2026-04-07T15:20:04.516071Z","steps":["trace[967373854] 'process raft request' (duration: 142.512183ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:20:04.567987Z","caller":"traceutil/trace.go:171","msg":"trace[1272587830] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"193.742243ms","start":"2026-04-07T15:20:04.374226Z","end":"2026-04-07T15:20:04.567968Z","steps":["trace[1272587830] 'process raft request' (duration: 193.605039ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:20:04.568183Z","caller":"traceutil/trace.go:171","msg":"trace[942950919] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"193.785743ms","start":"2026-04-07T15:20:04.374389Z","end":"2026-04-07T15:20:04.568175Z","steps":["trace[942950919] 'process raft request' (duration: 193.548997ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:20:04.568575Z","caller":"traceutil/trace.go:171","msg":"trace[270782085] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"192.943843ms","start":"2026-04-07T15:20:04.375617Z","end":"2026-04-07T15:20:04.56856Z","steps":["trace[270782085] 'process raft request' (duration: 192.508151ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:20:04.568555Z","caller":"traceutil/trace.go:171","msg":"trace[715170508] linearizableReadLoop","detail":"{readStateIndex:1233; appliedIndex:1230; }","duration":"192.927662ms","start":"2026-04-07T15:20:04.375605Z","end":"2026-04-07T15:20:04.568533Z","steps":["trace[715170508] 'read index received' (duration: 140.367358ms)","trace[715170508] 'applied index is now lower than readState.Index' (duration: 52.558894ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T15:20:04.568664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.041155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:20:04.568704Z","caller":"traceutil/trace.go:171","msg":"trace[1296012202] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1188; }","duration":"193.159578ms","start":"2026-04-07T15:20:04.375534Z","end":"2026-04-07T15:20:04.568694Z","steps":["trace[1296012202] 'agreement among raft nodes before linearized reading' (duration: 193.078146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:04.697295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.27642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:20:04.697376Z","caller":"traceutil/trace.go:171","msg":"trace[1832401598] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1188; }","duration":"127.412313ms","start":"2026-04-07T15:20:04.569945Z","end":"2026-04-07T15:20:04.697357Z","steps":["trace[1832401598] 'range keys from in-memory index tree' (duration: 127.178737ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:20:16.774993Z","caller":"traceutil/trace.go:171","msg":"trace[144392229] linearizableReadLoop","detail":"{readStateIndex:1273; appliedIndex:1271; }","duration":"121.14154ms","start":"2026-04-07T15:20:16.653832Z","end":"2026-04-07T15:20:16.774973Z","steps":["trace[144392229] 'read index received' (duration: 108.339459ms)","trace[144392229] 'applied index is now lower than readState.Index' (duration: 12.801091ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:20:16.775051Z","caller":"traceutil/trace.go:171","msg":"trace[752724849] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"158.012185ms","start":"2026-04-07T15:20:16.617019Z","end":"2026-04-07T15:20:16.775031Z","steps":["trace[752724849] 'process raft request' (duration: 157.798059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:16.775188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.344765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-07T15:20:16.775228Z","caller":"traceutil/trace.go:171","msg":"trace[1290670377] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1224; }","duration":"121.430968ms","start":"2026-04-07T15:20:16.653787Z","end":"2026-04-07T15:20:16.775218Z","steps":["trace[1290670377] 'agreement among raft nodes before linearized reading' (duration: 121.296414ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:19.815415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"846.467269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-07T15:20:19.815452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.067863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:20:19.81552Z","caller":"traceutil/trace.go:171","msg":"trace[428438073] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1232; }","duration":"560.245647ms","start":"2026-04-07T15:20:19.255253Z","end":"2026-04-07T15:20:19.815499Z","steps":["trace[428438073] 'range keys from in-memory index tree' (duration: 559.995212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:19.815551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:19.255239Z","time spent":"560.30637ms","remote":"127.0.0.1:49126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T15:20:19.815585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.009551923s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:20:19.815674Z","caller":"traceutil/trace.go:171","msg":"trace[87201255] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1232; }","duration":"1.009685246s","start":"2026-04-07T15:20:18.805964Z","end":"2026-04-07T15:20:19.815649Z","steps":["trace[87201255] 'count revisions from in-memory index tree' (duration: 1.00948613s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:19.815729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:18.805953Z","time spent":"1.009757738s","remote":"127.0.0.1:49366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-04-07T15:20:19.8159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.247924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:20:19.815954Z","caller":"traceutil/trace.go:171","msg":"trace[404554180] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1232; }","duration":"679.318305ms","start":"2026-04-07T15:20:19.136621Z","end":"2026-04-07T15:20:19.815939Z","steps":["trace[404554180] 'count revisions from in-memory index tree' (duration: 679.138481ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:19.815988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.018219628s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-07T15:20:19.815992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:19.136551Z","time spent":"679.430927ms","remote":"127.0.0.1:55458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-07T15:20:19.816015Z","caller":"traceutil/trace.go:171","msg":"trace[1046753851] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1232; }","duration":"1.01828558s","start":"2026-04-07T15:20:18.797723Z","end":"2026-04-07T15:20:19.816008Z","steps":["trace[1046753851] 'range keys from in-memory index tree' (duration: 1.018109967s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:19.816032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"975.043527ms","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-04-07T15:20:19.816114Z","caller":"traceutil/trace.go:171","msg":"trace[2047680220] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1232; }","duration":"975.162278ms","start":"2026-04-07T15:20:18.840944Z","end":"2026-04-07T15:20:19.816107Z","steps":["trace[2047680220] 'range keys from in-memory index tree' (duration: 974.922432ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:19.816133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.037215335s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-07T15:20:19.816136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:18.840924Z","time spent":"975.20646ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-07T15:20:19.816153Z","caller":"traceutil/trace.go:171","msg":"trace[27185951] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1232; }","duration":"1.037267266s","start":"2026-04-07T15:20:18.77888Z","end":"2026-04-07T15:20:19.816148Z","steps":["trace[27185951] 'range keys from in-memory index tree' (duration: 1.037060062s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:19.816171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:18.778861Z","time spent":"1.037306498s","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-07T15:20:19.816114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.732838ms","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":"warn","ts":"2026-04-07T15:20:19.81607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:18.7977Z","time spent":"1.018337862s","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-07T15:20:19.816225Z","caller":"traceutil/trace.go:171","msg":"trace[453207939] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1232; }","duration":"320.963664ms","start":"2026-04-07T15:20:19.495234Z","end":"2026-04-07T15:20:19.816198Z","steps":["trace[453207939] 'count revisions from in-memory index tree' (duration: 320.604054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:19.816272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"974.675537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-07T15:20:19.816298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:19.49521Z","time spent":"321.057316ms","remote":"127.0.0.1:56666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-07T15:20:19.816312Z","caller":"traceutil/trace.go:171","msg":"trace[1460471429] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1232; }","duration":"974.734169ms","start":"2026-04-07T15:20:18.841566Z","end":"2026-04-07T15:20:19.8163Z","steps":["trace[1460471429] 'range keys from in-memory index tree' (duration: 974.544863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:19.816342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:18.841554Z","time spent":"974.78079ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-07T15:20:19.815489Z","caller":"traceutil/trace.go:171","msg":"trace[1709128740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1232; }","duration":"846.594352ms","start":"2026-04-07T15:20:18.96888Z","end":"2026-04-07T15:20:19.815474Z","steps":["trace[1709128740] 'range keys from in-memory index tree' (duration: 846.295836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:19.816469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:18.96886Z","time spent":"847.602579ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-07T15:20:20.401774Z","caller":"traceutil/trace.go:171","msg":"trace[418678284] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"580.524166ms","start":"2026-04-07T15:20:19.821234Z","end":"2026-04-07T15:20:20.401759Z","steps":["trace[418678284] 'process raft request' (duration: 580.386613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:20.401894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:19.821206Z","time spent":"580.620489ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T15:20:20.478592Z","caller":"traceutil/trace.go:171","msg":"trace[520181643] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"657.165181ms","start":"2026-04-07T15:20:19.821396Z","end":"2026-04-07T15:20:20.478561Z","steps":["trace[520181643] 'process raft request' (duration: 600.704164ms)","trace[520181643] 'compare' (duration: 56.276861ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T15:20:20.478784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:19.821377Z","time spent":"657.319624ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T15:20:20.478955Z","caller":"traceutil/trace.go:171","msg":"trace[1366789659] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"657.472127ms","start":"2026-04-07T15:20:19.821458Z","end":"2026-04-07T15:20:20.47893Z","steps":["trace[1366789659] 'process raft request' (duration: 657.060148ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:20.479196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:19.821436Z","time spent":"657.634982ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T15:20:20.479193Z","caller":"traceutil/trace.go:171","msg":"trace[533902358] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"656.971124ms","start":"2026-04-07T15:20:19.822206Z","end":"2026-04-07T15:20:20.479177Z","steps":["trace[533902358] 'process raft request' (duration: 656.610546ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:20.47928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:19.822193Z","time spent":"657.046058ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T15:20:20.47947Z","caller":"traceutil/trace.go:171","msg":"trace[1765134780] linearizableReadLoop","detail":"{readStateIndex:1286; appliedIndex:1281; }","duration":"222.831611ms","start":"2026-04-07T15:20:20.256619Z","end":"2026-04-07T15:20:20.479451Z","steps":["trace[1765134780] 'read index received' (duration: 145.074829ms)","trace[1765134780] 'applied index is now lower than readState.Index' (duration: 77.755761ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:20:20.479495Z","caller":"traceutil/trace.go:171","msg":"trace[1076380716] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"657.242452ms","start":"2026-04-07T15:20:19.82224Z","end":"2026-04-07T15:20:20.479482Z","steps":["trace[1076380716] 'process raft request' (duration: 656.890083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:20.479569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:19.822231Z","time spent":"657.303703ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T15:20:20.479653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.038186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:20:20.479705Z","caller":"traceutil/trace.go:171","msg":"trace[221024913] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1238; }","duration":"223.151329ms","start":"2026-04-07T15:20:20.25654Z","end":"2026-04-07T15:20:20.479691Z","steps":["trace[221024913] 'agreement among raft nodes before linearized reading' (duration: 223.036856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:20.479726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.731989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:20:20.479764Z","caller":"traceutil/trace.go:171","msg":"trace[322765027] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1238; }","duration":"171.812441ms","start":"2026-04-07T15:20:20.30794Z","end":"2026-04-07T15:20:20.479753Z","steps":["trace[322765027] 'agreement among raft nodes before linearized reading' (duration: 171.741049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:21.734943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.357046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T15:20:21.735004Z","caller":"traceutil/trace.go:171","msg":"trace[1774208168] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1243; }","duration":"186.488699ms","start":"2026-04-07T15:20:21.548503Z","end":"2026-04-07T15:20:21.734991Z","steps":["trace[1774208168] 'count revisions from in-memory index tree' (duration: 186.242083ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:20:22.59711Z","caller":"traceutil/trace.go:171","msg":"trace[1885438050] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"111.255272ms","start":"2026-04-07T15:20:22.485832Z","end":"2026-04-07T15:20:22.597087Z","steps":["trace[1885438050] 'process raft request' (duration: 111.065077ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:20:22.598599Z","caller":"traceutil/trace.go:171","msg":"trace[213119814] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"111.530109ms","start":"2026-04-07T15:20:22.487043Z","end":"2026-04-07T15:20:22.598573Z","steps":["trace[213119814] 'process raft request' (duration: 111.286013ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:20:22.598609Z","caller":"traceutil/trace.go:171","msg":"trace[742676683] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"111.246142ms","start":"2026-04-07T15:20:22.487342Z","end":"2026-04-07T15:20:22.598589Z","steps":["trace[742676683] 'process raft request' (duration: 111.122199ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:20:22.598605Z","caller":"traceutil/trace.go:171","msg":"trace[184142177] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"111.16372ms","start":"2026-04-07T15:20:22.487418Z","end":"2026-04-07T15:20:22.598582Z","steps":["trace[184142177] 'process raft request' (duration: 111.091258ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:20:22.598714Z","caller":"traceutil/trace.go:171","msg":"trace[223131812] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"110.529023ms","start":"2026-04-07T15:20:22.488176Z","end":"2026-04-07T15:20:22.598705Z","steps":["trace[223131812] 'process raft request' (duration: 110.36707ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T15:20:32.375799Z","caller":"traceutil/trace.go:171","msg":"trace[1373348386] linearizableReadLoop","detail":"{readStateIndex:1389; appliedIndex:1388; }","duration":"120.598246ms","start":"2026-04-07T15:20:32.255175Z","end":"2026-04-07T15:20:32.375773Z","steps":["trace[1373348386] 'read index received' (duration: 120.364661ms)","trace[1373348386] 'applied index is now lower than readState.Index' (duration: 230.195µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:20:32.375845Z","caller":"traceutil/trace.go:171","msg":"trace[1706566766] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"202.310537ms","start":"2026-04-07T15:20:32.173491Z","end":"2026-04-07T15:20:32.375802Z","steps":["trace[1706566766] 'process raft request' (duration: 202.02942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:32.375921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.740259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T15:20:32.37613Z","caller":"traceutil/trace.go:171","msg":"trace[300041924] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1337; }","duration":"121.001716ms","start":"2026-04-07T15:20:32.255114Z","end":"2026-04-07T15:20:32.376116Z","steps":["trace[300041924] 'agreement among raft nodes before linearized reading' (duration: 120.758019ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:33.154736Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3306378148685470295,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T15:20:33.425321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"956.741226ms","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-04-07T15:20:33.425402Z","caller":"traceutil/trace.go:171","msg":"trace[1370872846] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1337; }","duration":"956.88107ms","start":"2026-04-07T15:20:32.468503Z","end":"2026-04-07T15:20:33.425384Z","steps":["trace[1370872846] 'range keys from in-memory index tree' (duration: 956.561882ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:33.425442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:32.468478Z","time spent":"956.955082ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-07T15:20:33.425415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.790707ms","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-04-07T15:20:33.425503Z","caller":"traceutil/trace.go:171","msg":"trace[379488818] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1337; }","duration":"783.91452ms","start":"2026-04-07T15:20:32.641564Z","end":"2026-04-07T15:20:33.425478Z","steps":["trace[379488818] 'range keys from in-memory index tree' (duration: 783.52458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:33.425546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:32.641548Z","time spent":"783.988862ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-07T15:20:33.437283Z","caller":"traceutil/trace.go:171","msg":"trace[433930318] linearizableReadLoop","detail":"{readStateIndex:1390; appliedIndex:1389; }","duration":"782.881185ms","start":"2026-04-07T15:20:32.654386Z","end":"2026-04-07T15:20:33.437267Z","steps":["trace[433930318] 'read index received' (duration: 782.749051ms)","trace[433930318] 'applied index is now lower than readState.Index' (duration: 131.114µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T15:20:33.437357Z","caller":"traceutil/trace.go:171","msg":"trace[1654381847] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"792.027694ms","start":"2026-04-07T15:20:32.645308Z","end":"2026-04-07T15:20:33.437335Z","steps":["trace[1654381847] 'process raft request' (duration: 791.815288ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:33.437435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.045098ms","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-04-07T15:20:33.437475Z","caller":"traceutil/trace.go:171","msg":"trace[398360066] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1338; }","duration":"783.122041ms","start":"2026-04-07T15:20:32.654343Z","end":"2026-04-07T15:20:33.437465Z","steps":["trace[398360066] 'agreement among raft nodes before linearized reading' (duration: 783.003058ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:33.437504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:32.654325Z","time spent":"783.171972ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-07T15:20:33.437531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:32.645281Z","time spent":"792.125377ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T15:20:33.43911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.029507ms","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-04-07T15:20:33.439154Z","caller":"traceutil/trace.go:171","msg":"trace[1945435385] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1340; }","duration":"783.087108ms","start":"2026-04-07T15:20:32.656056Z","end":"2026-04-07T15:20:33.439143Z","steps":["trace[1945435385] 'agreement among raft nodes before linearized reading' (duration: 782.978876ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:33.439176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:32.656047Z","time spent":"783.12398ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-07T15:20:33.439504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.937821ms","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:524"} {"level":"info","ts":"2026-04-07T15:20:33.439559Z","caller":"traceutil/trace.go:171","msg":"trace[1097298804] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1340; }","duration":"364.030014ms","start":"2026-04-07T15:20:33.07552Z","end":"2026-04-07T15:20:33.43955Z","steps":["trace[1097298804] 'agreement among raft nodes before linearized reading' (duration: 363.86329ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:33.439664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:33.07548Z","time spent":"364.174367ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":548,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-07T15:20:33.439987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.686729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-07T15:20:33.44004Z","caller":"traceutil/trace.go:171","msg":"trace[597392881] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1340; }","duration":"782.762511ms","start":"2026-04-07T15:20:32.657265Z","end":"2026-04-07T15:20:33.440028Z","steps":["trace[597392881] 'agreement among raft nodes before linearized reading' (duration: 782.603667ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T15:20:33.440073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T15:20:32.657252Z","time spent":"782.814043ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-07T15:22:36.199557Z","caller":"traceutil/trace.go:171","msg":"trace[617117088] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"100.112036ms","start":"2026-04-07T15:22:36.099425Z","end":"2026-04-07T15:22:36.199537Z","steps":["trace[617117088] 'process raft request' (duration: 99.973222ms)"],"step_count":1}