{"level":"warn","ts":"2026-05-09T21:42:22.694992Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-09T21:42:22.695084Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.216: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.204.45.216:2380","--initial-cluster=instance=https://199.204.45.216:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.216:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.216: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-05-09T21:42:22.69515Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-09T21:42:22.695161Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-05-09T21:42:22.69518Z","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-05-09T21:42:22.695795Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"]} {"level":"info","ts":"2026-05-09T21:42:22.695865Z","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.204.45.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.216: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-05-09T21:42:22.700927Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.833766ms"} {"level":"info","ts":"2026-05-09T21:42:22.717837Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e98569549cc430c","cluster-id":"65d70b4d1d4a8bf9"} {"level":"info","ts":"2026-05-09T21:42:22.717924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=()"} {"level":"info","ts":"2026-05-09T21:42:22.717951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 0"} {"level":"info","ts":"2026-05-09T21:42:22.718057Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e98569549cc430c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-09T21:42:22.718075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 1"} {"level":"info","ts":"2026-05-09T21:42:22.718125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"warn","ts":"2026-05-09T21:42:22.728405Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-09T21:42:22.731787Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-09T21:42:22.73413Z","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-05-09T21:42:22.737127Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e98569549cc430c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-09T21:42:22.738177Z","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-05-09T21:42:22.738636Z","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-05-09T21:42:22.738645Z","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-05-09T21:42:22.738121Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e98569549cc430c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-09T21:42:22.73944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"info","ts":"2026-05-09T21:42:22.73954Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","added-peer-id":"4e98569549cc430c","added-peer-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-05-09T21:42:22.74185Z","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-05-09T21:42:22.742075Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-05-09T21:42:22.742124Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-05-09T21:42:22.743121Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e98569549cc430c","initial-advertise-peer-urls":["https://199.204.45.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-09T21:42:22.743148Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-09T21:42:23.519772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c is starting a new election at term 1"} {"level":"info","ts":"2026-05-09T21:42:23.519834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became pre-candidate at term 1"} {"level":"info","ts":"2026-05-09T21:42:23.519858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgPreVoteResp from 4e98569549cc430c at term 1"} {"level":"info","ts":"2026-05-09T21:42:23.519878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became candidate at term 2"} {"level":"info","ts":"2026-05-09T21:42:23.51989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgVoteResp from 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-05-09T21:42:23.519928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became leader at term 2"} {"level":"info","ts":"2026-05-09T21:42:23.519942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e98569549cc430c elected leader 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-05-09T21:42:23.520939Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e98569549cc430c","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.216:2379]}","request-path":"/0/members/4e98569549cc430c/attributes","cluster-id":"65d70b4d1d4a8bf9","publish-timeout":"7s"} {"level":"info","ts":"2026-05-09T21:42:23.520938Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T21:42:23.52099Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T21:42:23.521224Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T21:42:23.521428Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-09T21:42:23.52164Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-09T21:42:23.522665Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.216:2379"} {"level":"info","ts":"2026-05-09T21:42:23.524229Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-09T21:42:23.526741Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T21:42:23.526885Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T21:42:23.526922Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T21:42:51.289639Z","caller":"traceutil/trace.go:171","msg":"trace[1353593725] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"146.242147ms","start":"2026-05-09T21:42:51.143367Z","end":"2026-05-09T21:42:51.289609Z","steps":["trace[1353593725] 'process raft request' (duration: 146.016871ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:52.554676Z","caller":"traceutil/trace.go:171","msg":"trace[1448992042] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"165.355982ms","start":"2026-05-09T21:42:52.389299Z","end":"2026-05-09T21:42:52.554655Z","steps":["trace[1448992042] 'process raft request' (duration: 159.941477ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:52.555466Z","caller":"traceutil/trace.go:171","msg":"trace[333982387] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"163.226943ms","start":"2026-05-09T21:42:52.392224Z","end":"2026-05-09T21:42:52.555451Z","steps":["trace[333982387] 'process raft request' (duration: 162.897846ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:52.721939Z","caller":"traceutil/trace.go:171","msg":"trace[1227893709] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"156.311682ms","start":"2026-05-09T21:42:52.565601Z","end":"2026-05-09T21:42:52.721912Z","steps":["trace[1227893709] 'process raft request' (duration: 153.831924ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:52.724925Z","caller":"traceutil/trace.go:171","msg":"trace[2071327393] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"157.474669ms","start":"2026-05-09T21:42:52.567432Z","end":"2026-05-09T21:42:52.724907Z","steps":["trace[2071327393] 'process raft request' (duration: 157.122411ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:52.725127Z","caller":"traceutil/trace.go:171","msg":"trace[1935829805] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"108.466687ms","start":"2026-05-09T21:42:52.616653Z","end":"2026-05-09T21:42:52.72512Z","steps":["trace[1935829805] 'process raft request' (duration: 108.18505ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:52.726192Z","caller":"traceutil/trace.go:171","msg":"trace[1199232218] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"105.726283ms","start":"2026-05-09T21:42:52.620456Z","end":"2026-05-09T21:42:52.726182Z","steps":["trace[1199232218] 'process raft request' (duration: 105.003575ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:59.212679Z","caller":"traceutil/trace.go:171","msg":"trace[1032596523] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"141.182399ms","start":"2026-05-09T21:42:59.07146Z","end":"2026-05-09T21:42:59.212642Z","steps":["trace[1032596523] 'process raft request' (duration: 140.478973ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:42:59.423372Z","caller":"traceutil/trace.go:171","msg":"trace[1861002732] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"184.448066ms","start":"2026-05-09T21:42:59.238856Z","end":"2026-05-09T21:42:59.423304Z","steps":["trace[1861002732] 'process raft request' (duration: 184.068588ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:43:00.304034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:59.881013Z","time spent":"423.011415ms","remote":"127.0.0.1:34642","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-09T21:43:00.304932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"788.347096ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:43:00.305092Z","caller":"traceutil/trace.go:171","msg":"trace[1467113831] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:596; }","duration":"825.784268ms","start":"2026-05-09T21:42:59.479287Z","end":"2026-05-09T21:43:00.305072Z","steps":["trace[1467113831] 'read index received' (duration: 36.742455ms)","trace[1467113831] 'applied index is now lower than readState.Index' (duration: 789.040013ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:43:00.305154Z","caller":"traceutil/trace.go:171","msg":"trace[1487925780] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"1.030050087s","start":"2026-05-09T21:42:59.275083Z","end":"2026-05-09T21:43:00.305133Z","steps":["trace[1487925780] 'process raft request' (duration: 240.840251ms)","trace[1487925780] 'compare' (duration: 787.962028ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:43:00.305285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:59.275056Z","time spent":"1.030168879s","remote":"127.0.0.1:49892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T21:43:00.305366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"826.062494ms","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-05-09T21:43:00.305424Z","caller":"traceutil/trace.go:171","msg":"trace[118408609] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:576; }","duration":"826.256438ms","start":"2026-05-09T21:42:59.479152Z","end":"2026-05-09T21:43:00.305409Z","steps":["trace[118408609] 'agreement among raft nodes before linearized reading' (duration: 826.039583ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:43:00.305473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:59.479116Z","time spent":"826.346341ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-09T21:43:00.305806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.415985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-09T21:43:00.306105Z","caller":"traceutil/trace.go:171","msg":"trace[520661885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:576; }","duration":"824.634291ms","start":"2026-05-09T21:42:59.48127Z","end":"2026-05-09T21:43:00.305905Z","steps":["trace[520661885] 'agreement among raft nodes before linearized reading' (duration: 824.061898ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:43:00.306286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:42:59.481252Z","time spent":"825.01613ms","remote":"127.0.0.1:49916","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-05-09T21:43:00.563321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.562167ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:43:00.563469Z","caller":"traceutil/trace.go:171","msg":"trace[1126131960] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"253.758911ms","start":"2026-05-09T21:43:00.309676Z","end":"2026-05-09T21:43:00.563435Z","steps":["trace[1126131960] 'process raft request' (duration: 99.854545ms)","trace[1126131960] 'compare' (duration: 153.427685ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:43:00.563493Z","caller":"traceutil/trace.go:171","msg":"trace[1384955258] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:597; }","duration":"251.192941ms","start":"2026-05-09T21:43:00.312282Z","end":"2026-05-09T21:43:00.563475Z","steps":["trace[1384955258] 'read index received' (duration: 97.269266ms)","trace[1384955258] 'applied index is now lower than readState.Index' (duration: 153.922475ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:43:00.563665Z","caller":"traceutil/trace.go:171","msg":"trace[880948433] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"251.11171ms","start":"2026-05-09T21:43:00.31254Z","end":"2026-05-09T21:43:00.563652Z","steps":["trace[880948433] 'process raft request' (duration: 250.888584ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:43:00.56388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.55977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-09T21:43:00.564001Z","caller":"traceutil/trace.go:171","msg":"trace[858888749] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:578; }","duration":"251.713124ms","start":"2026-05-09T21:43:00.312256Z","end":"2026-05-09T21:43:00.563969Z","steps":["trace[858888749] 'agreement among raft nodes before linearized reading' (duration: 251.266383ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:43:00.563982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.771929ms","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-05-09T21:43:00.564075Z","caller":"traceutil/trace.go:171","msg":"trace[345046167] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:578; }","duration":"146.928504ms","start":"2026-05-09T21:43:00.417119Z","end":"2026-05-09T21:43:00.564047Z","steps":["trace[345046167] 'agreement among raft nodes before linearized reading' (duration: 146.671797ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:43:11.168065Z","caller":"traceutil/trace.go:171","msg":"trace[1193937395] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"153.056716ms","start":"2026-05-09T21:43:11.014982Z","end":"2026-05-09T21:43:11.168038Z","steps":["trace[1193937395] 'process raft request' (duration: 152.848562ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:43:18.02958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.012901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-j5jjj\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-09T21:43:18.02967Z","caller":"traceutil/trace.go:171","msg":"trace[1426883022] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-j5jjj; range_end:; response_count:1; response_revision:745; }","duration":"698.157254ms","start":"2026-05-09T21:43:17.33149Z","end":"2026-05-09T21:43:18.029647Z","steps":["trace[1426883022] 'range keys from in-memory index tree' (duration: 697.790736ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:43:18.029723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:43:17.331464Z","time spent":"698.247937ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-j5jjj\" "} {"level":"warn","ts":"2026-05-09T21:43:18.030137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.281464ms","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-05-09T21:43:18.030252Z","caller":"traceutil/trace.go:171","msg":"trace[1169267415] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:745; }","duration":"124.463678ms","start":"2026-05-09T21:43:17.90577Z","end":"2026-05-09T21:43:18.030234Z","steps":["trace[1169267415] 'range keys from in-memory index tree' (duration: 123.907056ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:43:38.838511Z","caller":"traceutil/trace.go:171","msg":"trace[1297983282] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"289.31544ms","start":"2026-05-09T21:43:38.549173Z","end":"2026-05-09T21:43:38.838488Z","steps":["trace[1297983282] 'process raft request' (duration: 289.099535ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:43:39.27271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.449561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-09T21:43:39.272796Z","caller":"traceutil/trace.go:171","msg":"trace[1158927308] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:910; }","duration":"216.590795ms","start":"2026-05-09T21:43:39.056187Z","end":"2026-05-09T21:43:39.272778Z","steps":["trace[1158927308] 'range keys from in-memory index tree' (duration: 216.244747ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:43:39.272812Z","caller":"traceutil/trace.go:171","msg":"trace[1715601255] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"119.968646ms","start":"2026-05-09T21:43:39.152761Z","end":"2026-05-09T21:43:39.27273Z","steps":["trace[1715601255] 'process raft request' (duration: 116.103506ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:43:47.473677Z","caller":"traceutil/trace.go:171","msg":"trace[1020927320] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"130.238935ms","start":"2026-05-09T21:43:47.34342Z","end":"2026-05-09T21:43:47.473659Z","steps":["trace[1020927320] 'process raft request' (duration: 130.104682ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:43:53.491484Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410286198326788,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T21:43:53.992149Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410286198326788,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T21:43:54.049409Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.168817139s","expected-duration":"1s"} {"level":"info","ts":"2026-05-09T21:43:54.050851Z","caller":"traceutil/trace.go:171","msg":"trace[1395014389] linearizableReadLoop","detail":"{readStateIndex:991; appliedIndex:990; }","duration":"1.059591996s","start":"2026-05-09T21:43:52.991236Z","end":"2026-05-09T21:43:54.050828Z","steps":["trace[1395014389] 'read index received' (duration: 1.059148355s)","trace[1395014389] 'applied index is now lower than readState.Index' (duration: 442.511µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:43:54.05095Z","caller":"traceutil/trace.go:171","msg":"trace[1490566819] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"1.170501669s","start":"2026-05-09T21:43:52.880423Z","end":"2026-05-09T21:43:54.050925Z","steps":["trace[1490566819] 'process raft request' (duration: 1.170044707s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:43:54.050996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.05974296s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:43:54.051034Z","caller":"traceutil/trace.go:171","msg":"trace[334567271] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:957; }","duration":"1.059839782s","start":"2026-05-09T21:43:52.991183Z","end":"2026-05-09T21:43:54.051022Z","steps":["trace[334567271] 'agreement among raft nodes before linearized reading' (duration: 1.0597611s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:43:54.051076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:43:52.991161Z","time spent":"1.059905943s","remote":"127.0.0.1:49698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T21:43:54.051106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:43:52.880396Z","time spent":"1.170614362s","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:43:54.051743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.03272519s","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-05-09T21:43:54.05181Z","caller":"traceutil/trace.go:171","msg":"trace[48674239] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:957; }","duration":"1.032831992s","start":"2026-05-09T21:43:53.018964Z","end":"2026-05-09T21:43:54.051796Z","steps":["trace[48674239] 'agreement among raft nodes before linearized reading' (duration: 1.032675398s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:43:54.05184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:43:53.018943Z","time spent":"1.032890303s","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-09T21:43:54.051997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.173148ms","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-05-09T21:43:54.052016Z","caller":"traceutil/trace.go:171","msg":"trace[835977667] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:957; }","duration":"374.236788ms","start":"2026-05-09T21:43:53.677773Z","end":"2026-05-09T21:43:54.05201Z","steps":["trace[835977667] 'agreement among raft nodes before linearized reading' (duration: 374.200818ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:43:54.052033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:43:53.677754Z","time spent":"374.27464ms","remote":"127.0.0.1:50012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":29,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-09T21:43:54.052205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.027520388s","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-05-09T21:43:54.052199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.027349934s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-09T21:43:54.052227Z","caller":"traceutil/trace.go:171","msg":"trace[1949555974] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:957; }","duration":"1.027560409s","start":"2026-05-09T21:43:53.024661Z","end":"2026-05-09T21:43:54.052221Z","steps":["trace[1949555974] 'agreement among raft nodes before linearized reading' (duration: 1.027497078s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:43:54.05225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:43:53.024653Z","time spent":"1.02758999s","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-09T21:43:54.052248Z","caller":"traceutil/trace.go:171","msg":"trace[700385361] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:957; }","duration":"1.027423296s","start":"2026-05-09T21:43:53.024811Z","end":"2026-05-09T21:43:54.052234Z","steps":["trace[700385361] 'agreement among raft nodes before linearized reading' (duration: 1.027241971s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:43:54.052286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:43:53.0248Z","time spent":"1.027478197s","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-09T21:43:54.05241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.437163ms","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-05-09T21:43:54.052416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.280124ms","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":"info","ts":"2026-05-09T21:43:54.052439Z","caller":"traceutil/trace.go:171","msg":"trace[91737470] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:957; }","duration":"556.492954ms","start":"2026-05-09T21:43:53.49594Z","end":"2026-05-09T21:43:54.052433Z","steps":["trace[91737470] 'agreement among raft nodes before linearized reading' (duration: 556.426723ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:43:54.052446Z","caller":"traceutil/trace.go:171","msg":"trace[1529931183] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:957; }","duration":"633.349905ms","start":"2026-05-09T21:43:53.419087Z","end":"2026-05-09T21:43:54.052437Z","steps":["trace[1529931183] 'agreement among raft nodes before linearized reading' (duration: 633.298484ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:43:54.052458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:43:53.495923Z","time spent":"556.531125ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-09T21:43:54.052485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:43:53.419068Z","time spent":"633.398836ms","remote":"127.0.0.1:50158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":2,"response size":29,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-05-09T21:43:54.467536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.953091ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:43:54.467843Z","caller":"traceutil/trace.go:171","msg":"trace[1772322656] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"411.074386ms","start":"2026-05-09T21:43:54.05675Z","end":"2026-05-09T21:43:54.467825Z","steps":["trace[1772322656] 'process raft request' (duration: 411.000644ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:43:54.467828Z","caller":"traceutil/trace.go:171","msg":"trace[1539566433] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"412.233423ms","start":"2026-05-09T21:43:54.055553Z","end":"2026-05-09T21:43:54.467786Z","steps":["trace[1539566433] 'process raft request' (duration: 216.920304ms)","trace[1539566433] 'compare' (duration: 194.783737ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:43:54.467863Z","caller":"traceutil/trace.go:171","msg":"trace[742503178] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"411.142177ms","start":"2026-05-09T21:43:54.056693Z","end":"2026-05-09T21:43:54.467835Z","steps":["trace[742503178] 'process raft request' (duration: 410.960833ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:43:54.467914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:43:54.056746Z","time spent":"411.134717ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:43:54.467979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:43:54.055535Z","time spent":"412.355556ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:43:54.467964Z","caller":"traceutil/trace.go:171","msg":"trace[1716178429] linearizableReadLoop","detail":"{readStateIndex:994; appliedIndex:991; }","duration":"407.045533ms","start":"2026-05-09T21:43:54.060894Z","end":"2026-05-09T21:43:54.46794Z","steps":["trace[1716178429] 'read index received' (duration: 212.01839ms)","trace[1716178429] 'applied index is now lower than readState.Index' (duration: 195.025423ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:43:54.468005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:43:54.056677Z","time spent":"411.25239ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:43:54.468088Z","caller":"traceutil/trace.go:171","msg":"trace[1343658060] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"405.217151ms","start":"2026-05-09T21:43:54.062858Z","end":"2026-05-09T21:43:54.468075Z","steps":["trace[1343658060] 'process raft request' (duration: 404.931663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:43:54.468161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.079095ms","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":"warn","ts":"2026-05-09T21:43:54.468188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:43:54.062849Z","time spent":"405.263952ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:43:54.468213Z","caller":"traceutil/trace.go:171","msg":"trace[1494329538] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:961; }","duration":"295.136457ms","start":"2026-05-09T21:43:54.173066Z","end":"2026-05-09T21:43:54.468202Z","steps":["trace[1494329538] 'agreement among raft nodes before linearized reading' (duration: 295.055485ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:43:54.46823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.3358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:43:54.468267Z","caller":"traceutil/trace.go:171","msg":"trace[521777527] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:961; }","duration":"407.385571ms","start":"2026-05-09T21:43:54.060871Z","end":"2026-05-09T21:43:54.468256Z","steps":["trace[521777527] 'agreement among raft nodes before linearized reading' (duration: 407.32902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:43:54.468293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:43:54.060862Z","time spent":"407.426213ms","remote":"127.0.0.1:49698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T21:43:54.468396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.587408ms","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-05-09T21:43:54.468432Z","caller":"traceutil/trace.go:171","msg":"trace[610896298] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:961; }","duration":"262.66756ms","start":"2026-05-09T21:43:54.205754Z","end":"2026-05-09T21:43:54.468422Z","steps":["trace[610896298] 'agreement among raft nodes before linearized reading' (duration: 262.544707ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:43:54.763483Z","caller":"traceutil/trace.go:171","msg":"trace[454580758] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"290.819466ms","start":"2026-05-09T21:43:54.472638Z","end":"2026-05-09T21:43:54.763458Z","steps":["trace[454580758] 'process raft request' (duration: 287.670042ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:18.297376Z","caller":"traceutil/trace.go:171","msg":"trace[180383498] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"295.018212ms","start":"2026-05-09T21:44:18.002316Z","end":"2026-05-09T21:44:18.297334Z","steps":["trace[180383498] 'process raft request' (duration: 294.716615ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:18.484975Z","caller":"traceutil/trace.go:171","msg":"trace[465113220] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"199.135389ms","start":"2026-05-09T21:44:18.285802Z","end":"2026-05-09T21:44:18.484937Z","steps":["trace[465113220] 'process raft request' (duration: 149.874371ms)","trace[465113220] 'compare' (duration: 48.773077ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:44:20.678721Z","caller":"traceutil/trace.go:171","msg":"trace[1728641351] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"187.58393ms","start":"2026-05-09T21:44:20.491107Z","end":"2026-05-09T21:44:20.678691Z","steps":["trace[1728641351] 'process raft request' (duration: 187.337015ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:20.966939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.604203ms","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-05-09T21:44:20.967072Z","caller":"traceutil/trace.go:171","msg":"trace[1414877805] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1044; }","duration":"163.811757ms","start":"2026-05-09T21:44:20.803236Z","end":"2026-05-09T21:44:20.967047Z","steps":["trace[1414877805] 'range keys from in-memory index tree' (duration: 163.235494ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:20.967229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.574773ms","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-05-09T21:44:20.967319Z","caller":"traceutil/trace.go:171","msg":"trace[1228257968] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1044; }","duration":"188.675685ms","start":"2026-05-09T21:44:20.778624Z","end":"2026-05-09T21:44:20.967299Z","steps":["trace[1228257968] 'range keys from in-memory index tree' (duration: 188.310077ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:20.967192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.137208ms","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-05-09T21:44:20.967527Z","caller":"traceutil/trace.go:171","msg":"trace[1617322302] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1044; }","duration":"156.528857ms","start":"2026-05-09T21:44:20.810977Z","end":"2026-05-09T21:44:20.967506Z","steps":["trace[1617322302] 'range keys from in-memory index tree' (duration: 155.938173ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:20.967787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.578724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-09T21:44:20.967953Z","caller":"traceutil/trace.go:171","msg":"trace[303953311] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1044; }","duration":"176.801979ms","start":"2026-05-09T21:44:20.791063Z","end":"2026-05-09T21:44:20.967865Z","steps":["trace[303953311] 'range keys from in-memory index tree' (duration: 176.070323ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:21.134637Z","caller":"traceutil/trace.go:171","msg":"trace[1411801631] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"161.404211ms","start":"2026-05-09T21:44:20.973199Z","end":"2026-05-09T21:44:21.134603Z","steps":["trace[1411801631] 'process raft request' (duration: 161.184166ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:21.728496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.493175ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:44:21.728727Z","caller":"traceutil/trace.go:171","msg":"trace[1395538130] linearizableReadLoop","detail":"{readStateIndex:1087; appliedIndex:1083; }","duration":"736.661381ms","start":"2026-05-09T21:44:20.992048Z","end":"2026-05-09T21:44:21.72871Z","steps":["trace[1395538130] 'read index received' (duration: 142.365327ms)","trace[1395538130] 'applied index is now lower than readState.Index' (duration: 594.294994ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:44:21.728828Z","caller":"traceutil/trace.go:171","msg":"trace[1815302888] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"754.63209ms","start":"2026-05-09T21:44:20.974186Z","end":"2026-05-09T21:44:21.728819Z","steps":["trace[1815302888] 'process raft request' (duration: 754.482907ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:21.728902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:20.974173Z","time spent":"754.680501ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:44:21.72888Z","caller":"traceutil/trace.go:171","msg":"trace[1579627520] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"754.704693ms","start":"2026-05-09T21:44:20.974123Z","end":"2026-05-09T21:44:21.728828Z","steps":["trace[1579627520] 'process raft request' (duration: 754.495518ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:21.729142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:20.974108Z","time spent":"754.891996ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:44:21.729185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.115921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:44:21.729211Z","caller":"traceutil/trace.go:171","msg":"trace[1548265282] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"755.079241ms","start":"2026-05-09T21:44:20.97407Z","end":"2026-05-09T21:44:21.72915Z","steps":["trace[1548265282] 'process raft request' (duration: 200.831229ms)","trace[1548265282] 'compare' (duration: 553.340271ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:44:21.729264Z","caller":"traceutil/trace.go:171","msg":"trace[742598899] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1048; }","duration":"737.232064ms","start":"2026-05-09T21:44:20.99201Z","end":"2026-05-09T21:44:21.729242Z","steps":["trace[742598899] 'agreement among raft nodes before linearized reading' (duration: 737.104121ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:21.729324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:20.991998Z","time spent":"737.317976ms","remote":"127.0.0.1:49698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T21:44:21.729428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.953567ms","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-05-09T21:44:21.729479Z","caller":"traceutil/trace.go:171","msg":"trace[1388496073] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1048; }","duration":"658.08516ms","start":"2026-05-09T21:44:21.071381Z","end":"2026-05-09T21:44:21.729466Z","steps":["trace[1388496073] 'agreement among raft nodes before linearized reading' (duration: 657.884036ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:21.72949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:20.973945Z","time spent":"755.382038ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:44:21.729513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:21.071354Z","time spent":"658.149802ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-09T21:44:21.93664Z","caller":"traceutil/trace.go:171","msg":"trace[1837295496] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"201.866193ms","start":"2026-05-09T21:44:21.734731Z","end":"2026-05-09T21:44:21.936597Z","steps":["trace[1837295496] 'process raft request' (duration: 142.768496ms)","trace[1837295496] 'compare' (duration: 58.918093ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:44:22.469485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.296689ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-09T21:44:25.904995Z","caller":"traceutil/trace.go:171","msg":"trace[1332887960] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"155.301148ms","start":"2026-05-09T21:44:25.749659Z","end":"2026-05-09T21:44:25.90496Z","steps":["trace[1332887960] 'process raft request' (duration: 155.062952ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:25.907284Z","caller":"traceutil/trace.go:171","msg":"trace[550164960] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"153.848655ms","start":"2026-05-09T21:44:25.753412Z","end":"2026-05-09T21:44:25.907261Z","steps":["trace[550164960] 'process raft request' (duration: 153.570638ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:25.907191Z","caller":"traceutil/trace.go:171","msg":"trace[1603166851] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"153.799873ms","start":"2026-05-09T21:44:25.753311Z","end":"2026-05-09T21:44:25.907111Z","steps":["trace[1603166851] 'process raft request' (duration: 153.407124ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:35.31913Z","caller":"traceutil/trace.go:171","msg":"trace[638665707] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"120.292353ms","start":"2026-05-09T21:44:35.198819Z","end":"2026-05-09T21:44:35.319112Z","steps":["trace[638665707] 'process raft request' (duration: 120.17628ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:36.449031Z","caller":"traceutil/trace.go:171","msg":"trace[1583433225] linearizableReadLoop","detail":"{readStateIndex:1186; appliedIndex:1185; }","duration":"398.876912ms","start":"2026-05-09T21:44:36.050128Z","end":"2026-05-09T21:44:36.449005Z","steps":["trace[1583433225] 'read index received' (duration: 398.667448ms)","trace[1583433225] 'applied index is now lower than readState.Index' (duration: 208.414µs)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:44:36.449358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.51551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-05-09T21:44:36.449393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.245561ms","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-05-09T21:44:36.449437Z","caller":"traceutil/trace.go:171","msg":"trace[411050717] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"401.837891ms","start":"2026-05-09T21:44:36.047305Z","end":"2026-05-09T21:44:36.449143Z","steps":["trace[411050717] 'process raft request' (duration: 401.542364ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:36.449484Z","caller":"traceutil/trace.go:171","msg":"trace[915934040] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1142; }","duration":"399.461977ms","start":"2026-05-09T21:44:36.050003Z","end":"2026-05-09T21:44:36.449465Z","steps":["trace[915934040] 'agreement among raft nodes before linearized reading' (duration: 399.19414ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:36.449423Z","caller":"traceutil/trace.go:171","msg":"trace[185870845] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1142; }","duration":"397.601053ms","start":"2026-05-09T21:44:36.051807Z","end":"2026-05-09T21:44:36.449408Z","steps":["trace[185870845] 'agreement among raft nodes before linearized reading' (duration: 397.360086ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:36.449544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:36.049931Z","time spent":"399.60385ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-09T21:44:36.449358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.711842ms","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-05-09T21:44:36.449587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:36.051746Z","time spent":"397.826528ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-09T21:44:36.449661Z","caller":"traceutil/trace.go:171","msg":"trace[1641784774] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1142; }","duration":"394.060771ms","start":"2026-05-09T21:44:36.05557Z","end":"2026-05-09T21:44:36.44963Z","steps":["trace[1641784774] 'agreement among raft nodes before linearized reading' (duration: 393.63052ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:36.44975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:36.055549Z","time spent":"394.169973ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-09T21:44:36.449862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:36.047289Z","time spent":"402.246602ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:44:37.041416Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410286198327241,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-09T21:44:37.370603Z","caller":"traceutil/trace.go:171","msg":"trace[2119518480] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"915.515088ms","start":"2026-05-09T21:44:36.455062Z","end":"2026-05-09T21:44:37.370577Z","steps":["trace[2119518480] 'process raft request' (duration: 915.463317ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:37.37063Z","caller":"traceutil/trace.go:171","msg":"trace[171422976] transaction","detail":"{read_only:false; response_revision:1144; number_of_response:1; }","duration":"916.400009ms","start":"2026-05-09T21:44:36.454213Z","end":"2026-05-09T21:44:37.370613Z","steps":["trace[171422976] 'process raft request' (duration: 916.167313ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:37.370771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:36.455054Z","time spent":"915.63432ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:44:37.370811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:36.454191Z","time spent":"916.578323ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:44:37.371442Z","caller":"traceutil/trace.go:171","msg":"trace[1913987055] linearizableReadLoop","detail":"{readStateIndex:1190; appliedIndex:1187; }","duration":"830.716733ms","start":"2026-05-09T21:44:36.540695Z","end":"2026-05-09T21:44:37.371412Z","steps":["trace[1913987055] 'read index received' (duration: 829.77883ms)","trace[1913987055] 'applied index is now lower than readState.Index' (duration: 936.523µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:44:37.371614Z","caller":"traceutil/trace.go:171","msg":"trace[256233089] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"629.948365ms","start":"2026-05-09T21:44:36.741656Z","end":"2026-05-09T21:44:37.371605Z","steps":["trace[256233089] 'process raft request' (duration: 629.488315ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:37.371723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.157077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:44:37.371787Z","caller":"traceutil/trace.go:171","msg":"trace[1496427108] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1146; }","duration":"380.220528ms","start":"2026-05-09T21:44:36.991551Z","end":"2026-05-09T21:44:37.371771Z","steps":["trace[1496427108] 'agreement among raft nodes before linearized reading' (duration: 380.125926ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:37.37183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:36.991507Z","time spent":"380.31508ms","remote":"127.0.0.1:49698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T21:44:37.372016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.988122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:44:37.372056Z","caller":"traceutil/trace.go:171","msg":"trace[1303927537] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1146; }","duration":"234.145376ms","start":"2026-05-09T21:44:37.137899Z","end":"2026-05-09T21:44:37.372044Z","steps":["trace[1303927537] 'agreement among raft nodes before linearized reading' (duration: 234.088004ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:37.371742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:36.741625Z","time spent":"630.018817ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:44:37.372178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"831.486912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.216\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-09T21:44:37.372222Z","caller":"traceutil/trace.go:171","msg":"trace[1153636435] range","detail":"{range_begin:/registry/masterleases/199.204.45.216; range_end:; response_count:1; response_revision:1146; }","duration":"831.556482ms","start":"2026-05-09T21:44:36.540657Z","end":"2026-05-09T21:44:37.372214Z","steps":["trace[1153636435] 'agreement among raft nodes before linearized reading' (duration: 831.474631ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:37.372247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:36.540646Z","time spent":"831.597303ms","remote":"127.0.0.1:49726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.216\" "} {"level":"warn","ts":"2026-05-09T21:44:49.7609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.189937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:44:49.760997Z","caller":"traceutil/trace.go:171","msg":"trace[648319593] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1188; }","duration":"123.32016ms","start":"2026-05-09T21:44:49.637635Z","end":"2026-05-09T21:44:49.760955Z","steps":["trace[648319593] 'count revisions from in-memory index tree' (duration: 123.113515ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:53.031337Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410286198327385,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-09T21:44:53.276668Z","caller":"traceutil/trace.go:171","msg":"trace[372660422] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"897.892092ms","start":"2026-05-09T21:44:52.378741Z","end":"2026-05-09T21:44:53.276633Z","steps":["trace[372660422] 'process raft request' (duration: 897.716438ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:53.276857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:52.378718Z","time spent":"898.050496ms","remote":"127.0.0.1:49756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":871,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T21:44:53.719625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.620193ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-09T21:44:53.719956Z","caller":"traceutil/trace.go:171","msg":"trace[74265483] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"243.645657ms","start":"2026-05-09T21:44:53.476288Z","end":"2026-05-09T21:44:53.719933Z","steps":["trace[74265483] 'process raft request' (duration: 243.514233ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:53.720302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.188995473s","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-05-09T21:44:53.720385Z","caller":"traceutil/trace.go:171","msg":"trace[1562120787] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1205; }","duration":"1.189124487s","start":"2026-05-09T21:44:52.531237Z","end":"2026-05-09T21:44:53.720362Z","steps":["trace[1562120787] 'agreement among raft nodes before linearized reading' (duration: 1.18882984s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:53.720432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:52.531219Z","time spent":"1.189203498s","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-09T21:44:53.719987Z","caller":"traceutil/trace.go:171","msg":"trace[1670649905] linearizableReadLoop","detail":"{readStateIndex:1252; appliedIndex:1250; }","duration":"1.188659786s","start":"2026-05-09T21:44:52.531285Z","end":"2026-05-09T21:44:53.719945Z","steps":["trace[1670649905] 'read index received' (duration: 744.496999ms)","trace[1670649905] 'applied index is now lower than readState.Index' (duration: 444.158817ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:44:53.720951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.941821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-09T21:44:53.721005Z","caller":"traceutil/trace.go:171","msg":"trace[423646309] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1205; }","duration":"236.006073ms","start":"2026-05-09T21:44:53.484977Z","end":"2026-05-09T21:44:53.720983Z","steps":["trace[423646309] 'agreement among raft nodes before linearized reading' (duration: 235.87256ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:53.721048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.114650432s","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-05-09T21:44:53.721089Z","caller":"traceutil/trace.go:171","msg":"trace[370684804] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1205; }","duration":"1.114806985s","start":"2026-05-09T21:44:52.606268Z","end":"2026-05-09T21:44:53.721075Z","steps":["trace[370684804] 'agreement among raft nodes before linearized reading' (duration: 1.114545849s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:53.721122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:52.606232Z","time spent":"1.114882107s","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-09T21:44:53.721233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.542316ms","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-05-09T21:44:53.721267Z","caller":"traceutil/trace.go:171","msg":"trace[695561878] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1205; }","duration":"231.624858ms","start":"2026-05-09T21:44:53.489633Z","end":"2026-05-09T21:44:53.721257Z","steps":["trace[695561878] 'agreement among raft nodes before linearized reading' (duration: 231.534886ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:53.721364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.975679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:44:53.721387Z","caller":"traceutil/trace.go:171","msg":"trace[567156803] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1205; }","duration":"730.051921ms","start":"2026-05-09T21:44:52.991327Z","end":"2026-05-09T21:44:53.721379Z","steps":["trace[567156803] 'agreement among raft nodes before linearized reading' (duration: 730.01786ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:53.721444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:52.991299Z","time spent":"730.139793ms","remote":"127.0.0.1:49702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T21:44:53.721483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"938.164302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:44:53.721542Z","caller":"traceutil/trace.go:171","msg":"trace[1238185644] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1205; }","duration":"938.281675ms","start":"2026-05-09T21:44:52.783249Z","end":"2026-05-09T21:44:53.721531Z","steps":["trace[1238185644] 'agreement among raft nodes before linearized reading' (duration: 938.193513ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:53.721564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:52.783213Z","time spent":"938.346216ms","remote":"127.0.0.1:60268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-09T21:44:53.721638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.351774ms","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-05-09T21:44:53.721672Z","caller":"traceutil/trace.go:171","msg":"trace[1097141661] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1205; }","duration":"239.430005ms","start":"2026-05-09T21:44:53.482233Z","end":"2026-05-09T21:44:53.721663Z","steps":["trace[1097141661] 'agreement among raft nodes before linearized reading' (duration: 239.341023ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:53.968503Z","caller":"traceutil/trace.go:171","msg":"trace[2123454816] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"241.336982ms","start":"2026-05-09T21:44:53.727141Z","end":"2026-05-09T21:44:53.968478Z","steps":["trace[2123454816] 'process raft request' (duration: 241.114987ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:53.968791Z","caller":"traceutil/trace.go:171","msg":"trace[853398012] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"241.584098ms","start":"2026-05-09T21:44:53.727185Z","end":"2026-05-09T21:44:53.968769Z","steps":["trace[853398012] 'process raft request' (duration: 241.24199ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:53.96906Z","caller":"traceutil/trace.go:171","msg":"trace[337499884] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"241.609159ms","start":"2026-05-09T21:44:53.727439Z","end":"2026-05-09T21:44:53.969048Z","steps":["trace[337499884] 'process raft request' (duration: 241.260191ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:53.969082Z","caller":"traceutil/trace.go:171","msg":"trace[82910018] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"240.403378ms","start":"2026-05-09T21:44:53.728669Z","end":"2026-05-09T21:44:53.969073Z","steps":["trace[82910018] 'process raft request' (duration: 240.338017ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:55.060727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.228022ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:44:55.060821Z","caller":"traceutil/trace.go:171","msg":"trace[544255792] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"523.569108ms","start":"2026-05-09T21:44:54.537235Z","end":"2026-05-09T21:44:55.060805Z","steps":["trace[544255792] 'process raft request' (duration: 328.202933ms)","trace[544255792] 'compare' (duration: 195.042127ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:44:55.060868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:54.537193Z","time spent":"523.65538ms","remote":"127.0.0.1:49756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":823,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T21:44:55.603725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.242946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:44:55.603809Z","caller":"traceutil/trace.go:171","msg":"trace[100711208] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1213; }","duration":"125.397159ms","start":"2026-05-09T21:44:55.478395Z","end":"2026-05-09T21:44:55.603792Z","steps":["trace[100711208] 'count revisions from in-memory index tree' (duration: 125.149114ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:55.604013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.032953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5331"} {"level":"info","ts":"2026-05-09T21:44:55.604042Z","caller":"traceutil/trace.go:171","msg":"trace[1920715576] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1213; }","duration":"290.126136ms","start":"2026-05-09T21:44:55.313909Z","end":"2026-05-09T21:44:55.604035Z","steps":["trace[1920715576] 'range keys from in-memory index tree' (duration: 289.874ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:55.720045Z","caller":"traceutil/trace.go:171","msg":"trace[1947804690] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"107.226843ms","start":"2026-05-09T21:44:55.612793Z","end":"2026-05-09T21:44:55.720019Z","steps":["trace[1947804690] 'process raft request' (duration: 107.067448ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:55.903144Z","caller":"traceutil/trace.go:171","msg":"trace[2145383819] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"130.458082ms","start":"2026-05-09T21:44:55.772661Z","end":"2026-05-09T21:44:55.903119Z","steps":["trace[2145383819] 'process raft request' (duration: 46.437428ms)","trace[2145383819] 'compare' (duration: 83.901881ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:44:56.497182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.861629ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:44:56.497294Z","caller":"traceutil/trace.go:171","msg":"trace[1912085385] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"520.851383ms","start":"2026-05-09T21:44:55.976418Z","end":"2026-05-09T21:44:56.497269Z","steps":["trace[1912085385] 'process raft request' (duration: 76.804579ms)","trace[1912085385] 'compare' (duration: 443.378298ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:44:56.497356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:55.9764Z","time spent":"520.927195ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:44:57.922132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.269345709s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T21:44:57.922658Z","caller":"traceutil/trace.go:171","msg":"trace[901151245] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"1.946075794s","start":"2026-05-09T21:44:55.97654Z","end":"2026-05-09T21:44:57.922616Z","steps":["trace[901151245] 'process raft request' (duration: 676.153892ms)","trace[901151245] 'compare' (duration: 1.26818814s)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:44:57.922785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:55.976527Z","time spent":"1.946191328s","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:44:57.923403Z","caller":"traceutil/trace.go:171","msg":"trace[2088997399] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"1.946048385s","start":"2026-05-09T21:44:55.977337Z","end":"2026-05-09T21:44:57.923385Z","steps":["trace[2088997399] 'process raft request' (duration: 1.944925738s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:57.923545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:55.977311Z","time spent":"1.946174747s","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:44:57.923701Z","caller":"traceutil/trace.go:171","msg":"trace[182030041] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"148.105616ms","start":"2026-05-09T21:44:57.775566Z","end":"2026-05-09T21:44:57.923671Z","steps":["trace[182030041] 'process raft request' (duration: 148.001104ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:57.923957Z","caller":"traceutil/trace.go:171","msg":"trace[53591837] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"1.945168473s","start":"2026-05-09T21:44:55.97877Z","end":"2026-05-09T21:44:57.923938Z","steps":["trace[53591837] 'process raft request' (duration: 1.944569309s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:57.924052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.933176544s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:44:57.924102Z","caller":"traceutil/trace.go:171","msg":"trace[312135476] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1222; }","duration":"1.933279006s","start":"2026-05-09T21:44:55.990813Z","end":"2026-05-09T21:44:57.924092Z","steps":["trace[312135476] 'agreement among raft nodes before linearized reading' (duration: 1.933187294s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:57.924159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:55.990801Z","time spent":"1.933347028s","remote":"127.0.0.1:49698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T21:44:57.924058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:55.978758Z","time spent":"1.945251635s","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:44:57.92397Z","caller":"traceutil/trace.go:171","msg":"trace[1736553379] linearizableReadLoop","detail":"{readStateIndex:1269; appliedIndex:1265; }","duration":"1.933102572s","start":"2026-05-09T21:44:55.990854Z","end":"2026-05-09T21:44:57.923956Z","steps":["trace[1736553379] 'read index received' (duration: 62.332081ms)","trace[1736553379] 'applied index is now lower than readState.Index' (duration: 1.870765621s)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:44:57.924988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.905339354s","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-05-09T21:44:57.925052Z","caller":"traceutil/trace.go:171","msg":"trace[186896372] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1222; }","duration":"1.905441507s","start":"2026-05-09T21:44:56.019591Z","end":"2026-05-09T21:44:57.925032Z","steps":["trace[186896372] 'agreement among raft nodes before linearized reading' (duration: 1.905332584s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:57.925077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.976011ms","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":"warn","ts":"2026-05-09T21:44:57.925101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:56.019574Z","time spent":"1.905514879s","remote":"127.0.0.1:60450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"info","ts":"2026-05-09T21:44:57.925126Z","caller":"traceutil/trace.go:171","msg":"trace[1681757135] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1222; }","duration":"755.076494ms","start":"2026-05-09T21:44:57.170032Z","end":"2026-05-09T21:44:57.925109Z","steps":["trace[1681757135] 'agreement among raft nodes before linearized reading' (duration: 754.954331ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:57.925161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:57.170006Z","time spent":"755.145326ms","remote":"127.0.0.1:60260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-05-09T21:44:57.925212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.894609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T21:44:57.9253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"963.718818ms","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-05-09T21:44:57.925311Z","caller":"traceutil/trace.go:171","msg":"trace[610556014] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1222; }","duration":"591.002152ms","start":"2026-05-09T21:44:57.33429Z","end":"2026-05-09T21:44:57.925292Z","steps":["trace[610556014] 'agreement among raft nodes before linearized reading' (duration: 590.866449ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:57.925336Z","caller":"traceutil/trace.go:171","msg":"trace[1253555812] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1222; }","duration":"963.80683ms","start":"2026-05-09T21:44:56.961517Z","end":"2026-05-09T21:44:57.925324Z","steps":["trace[1253555812] 'agreement among raft nodes before linearized reading' (duration: 963.752198ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:57.925351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:57.334235Z","time spent":"591.103925ms","remote":"127.0.0.1:33458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-09T21:44:57.925372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:56.960918Z","time spent":"964.446396ms","remote":"127.0.0.1:60482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-09T21:44:57.925619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.383347844s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.216\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-09T21:44:57.925657Z","caller":"traceutil/trace.go:171","msg":"trace[1617371915] range","detail":"{range_begin:/registry/masterleases/199.204.45.216; range_end:; response_count:1; response_revision:1222; }","duration":"1.383442235s","start":"2026-05-09T21:44:56.542206Z","end":"2026-05-09T21:44:57.925648Z","steps":["trace[1617371915] 'agreement among raft nodes before linearized reading' (duration: 1.383310672s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:57.925684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:56.542174Z","time spent":"1.383504007s","remote":"127.0.0.1:49726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.216\" "} {"level":"warn","ts":"2026-05-09T21:44:57.925689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.49906367s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:44:57.925724Z","caller":"traceutil/trace.go:171","msg":"trace[1784535780] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1222; }","duration":"1.499138472s","start":"2026-05-09T21:44:56.426573Z","end":"2026-05-09T21:44:57.925712Z","steps":["trace[1784535780] 'agreement among raft nodes before linearized reading' (duration: 1.49907757s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:44:57.925761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:44:56.426551Z","time spent":"1.499199953s","remote":"127.0.0.1:60334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-09T21:44:58.158903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.55538ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-05-09T21:44:58.159198Z","caller":"traceutil/trace.go:171","msg":"trace[1809950408] linearizableReadLoop","detail":"{readStateIndex:1272; appliedIndex:1270; }","duration":"225.740226ms","start":"2026-05-09T21:44:57.933437Z","end":"2026-05-09T21:44:58.159178Z","steps":["trace[1809950408] 'read index received' (duration: 107.922039ms)","trace[1809950408] 'applied index is now lower than readState.Index' (duration: 117.816977ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:44:58.159398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.95104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:44:58.159395Z","caller":"traceutil/trace.go:171","msg":"trace[1669411112] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"229.889446ms","start":"2026-05-09T21:44:57.92948Z","end":"2026-05-09T21:44:58.15937Z","steps":["trace[1669411112] 'process raft request' (duration: 229.550758ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:58.159455Z","caller":"traceutil/trace.go:171","msg":"trace[1969920447] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1223; }","duration":"226.042413ms","start":"2026-05-09T21:44:57.933398Z","end":"2026-05-09T21:44:58.159441Z","steps":["trace[1969920447] 'agreement among raft nodes before linearized reading' (duration: 225.857419ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:44:58.902473Z","caller":"traceutil/trace.go:171","msg":"trace[199790189] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"109.910627ms","start":"2026-05-09T21:44:58.792529Z","end":"2026-05-09T21:44:58.90244Z","steps":["trace[199790189] 'process raft request' (duration: 109.704521ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:45:11.141341Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410286198327607,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T21:45:11.641935Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410286198327607,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T21:45:12.142664Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410286198327607,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T21:45:12.1658Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.946539426s","expected-duration":"1s"} {"level":"info","ts":"2026-05-09T21:45:12.166181Z","caller":"traceutil/trace.go:171","msg":"trace[1978682174] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"1.947006276s","start":"2026-05-09T21:45:10.219152Z","end":"2026-05-09T21:45:12.166159Z","steps":["trace[1978682174] 'process raft request' (duration: 1.946855833s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:45:12.166332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:45:10.219134Z","time spent":"1.947109119s","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:45:12.182175Z","caller":"traceutil/trace.go:171","msg":"trace[338059828] linearizableReadLoop","detail":"{readStateIndex:1372; appliedIndex:1369; }","duration":"1.541652825s","start":"2026-05-09T21:45:10.6405Z","end":"2026-05-09T21:45:12.182153Z","steps":["trace[338059828] 'read index received' (duration: 1.525555977s)","trace[338059828] 'applied index is now lower than readState.Index' (duration: 16.096248ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:45:12.182209Z","caller":"traceutil/trace.go:171","msg":"trace[1946349293] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"451.532593ms","start":"2026-05-09T21:45:11.730664Z","end":"2026-05-09T21:45:12.182197Z","steps":["trace[1946349293] 'process raft request' (duration: 451.347868ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:45:12.182247Z","caller":"traceutil/trace.go:171","msg":"trace[1957677939] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"213.942992ms","start":"2026-05-09T21:45:11.968295Z","end":"2026-05-09T21:45:12.182238Z","steps":["trace[1957677939] 'process raft request' (duration: 213.822759ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:45:12.182264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:45:11.730638Z","time spent":"451.597175ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T21:45:12.182349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.741563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:45:12.182377Z","caller":"traceutil/trace.go:171","msg":"trace[1582603903] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1321; }","duration":"190.811415ms","start":"2026-05-09T21:45:11.991558Z","end":"2026-05-09T21:45:12.18237Z","steps":["trace[1582603903] 'agreement among raft nodes before linearized reading' (duration: 190.765424ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:45:12.182487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.181301638s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-05-09T21:45:12.18251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.144823ms","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-05-09T21:45:12.182513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.460276ms","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-05-09T21:45:12.182543Z","caller":"traceutil/trace.go:171","msg":"trace[1270049894] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1321; }","duration":"191.249405ms","start":"2026-05-09T21:45:11.991286Z","end":"2026-05-09T21:45:12.182536Z","steps":["trace[1270049894] 'agreement among raft nodes before linearized reading' (duration: 191.083861ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:45:12.182546Z","caller":"traceutil/trace.go:171","msg":"trace[1554169118] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1321; }","duration":"1.181432511s","start":"2026-05-09T21:45:11.0011Z","end":"2026-05-09T21:45:12.182533Z","steps":["trace[1554169118] 'agreement among raft nodes before linearized reading' (duration: 1.181199065s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:45:12.182554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.927427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:45:12.182595Z","caller":"traceutil/trace.go:171","msg":"trace[453171066] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1321; }","duration":"190.555039ms","start":"2026-05-09T21:45:11.991997Z","end":"2026-05-09T21:45:12.182552Z","steps":["trace[453171066] 'agreement among raft nodes before linearized reading' (duration: 190.343624ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:45:12.182608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.788775ms","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-05-09T21:45:12.182656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.542165158s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-09T21:45:12.182649Z","caller":"traceutil/trace.go:171","msg":"trace[16271668] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1321; }","duration":"191.068451ms","start":"2026-05-09T21:45:11.991555Z","end":"2026-05-09T21:45:12.182624Z","steps":["trace[16271668] 'agreement among raft nodes before linearized reading' (duration: 190.900497ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:45:12.18268Z","caller":"traceutil/trace.go:171","msg":"trace[1230818867] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1321; }","duration":"1.542231949s","start":"2026-05-09T21:45:10.640442Z","end":"2026-05-09T21:45:12.182674Z","steps":["trace[1230818867] 'agreement among raft nodes before linearized reading' (duration: 1.542127337s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:45:12.1827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:45:10.640422Z","time spent":"1.54227438s","remote":"127.0.0.1:49916","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-05-09T21:45:12.182643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.704704ms","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-05-09T21:45:12.182798Z","caller":"traceutil/trace.go:171","msg":"trace[1180936332] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1321; }","duration":"563.92067ms","start":"2026-05-09T21:45:11.61887Z","end":"2026-05-09T21:45:12.18279Z","steps":["trace[1180936332] 'agreement among raft nodes before linearized reading' (duration: 563.731075ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:45:12.182847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:45:11.618849Z","time spent":"563.988851ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-05-09T21:45:12.182689Z","caller":"traceutil/trace.go:171","msg":"trace[1961573461] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1321; }","duration":"190.904667ms","start":"2026-05-09T21:45:11.991767Z","end":"2026-05-09T21:45:12.182672Z","steps":["trace[1961573461] 'agreement among raft nodes before linearized reading' (duration: 190.631311ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:45:12.182599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:45:11.001076Z","time spent":"1.181515423s","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-05-09T21:45:46.507642Z","caller":"traceutil/trace.go:171","msg":"trace[685159774] transaction","detail":"{read_only:false; response_revision:1481; number_of_response:1; }","duration":"112.179622ms","start":"2026-05-09T21:45:46.395438Z","end":"2026-05-09T21:45:46.507618Z","steps":["trace[685159774] 'process raft request' (duration: 112.10195ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:45:46.507695Z","caller":"traceutil/trace.go:171","msg":"trace[1525007951] transaction","detail":"{read_only:false; response_revision:1480; number_of_response:1; }","duration":"114.601839ms","start":"2026-05-09T21:45:46.393047Z","end":"2026-05-09T21:45:46.507649Z","steps":["trace[1525007951] 'process raft request' (duration: 114.357503ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:45:46.507863Z","caller":"traceutil/trace.go:171","msg":"trace[514521153] linearizableReadLoop","detail":"{readStateIndex:1540; appliedIndex:1536; }","duration":"108.790443ms","start":"2026-05-09T21:45:46.39904Z","end":"2026-05-09T21:45:46.507831Z","steps":["trace[514521153] 'read index received' (duration: 28.657933ms)","trace[514521153] 'applied index is now lower than readState.Index' (duration: 80.13032ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:45:46.507944Z","caller":"traceutil/trace.go:171","msg":"trace[1964228401] transaction","detail":"{read_only:false; response_revision:1482; number_of_response:1; }","duration":"112.444418ms","start":"2026-05-09T21:45:46.395472Z","end":"2026-05-09T21:45:46.507917Z","steps":["trace[1964228401] 'process raft request' (duration: 112.10591ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:45:46.508123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.069469ms","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-05-09T21:45:46.508658Z","caller":"traceutil/trace.go:171","msg":"trace[456299371] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1482; }","duration":"109.640113ms","start":"2026-05-09T21:45:46.399002Z","end":"2026-05-09T21:45:46.508642Z","steps":["trace[456299371] 'agreement among raft nodes before linearized reading' (duration: 108.957087ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:45:56.692876Z","caller":"traceutil/trace.go:171","msg":"trace[2044113259] transaction","detail":"{read_only:false; response_revision:1526; number_of_response:1; }","duration":"112.133411ms","start":"2026-05-09T21:45:56.580721Z","end":"2026-05-09T21:45:56.692854Z","steps":["trace[2044113259] 'process raft request' (duration: 111.932806ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:45:56.693418Z","caller":"traceutil/trace.go:171","msg":"trace[187074303] transaction","detail":"{read_only:false; response_revision:1527; number_of_response:1; }","duration":"111.720151ms","start":"2026-05-09T21:45:56.581686Z","end":"2026-05-09T21:45:56.693406Z","steps":["trace[187074303] 'process raft request' (duration: 111.123797ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:45:56.693742Z","caller":"traceutil/trace.go:171","msg":"trace[1241513071] transaction","detail":"{read_only:false; response_revision:1528; number_of_response:1; }","duration":"111.482555ms","start":"2026-05-09T21:45:56.582246Z","end":"2026-05-09T21:45:56.693729Z","steps":["trace[1241513071] 'process raft request' (duration: 111.114097ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:45:56.693734Z","caller":"traceutil/trace.go:171","msg":"trace[692649309] transaction","detail":"{read_only:false; response_revision:1529; number_of_response:1; }","duration":"109.268094ms","start":"2026-05-09T21:45:56.584446Z","end":"2026-05-09T21:45:56.693714Z","steps":["trace[692649309] 'process raft request' (duration: 109.180122ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:45:57.461439Z","caller":"traceutil/trace.go:171","msg":"trace[111554629] transaction","detail":"{read_only:false; response_revision:1532; number_of_response:1; }","duration":"159.542773ms","start":"2026-05-09T21:45:57.301868Z","end":"2026-05-09T21:45:57.461411Z","steps":["trace[111554629] 'process raft request' (duration: 147.297356ms)","trace[111554629] 'compare' (duration: 12.130565ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:46:06.876117Z","caller":"traceutil/trace.go:171","msg":"trace[506488799] linearizableReadLoop","detail":"{readStateIndex:1635; appliedIndex:1634; }","duration":"116.278969ms","start":"2026-05-09T21:46:06.75982Z","end":"2026-05-09T21:46:06.876099Z","steps":["trace[506488799] 'read index received' (duration: 116.125935ms)","trace[506488799] 'applied index is now lower than readState.Index' (duration: 152.184µs)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:46:06.876362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.593485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-09T21:46:06.876459Z","caller":"traceutil/trace.go:171","msg":"trace[1588363158] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1572; }","duration":"116.721878ms","start":"2026-05-09T21:46:06.759712Z","end":"2026-05-09T21:46:06.876434Z","steps":["trace[1588363158] 'agreement among raft nodes before linearized reading' (duration: 116.489523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:46:06.876652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.533403ms","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-05-09T21:46:06.876624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.647642ms","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-05-09T21:46:06.876767Z","caller":"traceutil/trace.go:171","msg":"trace[1070546525] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1572; }","duration":"106.863517ms","start":"2026-05-09T21:46:06.769885Z","end":"2026-05-09T21:46:06.876749Z","steps":["trace[1070546525] 'agreement among raft nodes before linearized reading' (duration: 106.491508ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:46:06.876179Z","caller":"traceutil/trace.go:171","msg":"trace[1708448653] transaction","detail":"{read_only:false; response_revision:1572; number_of_response:1; }","duration":"151.426553ms","start":"2026-05-09T21:46:06.724724Z","end":"2026-05-09T21:46:06.87615Z","steps":["trace[1708448653] 'process raft request' (duration: 151.239228ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:46:06.876724Z","caller":"traceutil/trace.go:171","msg":"trace[81271023] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1572; }","duration":"110.645436ms","start":"2026-05-09T21:46:06.766061Z","end":"2026-05-09T21:46:06.876706Z","steps":["trace[81271023] 'agreement among raft nodes before linearized reading' (duration: 110.191005ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:46:06.877449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.538173ms","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-05-09T21:46:06.877626Z","caller":"traceutil/trace.go:171","msg":"trace[1655176497] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1572; }","duration":"110.758468ms","start":"2026-05-09T21:46:06.766847Z","end":"2026-05-09T21:46:06.877606Z","steps":["trace[1655176497] 'agreement among raft nodes before linearized reading' (duration: 109.840487ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:46:07.009159Z","caller":"traceutil/trace.go:171","msg":"trace[1471412614] transaction","detail":"{read_only:false; response_revision:1574; number_of_response:1; }","duration":"128.438362ms","start":"2026-05-09T21:46:06.880686Z","end":"2026-05-09T21:46:07.009125Z","steps":["trace[1471412614] 'process raft request' (duration: 127.711235ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:46:07.009236Z","caller":"traceutil/trace.go:171","msg":"trace[1809227178] transaction","detail":"{read_only:false; response_revision:1575; number_of_response:1; }","duration":"127.568152ms","start":"2026-05-09T21:46:06.881634Z","end":"2026-05-09T21:46:07.009203Z","steps":["trace[1809227178] 'process raft request' (duration: 127.356607ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:46:07.00928Z","caller":"traceutil/trace.go:171","msg":"trace[1956147703] transaction","detail":"{read_only:false; response_revision:1576; number_of_response:1; }","duration":"127.532091ms","start":"2026-05-09T21:46:06.88172Z","end":"2026-05-09T21:46:07.009252Z","steps":["trace[1956147703] 'process raft request' (duration: 127.317656ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:46:13.053558Z","caller":"traceutil/trace.go:171","msg":"trace[554206991] transaction","detail":"{read_only:false; response_revision:1600; number_of_response:1; }","duration":"154.248199ms","start":"2026-05-09T21:46:12.899269Z","end":"2026-05-09T21:46:13.053518Z","steps":["trace[554206991] 'process raft request' (duration: 153.962752ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:46:13.245606Z","caller":"traceutil/trace.go:171","msg":"trace[1204486642] transaction","detail":"{read_only:false; response_revision:1602; number_of_response:1; }","duration":"187.851177ms","start":"2026-05-09T21:46:13.057725Z","end":"2026-05-09T21:46:13.245576Z","steps":["trace[1204486642] 'process raft request' (duration: 100.706572ms)","trace[1204486642] 'compare' (duration: 86.964981ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T21:46:13.24586Z","caller":"traceutil/trace.go:171","msg":"trace[324796678] transaction","detail":"{read_only:false; response_revision:1603; number_of_response:1; }","duration":"188.063492ms","start":"2026-05-09T21:46:13.057773Z","end":"2026-05-09T21:46:13.245836Z","steps":["trace[324796678] 'process raft request' (duration: 187.759815ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:46:13.2462Z","caller":"traceutil/trace.go:171","msg":"trace[502864075] transaction","detail":"{read_only:false; response_revision:1604; number_of_response:1; }","duration":"188.019121ms","start":"2026-05-09T21:46:13.058169Z","end":"2026-05-09T21:46:13.246188Z","steps":["trace[502864075] 'process raft request' (duration: 187.585281ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T21:46:31.496562Z","caller":"traceutil/trace.go:171","msg":"trace[1111199188] transaction","detail":"{read_only:false; response_revision:1686; number_of_response:1; }","duration":"165.723929ms","start":"2026-05-09T21:46:31.330812Z","end":"2026-05-09T21:46:31.496536Z","steps":["trace[1111199188] 'process raft request' (duration: 165.578045ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:48:21.798523Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410286198329807,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T21:48:22.298719Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410286198329807,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T21:48:22.799785Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410286198329807,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T21:48:23.334893Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831410286198329807,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T21:48:23.337301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.037107765s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-09T21:48:23.337392Z","caller":"traceutil/trace.go:171","msg":"trace[439147421] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.037641548s","start":"2026-05-09T21:48:21.299734Z","end":"2026-05-09T21:48:23.337376Z","steps":["trace[439147421] 'agreement among raft nodes before linearized reading' (duration: 2.037142516s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:48:23.337454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:48:21.299723Z","time spent":"2.037703369s","remote":"127.0.0.1:49702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/09 21:48:23 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-09T21:48:23.397022Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.098092554s","expected-duration":"1s"} {"level":"info","ts":"2026-05-09T21:48:23.397504Z","caller":"traceutil/trace.go:171","msg":"trace[1126916752] transaction","detail":"{read_only:false; response_revision:2212; number_of_response:1; }","duration":"2.099689815s","start":"2026-05-09T21:48:21.297774Z","end":"2026-05-09T21:48:23.397464Z","steps":["trace[1126916752] 'process raft request' (duration: 2.099438619s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:48:23.397721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:48:21.29773Z","time spent":"2.099869299s","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T21:48:23.40668Z","caller":"traceutil/trace.go:171","msg":"trace[455873067] linearizableReadLoop","detail":"{readStateIndex:2303; appliedIndex:2301; }","duration":"2.108607561s","start":"2026-05-09T21:48:21.298047Z","end":"2026-05-09T21:48:23.406655Z","steps":["trace[455873067] 'read index received' (duration: 2.099252854s)","trace[455873067] 'applied index is now lower than readState.Index' (duration: 9.353127ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T21:48:23.407257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.109229006s","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-05-09T21:48:23.407298Z","caller":"traceutil/trace.go:171","msg":"trace[1312721259] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2214; }","duration":"2.109429971s","start":"2026-05-09T21:48:21.297859Z","end":"2026-05-09T21:48:23.407289Z","steps":["trace[1312721259] 'agreement among raft nodes before linearized reading' (duration: 2.109146184s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:48:23.40733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:48:21.297842Z","time spent":"2.109480592s","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-09T21:48:23.41075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.648002662s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-09T21:48:23.410872Z","caller":"traceutil/trace.go:171","msg":"trace[1510563680] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2214; }","duration":"1.648191767s","start":"2026-05-09T21:48:21.762656Z","end":"2026-05-09T21:48:23.410848Z","steps":["trace[1510563680] 'agreement among raft nodes before linearized reading' (duration: 1.644823256s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:48:23.410931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:48:21.762642Z","time spent":"1.648278159s","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-09T21:48:23.411263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.735086497s","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-05-09T21:48:23.411303Z","caller":"traceutil/trace.go:171","msg":"trace[1720907160] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2214; }","duration":"1.735163049s","start":"2026-05-09T21:48:21.676128Z","end":"2026-05-09T21:48:23.411291Z","steps":["trace[1720907160] 'agreement among raft nodes before linearized reading' (duration: 1.731279624s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:48:23.411328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:48:21.676109Z","time spent":"1.735212489s","remote":"127.0.0.1:49916","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-05-09T21:48:23.41153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.088012584s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T21:48:23.411599Z","caller":"traceutil/trace.go:171","msg":"trace[2105894144] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:2214; }","duration":"1.088107776s","start":"2026-05-09T21:48:22.323477Z","end":"2026-05-09T21:48:23.411584Z","steps":["trace[2105894144] 'agreement among raft nodes before linearized reading' (duration: 1.083975785s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:48:23.411639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:48:22.323449Z","time spent":"1.088180788s","remote":"127.0.0.1:60220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-09T21:48:23.411868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"761.959421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-05-09T21:48:23.411893Z","caller":"traceutil/trace.go:171","msg":"trace[1814714801] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2214; }","duration":"762.018393ms","start":"2026-05-09T21:48:22.649868Z","end":"2026-05-09T21:48:23.411886Z","steps":["trace[1814714801] 'agreement among raft nodes before linearized reading' (duration: 757.568975ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:48:23.411912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:48:22.649846Z","time spent":"762.061593ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-09T21:48:23.411983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.011957147s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-09T21:48:23.412004Z","caller":"traceutil/trace.go:171","msg":"trace[929093913] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:2214; }","duration":"1.011982688s","start":"2026-05-09T21:48:22.400015Z","end":"2026-05-09T21:48:23.411998Z","steps":["trace[929093913] 'agreement among raft nodes before linearized reading' (duration: 1.007428597s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:48:23.412023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:48:22.399974Z","time spent":"1.012043329s","remote":"127.0.0.1:49988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":17,"response size":29,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-05-09T21:48:23.412225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.443614473s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-09T21:48:23.41228Z","caller":"traceutil/trace.go:171","msg":"trace[1486197724] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2214; }","duration":"1.443729155s","start":"2026-05-09T21:48:21.968537Z","end":"2026-05-09T21:48:23.412266Z","steps":["trace[1486197724] 'agreement among raft nodes before linearized reading' (duration: 1.438935468s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:48:23.412456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.346196599s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-09T21:48:23.412526Z","caller":"traceutil/trace.go:171","msg":"trace[503283856] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2214; }","duration":"1.346269391s","start":"2026-05-09T21:48:22.066246Z","end":"2026-05-09T21:48:23.412515Z","steps":["trace[503283856] 'agreement among raft nodes before linearized reading' (duration: 1.341218518s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:48:23.412625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:48:22.066151Z","time spent":"1.346463955s","remote":"127.0.0.1:49916","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-05-09T21:48:23.413997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:48:21.968508Z","time spent":"1.445471648s","remote":"127.0.0.1:49916","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-05-09T21:48:23.414146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.347247884s","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:531"} {"level":"info","ts":"2026-05-09T21:48:23.414286Z","caller":"traceutil/trace.go:171","msg":"trace[1877125075] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2214; }","duration":"1.347443599s","start":"2026-05-09T21:48:22.066832Z","end":"2026-05-09T21:48:23.414276Z","steps":["trace[1877125075] 'agreement among raft nodes before linearized reading' (duration: 1.340626093s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T21:48:23.414308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T21:48:22.066802Z","time spent":"1.34749985s","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":553,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}