{"level":"warn","ts":"2026-03-06T00:54:14.335132Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-06T00:54:14.335274Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.70:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.70:2380","--initial-cluster=instance=https://162.253.55.70:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.70:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.70: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-03-06T00:54:14.335433Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-06T00:54:14.335464Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.70:2380"]}
{"level":"info","ts":"2026-03-06T00:54:14.335579Z","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-03-06T00:54:14.336518Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.70:2379"]}
{"level":"info","ts":"2026-03-06T00:54:14.336843Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.70:2380"],"listen-peer-urls":["https://162.253.55.70:2380"],"advertise-client-urls":["https://162.253.55.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.70: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-03-06T00:54:14.342586Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.473406ms"}
{"level":"info","ts":"2026-03-06T00:54:14.353488Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"23887246632736aa","cluster-id":"62cfeca3ef46d3ef"}
{"level":"info","ts":"2026-03-06T00:54:14.353648Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa switched to configuration voters=()"}
{"level":"info","ts":"2026-03-06T00:54:14.353683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa became follower at term 0"}
{"level":"info","ts":"2026-03-06T00:54:14.353703Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 23887246632736aa [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-06T00:54:14.353713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa became follower at term 1"}
{"level":"info","ts":"2026-03-06T00:54:14.353763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa switched to configuration voters=(2560422034796918442)"}
{"level":"warn","ts":"2026-03-06T00:54:14.363186Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-06T00:54:14.365967Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-06T00:54:14.366975Z","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-03-06T00:54:14.370146Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"23887246632736aa","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-06T00:54:14.371228Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"23887246632736aa","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-06T00:54:14.370359Z","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-03-06T00:54:14.371571Z","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-03-06T00:54:14.371609Z","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-03-06T00:54:14.372225Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa switched to configuration voters=(2560422034796918442)"}
{"level":"info","ts":"2026-03-06T00:54:14.372594Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62cfeca3ef46d3ef","local-member-id":"23887246632736aa","added-peer-id":"23887246632736aa","added-peer-peer-urls":["https://162.253.55.70:2380"]}
{"level":"info","ts":"2026-03-06T00:54:14.375938Z","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-03-06T00:54:14.376171Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.70:2380"}
{"level":"info","ts":"2026-03-06T00:54:14.3763Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"23887246632736aa","initial-advertise-peer-urls":["https://162.253.55.70:2380"],"listen-peer-urls":["https://162.253.55.70:2380"],"advertise-client-urls":["https://162.253.55.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-06T00:54:14.376342Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-06T00:54:14.376254Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.70:2380"}
{"level":"info","ts":"2026-03-06T00:54:14.854687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa is starting a new election at term 1"}
{"level":"info","ts":"2026-03-06T00:54:14.854791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-06T00:54:14.854844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa received MsgPreVoteResp from 23887246632736aa at term 1"}
{"level":"info","ts":"2026-03-06T00:54:14.854932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa became candidate at term 2"}
{"level":"info","ts":"2026-03-06T00:54:14.854954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa received MsgVoteResp from 23887246632736aa at term 2"}
{"level":"info","ts":"2026-03-06T00:54:14.854981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"23887246632736aa became leader at term 2"}
{"level":"info","ts":"2026-03-06T00:54:14.854997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 23887246632736aa elected leader 23887246632736aa at term 2"}
{"level":"info","ts":"2026-03-06T00:54:14.856434Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-06T00:54:14.85841Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62cfeca3ef46d3ef","local-member-id":"23887246632736aa","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-06T00:54:14.858519Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-06T00:54:14.858556Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-06T00:54:14.85867Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-06T00:54:14.85873Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"23887246632736aa","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.70:2379]}","request-path":"/0/members/23887246632736aa/attributes","cluster-id":"62cfeca3ef46d3ef","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-06T00:54:14.858713Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-06T00:54:14.860242Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-06T00:54:14.860318Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-06T00:54:14.865069Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-06T00:54:14.865205Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.70:2379"}
{"level":"warn","ts":"2026-03-06T00:54:19.052479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.688858ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3939133175276524488 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/roles/kube-system/system::leader-locking-kube-scheduler\" mod_revision:0 > success:<request_put:<key:\"/registry/roles/kube-system/system::leader-locking-kube-scheduler\" value_size:573 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-06T00:54:19.05259Z","caller":"traceutil/trace.go:171","msg":"trace[1262497546] linearizableReadLoop","detail":"{readStateIndex:188; appliedIndex:187; }","duration":"724.554872ms","start":"2026-03-06T00:54:18.32802Z","end":"2026-03-06T00:54:19.052575Z","steps":["trace[1262497546] 'read index received'  (duration: 47.244477ms)","trace[1262497546] 'applied index is now lower than readState.Index'  (duration: 677.309225ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T00:54:19.05273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.595171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T00:54:19.052764Z","caller":"traceutil/trace.go:171","msg":"trace[736585984] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:184; }","duration":"610.668862ms","start":"2026-03-06T00:54:18.442086Z","end":"2026-03-06T00:54:19.052755Z","steps":["trace[736585984] 'agreement among raft nodes before linearized reading'  (duration: 610.58382ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:54:19.052797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:54:18.442033Z","time spent":"610.756035ms","remote":"127.0.0.1:33338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-06T00:54:19.052863Z","caller":"traceutil/trace.go:171","msg":"trace[913255546] transaction","detail":"{read_only:false; response_revision:184; number_of_response:1; }","duration":"1.184886056s","start":"2026-03-06T00:54:17.867943Z","end":"2026-03-06T00:54:19.052829Z","steps":["trace[913255546] 'process raft request'  (duration: 507.385247ms)","trace[913255546] 'compare'  (duration: 676.564546ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T00:54:19.052954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:54:17.867932Z","time spent":"1.184979809s","remote":"127.0.0.1:46464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":646,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/roles/kube-system/system::leader-locking-kube-scheduler\" mod_revision:0 > success:<request_put:<key:\"/registry/roles/kube-system/system::leader-locking-kube-scheduler\" value_size:573 >> failure:<>"}
{"level":"warn","ts":"2026-03-06T00:54:19.052759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"724.726075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T00:54:19.053172Z","caller":"traceutil/trace.go:171","msg":"trace[1363747758] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:184; }","duration":"725.218978ms","start":"2026-03-06T00:54:18.327942Z","end":"2026-03-06T00:54:19.053161Z","steps":["trace[1363747758] 'agreement among raft nodes before linearized reading'  (duration: 724.724326ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:54:19.053196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:54:18.327923Z","time spent":"725.266349ms","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-06T00:54:19.558051Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3939133175276524492,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-06T00:54:19.734141Z","caller":"traceutil/trace.go:171","msg":"trace[465561411] linearizableReadLoop","detail":"{readStateIndex:189; appliedIndex:188; }","duration":"676.438361ms","start":"2026-03-06T00:54:19.057678Z","end":"2026-03-06T00:54:19.734116Z","steps":["trace[465561411] 'read index received'  (duration: 648.200917ms)","trace[465561411] 'applied index is now lower than readState.Index'  (duration: 28.236624ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:54:19.734281Z","caller":"traceutil/trace.go:171","msg":"trace[2123893879] transaction","detail":"{read_only:false; response_revision:185; number_of_response:1; }","duration":"677.354254ms","start":"2026-03-06T00:54:19.056829Z","end":"2026-03-06T00:54:19.734183Z","steps":["trace[2123893879] 'process raft request'  (duration: 649.168131ms)","trace[2123893879] 'compare'  (duration: 27.984798ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T00:54:19.734391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.688336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-06T00:54:19.734392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.671858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-public\" ","response":"range_response_count:1 size:351"}
{"level":"warn","ts":"2026-03-06T00:54:19.734439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:54:19.056818Z","time spent":"677.54728ms","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<>"}
{"level":"info","ts":"2026-03-06T00:54:19.734445Z","caller":"traceutil/trace.go:171","msg":"trace[834161164] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:185; }","duration":"495.83243ms","start":"2026-03-06T00:54:19.238602Z","end":"2026-03-06T00:54:19.734434Z","steps":["trace[834161164] 'agreement among raft nodes before linearized reading'  (duration: 495.710558ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:54:19.734486Z","caller":"traceutil/trace.go:171","msg":"trace[1010732251] range","detail":"{range_begin:/registry/namespaces/kube-public; range_end:; response_count:1; response_revision:185; }","duration":"676.805351ms","start":"2026-03-06T00:54:19.057659Z","end":"2026-03-06T00:54:19.734464Z","steps":["trace[1010732251] 'agreement among raft nodes before linearized reading'  (duration: 676.576785ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:54:19.734558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:54:19.23858Z","time spent":"495.969254ms","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-06T00:54:19.734554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:54:19.057652Z","time spent":"676.889183ms","remote":"127.0.0.1:46240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-public\" "}
{"level":"warn","ts":"2026-03-06T00:54:19.734486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.610936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T00:54:19.734753Z","caller":"traceutil/trace.go:171","msg":"trace[397436042] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:185; }","duration":"193.960395ms","start":"2026-03-06T00:54:19.540784Z","end":"2026-03-06T00:54:19.734745Z","steps":["trace[397436042] 'agreement among raft nodes before linearized reading'  (duration: 193.612717ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:54:19.734604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.684836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T00:54:19.735261Z","caller":"traceutil/trace.go:171","msg":"trace[331449771] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:185; }","duration":"216.306802ms","start":"2026-03-06T00:54:19.518889Z","end":"2026-03-06T00:54:19.735196Z","steps":["trace[331449771] 'agreement among raft nodes before linearized reading'  (duration: 215.685777ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:54:47.485425Z","caller":"traceutil/trace.go:171","msg":"trace[1960442098] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"144.561133ms","start":"2026-03-06T00:54:47.34084Z","end":"2026-03-06T00:54:47.485402Z","steps":["trace[1960442098] 'process raft request'  (duration: 144.424269ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:54:53.34964Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3939133175276525187,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-06T00:54:53.474959Z","caller":"traceutil/trace.go:171","msg":"trace[1740038449] linearizableReadLoop","detail":"{readStateIndex:550; appliedIndex:549; }","duration":"626.097882ms","start":"2026-03-06T00:54:52.848838Z","end":"2026-03-06T00:54:53.474936Z","steps":["trace[1740038449] 'read index received'  (duration: 625.715883ms)","trace[1740038449] 'applied index is now lower than readState.Index'  (duration: 381.149µs)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:54:53.475229Z","caller":"traceutil/trace.go:171","msg":"trace[1857654861] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"636.948714ms","start":"2026-03-06T00:54:52.838213Z","end":"2026-03-06T00:54:53.475162Z","steps":["trace[1857654861] 'process raft request'  (duration: 636.432852ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:54:53.475492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.494794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T00:54:53.47555Z","caller":"traceutil/trace.go:171","msg":"trace[171885940] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:530; }","duration":"492.541775ms","start":"2026-03-06T00:54:52.982991Z","end":"2026-03-06T00:54:53.475532Z","steps":["trace[171885940] 'agreement among raft nodes before linearized reading'  (duration: 492.478074ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:54:53.475375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.501814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-03-06T00:54:53.475597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:54:52.982927Z","time spent":"492.663318ms","remote":"127.0.0.1:33328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-06T00:54:53.475668Z","caller":"traceutil/trace.go:171","msg":"trace[943530244] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:530; }","duration":"626.848902ms","start":"2026-03-06T00:54:52.848779Z","end":"2026-03-06T00:54:53.475628Z","steps":["trace[943530244] 'agreement among raft nodes before linearized reading'  (duration: 626.394ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:54:53.475755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:54:52.848758Z","time spent":"626.966314ms","remote":"127.0.0.1:46396","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-03-06T00:54:53.476014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:54:52.838172Z","time spent":"637.301033ms","remote":"127.0.0.1:46298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-4fctx\" mod_revision:503 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-4fctx\" value_size:17081 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-4fctx\" > >"}
{"level":"info","ts":"2026-03-06T00:54:53.76945Z","caller":"traceutil/trace.go:171","msg":"trace[1320100526] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"289.386823ms","start":"2026-03-06T00:54:53.480031Z","end":"2026-03-06T00:54:53.769418Z","steps":["trace[1320100526] 'process raft request'  (duration: 249.129229ms)","trace[1320100526] 'compare'  (duration: 40.14611ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:55:12.719149Z","caller":"traceutil/trace.go:171","msg":"trace[359947329] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"569.954124ms","start":"2026-03-06T00:55:12.149167Z","end":"2026-03-06T00:55:12.719121Z","steps":["trace[359947329] 'process raft request'  (duration: 569.814981ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:55:12.719352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:55:12.149136Z","time spent":"570.149389ms","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:711 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-06T00:55:12.733447Z","caller":"traceutil/trace.go:171","msg":"trace[1578518873] transaction","detail":"{read_only:false; response_revision:716; number_of_response:1; }","duration":"583.392789ms","start":"2026-03-06T00:55:12.150031Z","end":"2026-03-06T00:55:12.733423Z","steps":["trace[1578518873] 'process raft request'  (duration: 583.362848ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:55:12.733517Z","caller":"traceutil/trace.go:171","msg":"trace[915974869] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"584.210109ms","start":"2026-03-06T00:55:12.149285Z","end":"2026-03-06T00:55:12.733495Z","steps":["trace[915974869] 'process raft request'  (duration: 584.017254ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:55:12.733588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:55:12.150019Z","time spent":"583.486362ms","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:709 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-06T00:55:12.733666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:55:12.149269Z","time spent":"584.349953ms","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:710 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-06T00:55:38.806358Z","caller":"traceutil/trace.go:171","msg":"trace[968377375] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"125.998769ms","start":"2026-03-06T00:55:38.680325Z","end":"2026-03-06T00:55:38.806324Z","steps":["trace[968377375] 'process raft request'  (duration: 125.795384ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:55:41.275511Z","caller":"traceutil/trace.go:171","msg":"trace[630423158] linearizableReadLoop","detail":"{readStateIndex:832; appliedIndex:831; }","duration":"235.656845ms","start":"2026-03-06T00:55:41.039831Z","end":"2026-03-06T00:55:41.275488Z","steps":["trace[630423158] 'read index received'  (duration: 235.405369ms)","trace[630423158] 'applied index is now lower than readState.Index'  (duration: 250.326µs)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:55:41.27564Z","caller":"traceutil/trace.go:171","msg":"trace[1500589980] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"305.362469ms","start":"2026-03-06T00:55:40.970266Z","end":"2026-03-06T00:55:41.275629Z","steps":["trace[1500589980] 'process raft request'  (duration: 305.04212ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:55:41.27578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:55:40.970239Z","time spent":"305.43479ms","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:793 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-06T00:55:41.275885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.361885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-06T00:55:41.275976Z","caller":"traceutil/trace.go:171","msg":"trace[1621608463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:799; }","duration":"208.487598ms","start":"2026-03-06T00:55:41.06747Z","end":"2026-03-06T00:55:41.275958Z","steps":["trace[1621608463] 'agreement among raft nodes before linearized reading'  (duration: 208.278133ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:55:41.276212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.938835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-06T00:55:41.276226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.51749ms","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-03-06T00:55:41.276251Z","caller":"traceutil/trace.go:171","msg":"trace[1839054269] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:799; }","duration":"189.000577ms","start":"2026-03-06T00:55:41.087242Z","end":"2026-03-06T00:55:41.276242Z","steps":["trace[1839054269] 'agreement among raft nodes before linearized reading'  (duration: 188.937706ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:55:41.276281Z","caller":"traceutil/trace.go:171","msg":"trace[133474969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:799; }","duration":"154.600342ms","start":"2026-03-06T00:55:41.121665Z","end":"2026-03-06T00:55:41.276266Z","steps":["trace[133474969] 'agreement among raft nodes before linearized reading'  (duration: 154.430538ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:55:41.276519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.677222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T00:55:41.276582Z","caller":"traceutil/trace.go:171","msg":"trace[652819323] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:799; }","duration":"236.777994ms","start":"2026-03-06T00:55:41.039789Z","end":"2026-03-06T00:55:41.276567Z","steps":["trace[652819323] 'agreement among raft nodes before linearized reading'  (duration: 236.671521ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:55:52.116717Z","caller":"traceutil/trace.go:171","msg":"trace[1375503985] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"190.678131ms","start":"2026-03-06T00:55:51.926005Z","end":"2026-03-06T00:55:52.116683Z","steps":["trace[1375503985] 'process raft request'  (duration: 190.442195ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:55:52.230542Z","caller":"traceutil/trace.go:171","msg":"trace[135973579] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"110.941071ms","start":"2026-03-06T00:55:52.11958Z","end":"2026-03-06T00:55:52.230521Z","steps":["trace[135973579] 'process raft request'  (duration: 110.809908ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:55:53.735632Z","caller":"traceutil/trace.go:171","msg":"trace[416443053] linearizableReadLoop","detail":"{readStateIndex:920; appliedIndex:919; }","duration":"268.980893ms","start":"2026-03-06T00:55:53.466626Z","end":"2026-03-06T00:55:53.735607Z","steps":["trace[416443053] 'read index received'  (duration: 268.913331ms)","trace[416443053] 'applied index is now lower than readState.Index'  (duration: 66.312µs)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:55:53.735703Z","caller":"traceutil/trace.go:171","msg":"trace[1751110933] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"353.289399ms","start":"2026-03-06T00:55:53.382372Z","end":"2026-03-06T00:55:53.735661Z","steps":["trace[1751110933] 'process raft request'  (duration: 353.091624ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:55:53.735859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.204718ms","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-03-06T00:55:53.735894Z","caller":"traceutil/trace.go:171","msg":"trace[845166082] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:883; }","duration":"269.293782ms","start":"2026-03-06T00:55:53.46659Z","end":"2026-03-06T00:55:53.735884Z","steps":["trace[845166082] 'agreement among raft nodes before linearized reading'  (duration: 269.141127ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:55:53.735925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:55:53.382352Z","time spent":"353.457923ms","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:878 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-06T00:55:54.023631Z","caller":"traceutil/trace.go:171","msg":"trace[65492261] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"283.362802ms","start":"2026-03-06T00:55:53.740243Z","end":"2026-03-06T00:55:54.023606Z","steps":["trace[65492261] 'process raft request'  (duration: 283.2597ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:55:54.023893Z","caller":"traceutil/trace.go:171","msg":"trace[509021771] linearizableReadLoop","detail":"{readStateIndex:921; appliedIndex:920; }","duration":"288.164057ms","start":"2026-03-06T00:55:53.735713Z","end":"2026-03-06T00:55:54.023877Z","steps":["trace[509021771] 'read index received'  (duration: 287.316205ms)","trace[509021771] 'applied index is now lower than readState.Index'  (duration: 846.822µs)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:55:54.023907Z","caller":"traceutil/trace.go:171","msg":"trace[1487315551] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"301.317094ms","start":"2026-03-06T00:55:53.722543Z","end":"2026-03-06T00:55:54.02386Z","steps":["trace[1487315551] 'process raft request'  (duration: 300.553175ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:55:54.024053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.589684ms","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-03-06T00:55:54.024075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:55:53.722507Z","time spent":"301.484268ms","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:807 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-03-06T00:55:54.024088Z","caller":"traceutil/trace.go:171","msg":"trace[1254113910] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:885; }","duration":"556.657597ms","start":"2026-03-06T00:55:53.467421Z","end":"2026-03-06T00:55:54.024078Z","steps":["trace[1254113910] 'agreement among raft nodes before linearized reading'  (duration: 556.499833ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:55:54.02412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:55:53.467413Z","time spent":"556.699527ms","remote":"127.0.0.1:46396","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-03-06T00:56:12.209993Z","caller":"traceutil/trace.go:171","msg":"trace[1179089825] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"296.871609ms","start":"2026-03-06T00:56:11.913083Z","end":"2026-03-06T00:56:12.209955Z","steps":["trace[1179089825] 'process raft request'  (duration: 296.647434ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:12.576593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.423451ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3939133175276526164 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:950 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-06T00:56:12.576851Z","caller":"traceutil/trace.go:171","msg":"trace[558010395] linearizableReadLoop","detail":"{readStateIndex:1004; appliedIndex:1002; }","duration":"297.917587ms","start":"2026-03-06T00:56:12.278909Z","end":"2026-03-06T00:56:12.576827Z","steps":["trace[558010395] 'read index received'  (duration: 167.150846ms)","trace[558010395] 'applied index is now lower than readState.Index'  (duration: 130.765281ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:56:12.576991Z","caller":"traceutil/trace.go:171","msg":"trace[108692452] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"360.27314ms","start":"2026-03-06T00:56:12.216711Z","end":"2026-03-06T00:56:12.576984Z","steps":["trace[108692452] 'process raft request'  (duration: 360.026053ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:12.577087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:56:12.216698Z","time spent":"360.32035ms","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:951 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-06T00:56:12.577178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.260585ms","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-03-06T00:56:12.57693Z","caller":"traceutil/trace.go:171","msg":"trace[1993221837] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"360.898516ms","start":"2026-03-06T00:56:12.216007Z","end":"2026-03-06T00:56:12.576906Z","steps":["trace[1993221837] 'process raft request'  (duration: 230.054893ms)","trace[1993221837] 'compare'  (duration: 130.293778ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:56:12.577249Z","caller":"traceutil/trace.go:171","msg":"trace[1799843968] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:963; }","duration":"298.383298ms","start":"2026-03-06T00:56:12.278849Z","end":"2026-03-06T00:56:12.577232Z","steps":["trace[1799843968] 'agreement among raft nodes before linearized reading'  (duration: 298.187243ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:12.577271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:56:12.215987Z","time spent":"361.267574ms","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:950 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-06T00:56:12.577938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.572051ms","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-03-06T00:56:12.578051Z","caller":"traceutil/trace.go:171","msg":"trace[460728137] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:963; }","duration":"215.746825ms","start":"2026-03-06T00:56:12.362279Z","end":"2026-03-06T00:56:12.578026Z","steps":["trace[460728137] 'agreement among raft nodes before linearized reading'  (duration: 215.438477ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:56:12.778484Z","caller":"traceutil/trace.go:171","msg":"trace[2110291263] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"195.013583ms","start":"2026-03-06T00:56:12.583441Z","end":"2026-03-06T00:56:12.778454Z","steps":["trace[2110291263] 'process raft request'  (duration: 178.565639ms)","trace[2110291263] 'compare'  (duration: 16.125915ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:56:14.404771Z","caller":"traceutil/trace.go:171","msg":"trace[1615394318] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"186.155023ms","start":"2026-03-06T00:56:14.218589Z","end":"2026-03-06T00:56:14.404744Z","steps":["trace[1615394318] 'process raft request'  (duration: 185.979279ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:14.702219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.040794ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3939133175276526176 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:912 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-06T00:56:14.702583Z","caller":"traceutil/trace.go:171","msg":"trace[40248962] linearizableReadLoop","detail":"{readStateIndex:1009; appliedIndex:1008; }","duration":"121.257826ms","start":"2026-03-06T00:56:14.581249Z","end":"2026-03-06T00:56:14.702507Z","steps":["trace[40248962] 'read index received'  (duration: 28.02µs)","trace[40248962] 'applied index is now lower than readState.Index'  (duration: 121.224326ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:56:14.702711Z","caller":"traceutil/trace.go:171","msg":"trace[1353106048] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"350.186989ms","start":"2026-03-06T00:56:14.352508Z","end":"2026-03-06T00:56:14.702695Z","steps":["trace[1353106048] 'process raft request'  (duration: 122.56772ms)","trace[1353106048] 'compare'  (duration: 226.927342ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T00:56:14.702879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:56:14.352477Z","time spent":"350.317043ms","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:912 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-06T00:56:14.70301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.755259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-06T00:56:14.703041Z","caller":"traceutil/trace.go:171","msg":"trace[1976370453] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:968; }","duration":"121.813391ms","start":"2026-03-06T00:56:14.58122Z","end":"2026-03-06T00:56:14.703033Z","steps":["trace[1976370453] 'agreement among raft nodes before linearized reading'  (duration: 121.710037ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:14.703072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.713408ms","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-03-06T00:56:14.703141Z","caller":"traceutil/trace.go:171","msg":"trace[1211339174] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:968; }","duration":"121.834921ms","start":"2026-03-06T00:56:14.581292Z","end":"2026-03-06T00:56:14.703127Z","steps":["trace[1211339174] 'agreement among raft nodes before linearized reading'  (duration: 121.636335ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:15.269144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.571114ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3939133175276526179 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:964 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-06T00:56:15.269243Z","caller":"traceutil/trace.go:171","msg":"trace[228468054] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"562.66642ms","start":"2026-03-06T00:56:14.706558Z","end":"2026-03-06T00:56:15.269224Z","steps":["trace[228468054] 'process raft request'  (duration: 254.947272ms)","trace[228468054] 'compare'  (duration: 307.483832ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T00:56:15.269289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:56:14.706538Z","time spent":"562.730381ms","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:964 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-06T00:56:15.808158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.063195ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3939133175276526180 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:962 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-06T00:56:15.808404Z","caller":"traceutil/trace.go:171","msg":"trace[1793204748] linearizableReadLoop","detail":"{readStateIndex:1012; appliedIndex:1009; }","duration":"1.025933336s","start":"2026-03-06T00:56:14.78245Z","end":"2026-03-06T00:56:15.808383Z","steps":["trace[1793204748] 'read index received'  (duration: 179.040522ms)","trace[1793204748] 'applied index is now lower than readState.Index'  (duration: 846.891254ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:56:15.808464Z","caller":"traceutil/trace.go:171","msg":"trace[1922369152] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"1.101168048s","start":"2026-03-06T00:56:14.707271Z","end":"2026-03-06T00:56:15.808439Z","steps":["trace[1922369152] 'process raft request'  (duration: 831.668443ms)","trace[1922369152] 'compare'  (duration: 268.904141ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:56:15.808519Z","caller":"traceutil/trace.go:171","msg":"trace[2016007300] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"1.101152449s","start":"2026-03-06T00:56:14.707354Z","end":"2026-03-06T00:56:15.808506Z","steps":["trace[2016007300] 'process raft request'  (duration: 1.100934323s)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:15.808605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:56:14.70725Z","time spent":"1.101282213s","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:962 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-06T00:56:15.808598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:56:14.707338Z","time spent":"1.101217101s","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:963 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-06T00:56:15.899885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.117400287s","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-03-06T00:56:15.900051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.226031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"}
{"level":"info","ts":"2026-03-06T00:56:15.900054Z","caller":"traceutil/trace.go:171","msg":"trace[539051577] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:971; }","duration":"1.117609222s","start":"2026-03-06T00:56:14.782406Z","end":"2026-03-06T00:56:15.900015Z","steps":["trace[539051577] 'agreement among raft nodes before linearized reading'  (duration: 1.026440809s)","trace[539051577] 'range keys from in-memory index tree'  (duration: 90.862226ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T00:56:15.899911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"918.240078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T00:56:15.900146Z","caller":"traceutil/trace.go:171","msg":"trace[1700565623] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:972; }","duration":"918.544176ms","start":"2026-03-06T00:56:14.981595Z","end":"2026-03-06T00:56:15.900139Z","steps":["trace[1700565623] 'agreement among raft nodes before linearized reading'  (duration: 918.218108ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:15.900173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:56:14.981571Z","time spent":"918.594849ms","remote":"127.0.0.1:33328","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-03-06T00:56:15.900172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:56:14.782381Z","time spent":"1.117773506s","remote":"127.0.0.1:46396","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-03-06T00:56:15.900095Z","caller":"traceutil/trace.go:171","msg":"trace[1454466405] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:972; }","duration":"522.296883ms","start":"2026-03-06T00:56:15.377782Z","end":"2026-03-06T00:56:15.900079Z","steps":["trace[1454466405] 'agreement among raft nodes before linearized reading'  (duration: 522.17545ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:15.900383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:56:15.377762Z","time spent":"522.515639ms","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"info","ts":"2026-03-06T00:56:16.01156Z","caller":"traceutil/trace.go:171","msg":"trace[891166789] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"104.449795ms","start":"2026-03-06T00:56:15.907089Z","end":"2026-03-06T00:56:16.011539Z","steps":["trace[891166789] 'process raft request'  (duration: 104.208648ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:56:16.011714Z","caller":"traceutil/trace.go:171","msg":"trace[370701944] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"105.340088ms","start":"2026-03-06T00:56:15.906366Z","end":"2026-03-06T00:56:16.011706Z","steps":["trace[370701944] 'process raft request'  (duration: 104.837215ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:16.217555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.346929ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3939133175276526194 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/external-resizer-rbd-csi-ceph-com.189a1a884bd5d4cd\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/external-resizer-rbd-csi-ceph-com.189a1a884bd5d4cd\" value_size:771 lease:3939133175276525914 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-06T00:56:16.217742Z","caller":"traceutil/trace.go:171","msg":"trace[279257270] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"134.179018ms","start":"2026-03-06T00:56:16.083548Z","end":"2026-03-06T00:56:16.217727Z","steps":["trace[279257270] 'process raft request'  (duration: 134.147988ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:56:16.217904Z","caller":"traceutil/trace.go:171","msg":"trace[274636724] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"197.987738ms","start":"2026-03-06T00:56:16.01991Z","end":"2026-03-06T00:56:16.217898Z","steps":["trace[274636724] 'process raft request'  (duration: 76.243729ms)","trace[274636724] 'compare'  (duration: 121.241026ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:56:16.218074Z","caller":"traceutil/trace.go:171","msg":"trace[1353388325] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"195.905995ms","start":"2026-03-06T00:56:16.022162Z","end":"2026-03-06T00:56:16.218068Z","steps":["trace[1353388325] 'process raft request'  (duration: 195.486873ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:16.938815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.412492ms","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-03-06T00:56:16.938912Z","caller":"traceutil/trace.go:171","msg":"trace[1899984713] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:979; }","duration":"530.561445ms","start":"2026-03-06T00:56:16.40833Z","end":"2026-03-06T00:56:16.938891Z","steps":["trace[1899984713] 'range keys from in-memory index tree'  (duration: 530.218427ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:16.93897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:56:16.408309Z","time spent":"530.649268ms","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-06T00:56:17.051459Z","caller":"traceutil/trace.go:171","msg":"trace[2134974268] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"108.114588ms","start":"2026-03-06T00:56:16.943324Z","end":"2026-03-06T00:56:17.051439Z","steps":["trace[2134974268] 'process raft request'  (duration: 107.960164ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:17.67555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.448824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T00:56:17.675713Z","caller":"traceutil/trace.go:171","msg":"trace[788467291] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:981; }","duration":"190.697441ms","start":"2026-03-06T00:56:17.484998Z","end":"2026-03-06T00:56:17.675696Z","steps":["trace[788467291] 'count revisions from in-memory index tree'  (duration: 190.120857ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:56:20.445071Z","caller":"traceutil/trace.go:171","msg":"trace[922348673] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"128.953904ms","start":"2026-03-06T00:56:20.316081Z","end":"2026-03-06T00:56:20.445035Z","steps":["trace[922348673] 'process raft request'  (duration: 58.232887ms)","trace[922348673] 'compare'  (duration: 70.190394ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T00:56:21.193626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.118257ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3939133175276526262 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:975 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:405 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-06T00:56:21.19374Z","caller":"traceutil/trace.go:171","msg":"trace[45763656] linearizableReadLoop","detail":"{readStateIndex:1056; appliedIndex:1055; }","duration":"125.171397ms","start":"2026-03-06T00:56:21.068554Z","end":"2026-03-06T00:56:21.193725Z","steps":["trace[45763656] 'read index received'  (duration: 27.311µs)","trace[45763656] 'applied index is now lower than readState.Index'  (duration: 125.142766ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:56:21.193843Z","caller":"traceutil/trace.go:171","msg":"trace[1160464899] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"174.216867ms","start":"2026-03-06T00:56:21.019613Z","end":"2026-03-06T00:56:21.19383Z","steps":["trace[1160464899] 'process raft request'  (duration: 44.818442ms)","trace[1160464899] 'compare'  (duration: 128.997595ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T00:56:21.194245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.675929ms","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-03-06T00:56:21.194303Z","caller":"traceutil/trace.go:171","msg":"trace[1734598812] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1013; }","duration":"125.772812ms","start":"2026-03-06T00:56:21.068516Z","end":"2026-03-06T00:56:21.194288Z","steps":["trace[1734598812] 'agreement among raft nodes before linearized reading'  (duration: 125.568366ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:56:21.308057Z","caller":"traceutil/trace.go:171","msg":"trace[679072126] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"110.373267ms","start":"2026-03-06T00:56:21.197657Z","end":"2026-03-06T00:56:21.30803Z","steps":["trace[679072126] 'process raft request'  (duration: 106.497147ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:56:21.334642Z","caller":"traceutil/trace.go:171","msg":"trace[237119650] linearizableReadLoop","detail":"{readStateIndex:1058; appliedIndex:1056; }","duration":"112.204723ms","start":"2026-03-06T00:56:21.22237Z","end":"2026-03-06T00:56:21.334575Z","steps":["trace[237119650] 'read index received'  (duration: 81.798461ms)","trace[237119650] 'applied index is now lower than readState.Index'  (duration: 30.405352ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:56:21.334635Z","caller":"traceutil/trace.go:171","msg":"trace[1447488699] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"126.499681ms","start":"2026-03-06T00:56:21.208114Z","end":"2026-03-06T00:56:21.334614Z","steps":["trace[1447488699] 'process raft request'  (duration: 126.360558ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:21.33511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.678766ms","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:508"}
{"level":"info","ts":"2026-03-06T00:56:21.335222Z","caller":"traceutil/trace.go:171","msg":"trace[1292173925] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1015; }","duration":"112.872051ms","start":"2026-03-06T00:56:21.222332Z","end":"2026-03-06T00:56:21.335204Z","steps":["trace[1292173925] 'agreement among raft nodes before linearized reading'  (duration: 112.395808ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:24.544683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.595046ms","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-03-06T00:56:24.54477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.123941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-06T00:56:24.544872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.037336ms","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-03-06T00:56:24.5449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.827422ms","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-03-06T00:56:24.544933Z","caller":"traceutil/trace.go:171","msg":"trace[279037917] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1028; }","duration":"639.891946ms","start":"2026-03-06T00:56:23.905029Z","end":"2026-03-06T00:56:24.544921Z","steps":["trace[279037917] 'range keys from in-memory index tree'  (duration: 639.7204ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:56:24.54496Z","caller":"traceutil/trace.go:171","msg":"trace[1655274233] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1028; }","duration":"501.130419ms","start":"2026-03-06T00:56:24.04379Z","end":"2026-03-06T00:56:24.54492Z","steps":["trace[1655274233] 'range keys from in-memory index tree'  (duration: 500.78063ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:24.545001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:56:24.043771Z","time spent":"501.220862ms","remote":"127.0.0.1:46396","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":"warn","ts":"2026-03-06T00:56:24.545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:56:23.905012Z","time spent":"639.972638ms","remote":"127.0.0.1:46396","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":"info","ts":"2026-03-06T00:56:24.544873Z","caller":"traceutil/trace.go:171","msg":"trace[600143267] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1028; }","duration":"561.288704ms","start":"2026-03-06T00:56:23.983551Z","end":"2026-03-06T00:56:24.54484Z","steps":["trace[600143267] 'range keys from in-memory index tree'  (duration: 561.052189ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:24.546003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:56:23.983535Z","time spent":"562.431844ms","remote":"127.0.0.1:33338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-06T00:56:24.544807Z","caller":"traceutil/trace.go:171","msg":"trace[970838172] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1028; }","duration":"639.748921ms","start":"2026-03-06T00:56:23.905029Z","end":"2026-03-06T00:56:24.544778Z","steps":["trace[970838172] 'range keys from in-memory index tree'  (duration: 639.424173ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:24.546287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:56:23.905012Z","time spent":"641.258841ms","remote":"127.0.0.1:46396","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-03-06T00:56:24.845115Z","caller":"traceutil/trace.go:171","msg":"trace[1259064803] linearizableReadLoop","detail":"{readStateIndex:1072; appliedIndex:1071; }","duration":"297.034514ms","start":"2026-03-06T00:56:24.548061Z","end":"2026-03-06T00:56:24.845096Z","steps":["trace[1259064803] 'read index received'  (duration: 296.860109ms)","trace[1259064803] 'applied index is now lower than readState.Index'  (duration: 173.585µs)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:56:24.845156Z","caller":"traceutil/trace.go:171","msg":"trace[609546776] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"795.34294ms","start":"2026-03-06T00:56:24.049783Z","end":"2026-03-06T00:56:24.845125Z","steps":["trace[609546776] 'process raft request'  (duration: 795.016742ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:24.845204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.126086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T00:56:24.845227Z","caller":"traceutil/trace.go:171","msg":"trace[1876617446] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1029; }","duration":"297.191308ms","start":"2026-03-06T00:56:24.548028Z","end":"2026-03-06T00:56:24.845219Z","steps":["trace[1876617446] 'agreement among raft nodes before linearized reading'  (duration: 297.135736ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:24.845268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:56:24.049764Z","time spent":"795.442362ms","remote":"127.0.0.1:46296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6610,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:947 > success:<request_put:<key:\"/registry/minions/instance\" value_size:6576 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-03-06T00:56:24.853282Z","caller":"traceutil/trace.go:171","msg":"trace[1620160447] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"300.603265ms","start":"2026-03-06T00:56:24.552653Z","end":"2026-03-06T00:56:24.853257Z","steps":["trace[1620160447] 'process raft request'  (duration: 292.835425ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:24.853388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:56:24.55264Z","time spent":"300.694798ms","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1024 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-06T00:56:24.85374Z","caller":"traceutil/trace.go:171","msg":"trace[1963331982] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"300.875502ms","start":"2026-03-06T00:56:24.552856Z","end":"2026-03-06T00:56:24.853731Z","steps":["trace[1963331982] 'process raft request'  (duration: 300.152594ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:24.853787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:56:24.552842Z","time spent":"300.922304ms","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1023 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-06T00:56:24.854055Z","caller":"traceutil/trace.go:171","msg":"trace[1315317976] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"300.959715ms","start":"2026-03-06T00:56:24.553088Z","end":"2026-03-06T00:56:24.854048Z","steps":["trace[1315317976] 'process raft request'  (duration: 300.136304ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:56:24.854114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:56:24.553063Z","time spent":"301.016856ms","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1022 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-06T00:56:29.592532Z","caller":"traceutil/trace.go:171","msg":"trace[1194774603] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"213.787744ms","start":"2026-03-06T00:56:29.378722Z","end":"2026-03-06T00:56:29.59251Z","steps":["trace[1194774603] 'process raft request'  (duration: 213.408225ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:56:35.674914Z","caller":"traceutil/trace.go:171","msg":"trace[1244107586] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"103.256433ms","start":"2026-03-06T00:56:35.571625Z","end":"2026-03-06T00:56:35.674881Z","steps":["trace[1244107586] 'process raft request'  (duration: 103.085409ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:56:49.6267Z","caller":"traceutil/trace.go:171","msg":"trace[2058709383] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"197.634108ms","start":"2026-03-06T00:56:49.429042Z","end":"2026-03-06T00:56:49.626676Z","steps":["trace[2058709383] 'process raft request'  (duration: 197.490883ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:57:46.01928Z","caller":"traceutil/trace.go:171","msg":"trace[554043496] linearizableReadLoop","detail":"{readStateIndex:1422; appliedIndex:1421; }","duration":"100.370646ms","start":"2026-03-06T00:57:45.918884Z","end":"2026-03-06T00:57:46.019254Z","steps":["trace[554043496] 'read index received'  (duration: 100.179781ms)","trace[554043496] 'applied index is now lower than readState.Index'  (duration: 189.835µs)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:57:46.019327Z","caller":"traceutil/trace.go:171","msg":"trace[730468926] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"191.426094ms","start":"2026-03-06T00:57:45.827871Z","end":"2026-03-06T00:57:46.019297Z","steps":["trace[730468926] 'process raft request'  (duration: 191.230849ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:57:46.019712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.795726ms","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-03-06T00:57:46.019863Z","caller":"traceutil/trace.go:171","msg":"trace[223560126] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1362; }","duration":"101.016221ms","start":"2026-03-06T00:57:45.91883Z","end":"2026-03-06T00:57:46.019846Z","steps":["trace[223560126] 'agreement among raft nodes before linearized reading'  (duration: 100.642543ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:58:21.972763Z","caller":"traceutil/trace.go:171","msg":"trace[2001898584] transaction","detail":"{read_only:false; response_revision:1511; number_of_response:1; }","duration":"124.271745ms","start":"2026-03-06T00:58:21.848459Z","end":"2026-03-06T00:58:21.972731Z","steps":["trace[2001898584] 'process raft request'  (duration: 50.178248ms)","trace[2001898584] 'compare'  (duration: 73.776238ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:58:26.013772Z","caller":"traceutil/trace.go:171","msg":"trace[1420581645] transaction","detail":"{read_only:false; response_revision:1524; number_of_response:1; }","duration":"106.770459ms","start":"2026-03-06T00:58:25.906961Z","end":"2026-03-06T00:58:26.013731Z","steps":["trace[1420581645] 'process raft request'  (duration: 105.672291ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:58:38.246127Z","caller":"traceutil/trace.go:171","msg":"trace[1732742165] linearizableReadLoop","detail":"{readStateIndex:1645; appliedIndex:1644; }","duration":"140.039595ms","start":"2026-03-06T00:58:38.106067Z","end":"2026-03-06T00:58:38.246107Z","steps":["trace[1732742165] 'read index received'  (duration: 139.8448ms)","trace[1732742165] 'applied index is now lower than readState.Index'  (duration: 193.665µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T00:58:38.246278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.192459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-06T00:58:38.246307Z","caller":"traceutil/trace.go:171","msg":"trace[1253791601] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1575; }","duration":"103.23733ms","start":"2026-03-06T00:58:38.143059Z","end":"2026-03-06T00:58:38.246297Z","steps":["trace[1253791601] 'agreement among raft nodes before linearized reading'  (duration: 103.172408ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:58:38.246223Z","caller":"traceutil/trace.go:171","msg":"trace[1186990867] transaction","detail":"{read_only:false; response_revision:1575; number_of_response:1; }","duration":"144.086328ms","start":"2026-03-06T00:58:38.1021Z","end":"2026-03-06T00:58:38.246186Z","steps":["trace[1186990867] 'process raft request'  (duration: 143.888313ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:58:38.246396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.296573ms","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-03-06T00:58:38.246943Z","caller":"traceutil/trace.go:171","msg":"trace[1266683994] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1575; }","duration":"140.872108ms","start":"2026-03-06T00:58:38.10605Z","end":"2026-03-06T00:58:38.246922Z","steps":["trace[1266683994] 'agreement among raft nodes before linearized reading'  (duration: 140.18044ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:58:51.758298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.017294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:6 size:363686"}
{"level":"info","ts":"2026-03-06T00:58:51.758391Z","caller":"traceutil/trace.go:171","msg":"trace[825598551] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:6; response_revision:1629; }","duration":"118.150837ms","start":"2026-03-06T00:58:51.640215Z","end":"2026-03-06T00:58:51.758366Z","steps":["trace[825598551] 'range keys from in-memory index tree'  (duration: 117.359996ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:59:02.7146Z","caller":"traceutil/trace.go:171","msg":"trace[512075610] transaction","detail":"{read_only:false; response_revision:1677; number_of_response:1; }","duration":"107.533547ms","start":"2026-03-06T00:59:02.607031Z","end":"2026-03-06T00:59:02.714564Z","steps":["trace[512075610] 'process raft request'  (duration: 35.128996ms)","trace[512075610] 'compare'  (duration: 72.218545ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:59:04.068678Z","caller":"traceutil/trace.go:171","msg":"trace[2126368204] transaction","detail":"{read_only:false; response_revision:1679; number_of_response:1; }","duration":"161.053079ms","start":"2026-03-06T00:59:03.907584Z","end":"2026-03-06T00:59:04.068637Z","steps":["trace[2126368204] 'process raft request'  (duration: 160.73937ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:59:38.477175Z","caller":"traceutil/trace.go:171","msg":"trace[1462334861] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"102.799362ms","start":"2026-03-06T00:59:38.374318Z","end":"2026-03-06T00:59:38.477117Z","steps":["trace[1462334861] 'process raft request'  (duration: 11.825092ms)","trace[1462334861] 'compare'  (duration: 90.574859ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:59:39.01295Z","caller":"traceutil/trace.go:171","msg":"trace[406246566] linearizableReadLoop","detail":"{readStateIndex:1935; appliedIndex:1934; }","duration":"184.106957ms","start":"2026-03-06T00:59:38.828815Z","end":"2026-03-06T00:59:39.012922Z","steps":["trace[406246566] 'read index received'  (duration: 177.483562ms)","trace[406246566] 'applied index is now lower than readState.Index'  (duration: 6.622264ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T00:59:39.013161Z","caller":"traceutil/trace.go:171","msg":"trace[138177069] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"290.412561ms","start":"2026-03-06T00:59:38.722737Z","end":"2026-03-06T00:59:39.01315Z","steps":["trace[138177069] 'process raft request'  (duration: 283.54993ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:59:39.013411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.58822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-03-06T00:59:39.013474Z","caller":"traceutil/trace.go:171","msg":"trace[699190231] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1852; }","duration":"184.715473ms","start":"2026-03-06T00:59:38.828741Z","end":"2026-03-06T00:59:39.013457Z","steps":["trace[699190231] 'agreement among raft nodes before linearized reading'  (duration: 184.436166ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T00:59:39.017701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.192901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-03-06T00:59:39.017736Z","caller":"traceutil/trace.go:171","msg":"trace[1979362227] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1853; }","duration":"142.273763ms","start":"2026-03-06T00:59:38.875452Z","end":"2026-03-06T00:59:39.017726Z","steps":["trace[1979362227] 'agreement among raft nodes before linearized reading'  (duration: 142.170131ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T00:59:39.017741Z","caller":"traceutil/trace.go:171","msg":"trace[2133340077] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"186.933501ms","start":"2026-03-06T00:59:38.830752Z","end":"2026-03-06T00:59:39.017686Z","steps":["trace[2133340077] 'process raft request'  (duration: 186.814178ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T01:00:02.059183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.769039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system::leader-locking-kube-controller-manager\" ","response":"range_response_count:1 size:688"}
{"level":"warn","ts":"2026-03-06T01:00:02.059239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.408298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system::leader-locking-kube-scheduler\" ","response":"range_response_count:1 size:661"}
{"level":"info","ts":"2026-03-06T01:00:02.059372Z","caller":"traceutil/trace.go:171","msg":"trace[1809905868] range","detail":"{range_begin:/registry/roles/kube-system/system::leader-locking-kube-scheduler; range_end:; response_count:1; response_revision:1956; }","duration":"119.584873ms","start":"2026-03-06T01:00:01.939761Z","end":"2026-03-06T01:00:02.059346Z","steps":["trace[1809905868] 'range keys from in-memory index tree'  (duration: 119.313626ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T01:00:02.059292Z","caller":"traceutil/trace.go:171","msg":"trace[135741374] range","detail":"{range_begin:/registry/roles/kube-system/system::leader-locking-kube-controller-manager; range_end:; response_count:1; response_revision:1956; }","duration":"128.919083ms","start":"2026-03-06T01:00:01.930343Z","end":"2026-03-06T01:00:02.059262Z","steps":["trace[135741374] 'range keys from in-memory index tree'  (duration: 128.675697ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T01:00:12.110589Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3939133175276529818,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-06T01:00:12.610971Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3939133175276529818,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-06T01:00:13.111324Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3939133175276529818,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-06T01:00:14.371191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.260428172s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-03-06T01:00:14.371357Z","caller":"traceutil/trace.go:171","msg":"trace[408823442] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.260632998s","start":"2026-03-06T01:00:12.1107Z","end":"2026-03-06T01:00:14.371333Z","steps":["trace[408823442] 'agreement among raft nodes before linearized reading'  (duration: 2.260443013s)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T01:00:14.371462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:00:12.110686Z","time spent":"2.260744391s","remote":"127.0.0.1:33338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/03/06 01:00:14 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-06T01:00:14.371649Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3939133175276529818,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-06T01:00:14.436499Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.277412807s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-06T01:00:14.436934Z","caller":"traceutil/trace.go:171","msg":"trace[14697844] linearizableReadLoop","detail":"{readStateIndex:2082; appliedIndex:2081; }","duration":"3.270087039s","start":"2026-03-06T01:00:11.166817Z","end":"2026-03-06T01:00:14.436904Z","steps":["trace[14697844] 'read index received'  (duration: 3.269901574s)","trace[14697844] 'applied index is now lower than readState.Index'  (duration: 184.055µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T01:00:14.437213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.270367116s","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-03-06T01:00:14.437186Z","caller":"traceutil/trace.go:171","msg":"trace[1129046768] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"3.278249948s","start":"2026-03-06T01:00:11.158883Z","end":"2026-03-06T01:00:14.437133Z","steps":["trace[1129046768] 'process raft request'  (duration: 3.277847008s)"],"step_count":1}
{"level":"info","ts":"2026-03-06T01:00:14.437274Z","caller":"traceutil/trace.go:171","msg":"trace[269370315] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1992; }","duration":"3.270468249s","start":"2026-03-06T01:00:11.166793Z","end":"2026-03-06T01:00:14.437261Z","steps":["trace[269370315] 'agreement among raft nodes before linearized reading'  (duration: 3.270262663s)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T01:00:14.437321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:00:11.166782Z","time spent":"3.270529761s","remote":"127.0.0.1:46396","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\" "}
{"level":"warn","ts":"2026-03-06T01:00:14.437427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:00:11.158849Z","time spent":"3.278449913s","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1983 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-06T01:00:14.448146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.260835791s","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-03-06T01:00:14.448225Z","caller":"traceutil/trace.go:171","msg":"trace[1016162813] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1993; }","duration":"3.260965785s","start":"2026-03-06T01:00:11.187243Z","end":"2026-03-06T01:00:14.448208Z","steps":["trace[1016162813] 'agreement among raft nodes before linearized reading'  (duration: 3.260762s)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T01:00:14.448231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.332856269s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"}
{"level":"info","ts":"2026-03-06T01:00:14.448268Z","caller":"traceutil/trace.go:171","msg":"trace[1082553097] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1993; }","duration":"2.332919429s","start":"2026-03-06T01:00:12.115339Z","end":"2026-03-06T01:00:14.448258Z","steps":["trace[1082553097] 'agreement among raft nodes before linearized reading'  (duration: 2.332820017s)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T01:00:14.448308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:00:12.115323Z","time spent":"2.332978733s","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-03-06T01:00:14.448356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.337121079s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"}
{"level":"warn","ts":"2026-03-06T01:00:14.44835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.528757506s","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":"warn","ts":"2026-03-06T01:00:14.448419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.840562675s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-03-06T01:00:14.448265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:00:11.187226Z","time spent":"3.261029847s","remote":"127.0.0.1:46396","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":"info","ts":"2026-03-06T01:00:14.44839Z","caller":"traceutil/trace.go:171","msg":"trace[832708780] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1993; }","duration":"2.337419195s","start":"2026-03-06T01:00:12.110958Z","end":"2026-03-06T01:00:14.448377Z","steps":["trace[832708780] 'agreement among raft nodes before linearized reading'  (duration: 2.337339733s)"],"step_count":1}
{"level":"info","ts":"2026-03-06T01:00:14.448462Z","caller":"traceutil/trace.go:171","msg":"trace[660569817] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1993; }","duration":"1.840647607s","start":"2026-03-06T01:00:12.607803Z","end":"2026-03-06T01:00:14.44845Z","steps":["trace[660569817] 'agreement among raft nodes before linearized reading'  (duration: 1.840491583s)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T01:00:14.44849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:00:12.607785Z","time spent":"1.840700178s","remote":"127.0.0.1:46396","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-03-06T01:00:14.4485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:00:12.110954Z","time spent":"2.337537069s","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":548,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "}
{"level":"info","ts":"2026-03-06T01:00:14.448446Z","caller":"traceutil/trace.go:171","msg":"trace[1790796451] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1993; }","duration":"1.528926271s","start":"2026-03-06T01:00:12.919498Z","end":"2026-03-06T01:00:14.448425Z","steps":["trace[1790796451] 'agreement among raft nodes before linearized reading'  (duration: 1.528619222s)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T01:00:14.448541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:00:12.919478Z","time spent":"1.529053554s","remote":"127.0.0.1:46396","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-03-06T01:00:14.448577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.949678001s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-03-06T01:00:14.448596Z","caller":"traceutil/trace.go:171","msg":"trace[503406463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1993; }","duration":"1.949739303s","start":"2026-03-06T01:00:12.498851Z","end":"2026-03-06T01:00:14.44859Z","steps":["trace[503406463] 'agreement among raft nodes before linearized reading'  (duration: 1.949449085s)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T01:00:14.448598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.337653852s","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-03-06T01:00:14.448615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:00:12.498828Z","time spent":"1.949782873s","remote":"127.0.0.1:46396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-06T01:00:14.448634Z","caller":"traceutil/trace.go:171","msg":"trace[346490481] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1993; }","duration":"2.337713733s","start":"2026-03-06T01:00:12.110909Z","end":"2026-03-06T01:00:14.448623Z","steps":["trace[346490481] 'agreement among raft nodes before linearized reading'  (duration: 2.337500248s)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T01:00:14.44866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:00:12.110898Z","time spent":"2.337757334s","remote":"127.0.0.1:46396","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-03-06T01:00:14.448697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"933.174138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4fctx\" ","response":"range_response_count:1 size:18521"}
{"level":"info","ts":"2026-03-06T01:00:14.448726Z","caller":"traceutil/trace.go:171","msg":"trace[961030697] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4fctx; range_end:; response_count:1; response_revision:1993; }","duration":"933.25003ms","start":"2026-03-06T01:00:13.515466Z","end":"2026-03-06T01:00:14.448716Z","steps":["trace[961030697] 'agreement among raft nodes before linearized reading'  (duration: 933.141897ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T01:00:14.44875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:00:13.515417Z","time spent":"933.327281ms","remote":"127.0.0.1:46298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":18543,"request content":"key:\"/registry/pods/kube-system/cilium-4fctx\" "}
{"level":"warn","ts":"2026-03-06T01:00:14.669329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.329491ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3939133175276529822 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1984 > success:<request_put:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" value_size:451 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-06T01:00:14.669858Z","caller":"traceutil/trace.go:171","msg":"trace[815276587] transaction","detail":"{read_only:false; response_revision:1995; number_of_response:1; }","duration":"216.622259ms","start":"2026-03-06T01:00:14.453202Z","end":"2026-03-06T01:00:14.669824Z","steps":["trace[815276587] 'process raft request'  (duration: 216.449155ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T01:00:14.66993Z","caller":"traceutil/trace.go:171","msg":"trace[1669432345] transaction","detail":"{read_only:false; response_revision:1998; number_of_response:1; }","duration":"216.543457ms","start":"2026-03-06T01:00:14.453369Z","end":"2026-03-06T01:00:14.669912Z","steps":["trace[1669432345] 'process raft request'  (duration: 216.402764ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T01:00:14.670085Z","caller":"traceutil/trace.go:171","msg":"trace[878824582] transaction","detail":"{read_only:false; response_revision:1996; number_of_response:1; }","duration":"216.759612ms","start":"2026-03-06T01:00:14.453314Z","end":"2026-03-06T01:00:14.670073Z","steps":["trace[878824582] 'process raft request'  (duration: 216.393783ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T01:00:14.670159Z","caller":"traceutil/trace.go:171","msg":"trace[1816581691] transaction","detail":"{read_only:false; response_revision:1994; number_of_response:1; }","duration":"228.042491ms","start":"2026-03-06T01:00:14.442103Z","end":"2026-03-06T01:00:14.670145Z","steps":["trace[1816581691] 'process raft request'  (duration: 51.819247ms)","trace[1816581691] 'compare'  (duration: 175.193558ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T01:00:14.670292Z","caller":"traceutil/trace.go:171","msg":"trace[1264493390] linearizableReadLoop","detail":"{readStateIndex:2093; appliedIndex:2083; }","duration":"211.826266ms","start":"2026-03-06T01:00:14.458305Z","end":"2026-03-06T01:00:14.670132Z","steps":["trace[1264493390] 'read index received'  (duration: 35.801967ms)","trace[1264493390] 'applied index is now lower than readState.Index'  (duration: 176.023469ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T01:00:14.670398Z","caller":"traceutil/trace.go:171","msg":"trace[1400055704] transaction","detail":"{read_only:false; response_revision:1999; number_of_response:1; }","duration":"216.962208ms","start":"2026-03-06T01:00:14.453428Z","end":"2026-03-06T01:00:14.67039Z","steps":["trace[1400055704] 'process raft request'  (duration: 216.368363ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T01:00:14.670473Z","caller":"traceutil/trace.go:171","msg":"trace[437064083] transaction","detail":"{read_only:false; response_revision:2000; number_of_response:1; }","duration":"215.565933ms","start":"2026-03-06T01:00:14.454898Z","end":"2026-03-06T01:00:14.670464Z","steps":["trace[437064083] 'process raft request'  (duration: 214.927136ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T01:00:14.670548Z","caller":"traceutil/trace.go:171","msg":"trace[982020290] transaction","detail":"{read_only:false; response_revision:2003; number_of_response:1; }","duration":"215.243874ms","start":"2026-03-06T01:00:14.455296Z","end":"2026-03-06T01:00:14.67054Z","steps":["trace[982020290] 'process raft request'  (duration: 214.612217ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T01:00:14.670742Z","caller":"traceutil/trace.go:171","msg":"trace[1508776434] transaction","detail":"{read_only:false; response_revision:2002; number_of_response:1; }","duration":"215.665405ms","start":"2026-03-06T01:00:14.455067Z","end":"2026-03-06T01:00:14.670732Z","steps":["trace[1508776434] 'process raft request'  (duration: 214.814854ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T01:00:14.670929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.616087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4fctx\" ","response":"range_response_count:1 size:18521"}
{"level":"info","ts":"2026-03-06T01:00:14.67109Z","caller":"traceutil/trace.go:171","msg":"trace[1677585389] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4fctx; range_end:; response_count:1; response_revision:2003; }","duration":"212.762211ms","start":"2026-03-06T01:00:14.458272Z","end":"2026-03-06T01:00:14.671034Z","steps":["trace[1677585389] 'agreement among raft nodes before linearized reading'  (duration: 212.37422ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T01:00:14.670326Z","caller":"traceutil/trace.go:171","msg":"trace[1959191774] transaction","detail":"{read_only:false; response_revision:1997; number_of_response:1; }","duration":"216.955738ms","start":"2026-03-06T01:00:14.453359Z","end":"2026-03-06T01:00:14.670315Z","steps":["trace[1959191774] 'process raft request'  (duration: 216.382103ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T01:00:14.67037Z","caller":"traceutil/trace.go:171","msg":"trace[700633329] transaction","detail":"{read_only:false; response_revision:2001; number_of_response:1; }","duration":"215.406079ms","start":"2026-03-06T01:00:14.454953Z","end":"2026-03-06T01:00:14.670359Z","steps":["trace[700633329] 'process raft request'  (duration: 214.901476ms)"],"step_count":1}