{"level":"warn","ts":"2026-03-17T21:56:11.013738Z","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-17T21:56:11.013895Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.112:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.112:2380","--initial-cluster=instance=https://199.19.213.112:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.112:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.112: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-17T21:56:11.014013Z","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-17T21:56:11.014209Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.112:2380"]}
{"level":"info","ts":"2026-03-17T21:56:11.01426Z","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-17T21:56:11.015241Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.112:2379"]}
{"level":"info","ts":"2026-03-17T21:56:11.015445Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.112:2380"],"listen-peer-urls":["https://199.19.213.112:2380"],"advertise-client-urls":["https://199.19.213.112:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.112:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.112: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-17T21:56:11.019486Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.615655ms"}
{"level":"info","ts":"2026-03-17T21:56:11.031743Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"197930edc5411b2e","cluster-id":"8165613f50a6d530"}
{"level":"info","ts":"2026-03-17T21:56:11.031842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e switched to configuration voters=()"}
{"level":"info","ts":"2026-03-17T21:56:11.031868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became follower at term 0"}
{"level":"info","ts":"2026-03-17T21:56:11.031945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 197930edc5411b2e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-17T21:56:11.031966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became follower at term 1"}
{"level":"info","ts":"2026-03-17T21:56:11.032019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e switched to configuration voters=(1835552120904948526)"}
{"level":"warn","ts":"2026-03-17T21:56:11.038049Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-17T21:56:11.039626Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-17T21:56:11.040615Z","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-17T21:56:11.044181Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"197930edc5411b2e","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-17T21:56:11.044332Z","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-17T21:56:11.044317Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"197930edc5411b2e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-17T21:56:11.044415Z","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-17T21:56:11.044466Z","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-17T21:56:11.045319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e switched to configuration voters=(1835552120904948526)"}
{"level":"info","ts":"2026-03-17T21:56:11.046447Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8165613f50a6d530","local-member-id":"197930edc5411b2e","added-peer-id":"197930edc5411b2e","added-peer-peer-urls":["https://199.19.213.112:2380"]}
{"level":"info","ts":"2026-03-17T21:56:11.052972Z","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-17T21:56:11.053276Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"197930edc5411b2e","initial-advertise-peer-urls":["https://199.19.213.112:2380"],"listen-peer-urls":["https://199.19.213.112:2380"],"advertise-client-urls":["https://199.19.213.112:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.112:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-17T21:56:11.053332Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-17T21:56:11.053584Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.112:2380"}
{"level":"info","ts":"2026-03-17T21:56:11.053679Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.112:2380"}
{"level":"info","ts":"2026-03-17T21:56:11.132477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e is starting a new election at term 1"}
{"level":"info","ts":"2026-03-17T21:56:11.132608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-17T21:56:11.132631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e received MsgPreVoteResp from 197930edc5411b2e at term 1"}
{"level":"info","ts":"2026-03-17T21:56:11.13265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became candidate at term 2"}
{"level":"info","ts":"2026-03-17T21:56:11.132661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e received MsgVoteResp from 197930edc5411b2e at term 2"}
{"level":"info","ts":"2026-03-17T21:56:11.132698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became leader at term 2"}
{"level":"info","ts":"2026-03-17T21:56:11.132712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 197930edc5411b2e elected leader 197930edc5411b2e at term 2"}
{"level":"info","ts":"2026-03-17T21:56:11.133722Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"197930edc5411b2e","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.112:2379]}","request-path":"/0/members/197930edc5411b2e/attributes","cluster-id":"8165613f50a6d530","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-17T21:56:11.133781Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-17T21:56:11.13388Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-17T21:56:11.13398Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-17T21:56:11.134298Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-17T21:56:11.134368Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-17T21:56:11.134963Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8165613f50a6d530","local-member-id":"197930edc5411b2e","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-17T21:56:11.135155Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-17T21:56:11.135263Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-17T21:56:11.138457Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.112:2379"}
{"level":"info","ts":"2026-03-17T21:56:11.140986Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-17T21:56:29.452388Z","caller":"traceutil/trace.go:171","msg":"trace[1972899110] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"400.449221ms","start":"2026-03-17T21:56:29.051908Z","end":"2026-03-17T21:56:29.452358Z","steps":["trace[1972899110] 'process raft request'  (duration: 400.317297ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:56:29.45371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:56:29.051891Z","time spent":"400.944614ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:445 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-17T21:56:29.454521Z","caller":"traceutil/trace.go:171","msg":"trace[1115264426] linearizableReadLoop","detail":"{readStateIndex:464; appliedIndex:464; }","duration":"394.271398ms","start":"2026-03-17T21:56:29.060235Z","end":"2026-03-17T21:56:29.454506Z","steps":["trace[1115264426] 'read index received'  (duration: 394.265298ms)","trace[1115264426] 'applied index is now lower than readState.Index'  (duration: 5.03µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:56:29.454893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.644637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-03-17T21:56:29.455047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.303249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-17T21:56:29.455142Z","caller":"traceutil/trace.go:171","msg":"trace[1173898010] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:449; }","duration":"394.425273ms","start":"2026-03-17T21:56:29.060694Z","end":"2026-03-17T21:56:29.455119Z","steps":["trace[1173898010] 'agreement among raft nodes before linearized reading'  (duration: 394.224588ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:56:29.455199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:56:29.060686Z","time spent":"394.502425ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-17T21:56:29.455313Z","caller":"traceutil/trace.go:171","msg":"trace[13585696] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:449; }","duration":"394.873624ms","start":"2026-03-17T21:56:29.060205Z","end":"2026-03-17T21:56:29.455078Z","steps":["trace[13585696] 'agreement among raft nodes before linearized reading'  (duration: 394.602886ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:56:29.455661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:56:29.060192Z","time spent":"395.451269ms","remote":"127.0.0.1:38050","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-17T21:56:30.00885Z","caller":"traceutil/trace.go:171","msg":"trace[2082777980] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"548.491347ms","start":"2026-03-17T21:56:29.460331Z","end":"2026-03-17T21:56:30.008822Z","steps":["trace[2082777980] 'process raft request'  (duration: 484.080396ms)","trace[2082777980] 'compare'  (duration: 64.275538ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:56:30.009208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:56:29.460306Z","time spent":"548.700402ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:447 > 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":"info","ts":"2026-03-17T21:56:30.486835Z","caller":"traceutil/trace.go:171","msg":"trace[1023011248] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"1.024394996s","start":"2026-03-17T21:56:29.462409Z","end":"2026-03-17T21:56:30.486804Z","steps":["trace[1023011248] 'process raft request'  (duration: 998.535278ms)","trace[1023011248] 'compare'  (duration: 25.695974ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:56:30.487031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:56:29.462395Z","time spent":"1.024529211s","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:446 > 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-17T21:56:30.490615Z","caller":"traceutil/trace.go:171","msg":"trace[1581088449] linearizableReadLoop","detail":"{readStateIndex:467; appliedIndex:464; }","duration":"800.796478ms","start":"2026-03-17T21:56:29.689803Z","end":"2026-03-17T21:56:30.490599Z","steps":["trace[1581088449] 'read index received'  (duration: 254.549842ms)","trace[1581088449] 'applied index is now lower than readState.Index'  (duration: 546.245726ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:56:30.490805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.991553ms","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-17T21:56:30.490865Z","caller":"traceutil/trace.go:171","msg":"trace[1319212450] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:451; }","duration":"801.086776ms","start":"2026-03-17T21:56:29.689763Z","end":"2026-03-17T21:56:30.49085Z","steps":["trace[1319212450] 'agreement among raft nodes before linearized reading'  (duration: 800.964203ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:56:30.490923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:56:29.689741Z","time spent":"801.170757ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-17T21:56:50.823756Z","caller":"traceutil/trace.go:171","msg":"trace[1904768021] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"152.77685ms","start":"2026-03-17T21:56:50.670958Z","end":"2026-03-17T21:56:50.823735Z","steps":["trace[1904768021] 'process raft request'  (duration: 152.663157ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:56:52.570284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"924.230376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T21:56:52.570377Z","caller":"traceutil/trace.go:171","msg":"trace[446243862] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:539; }","duration":"924.37356ms","start":"2026-03-17T21:56:51.645985Z","end":"2026-03-17T21:56:52.570359Z","steps":["trace[446243862] 'range keys from in-memory index tree'  (duration: 924.170845ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:56:52.570368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.570852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-03-17T21:56:52.57042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:56:51.64597Z","time spent":"924.441781ms","remote":"127.0.0.1:37860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-17T21:56:52.570454Z","caller":"traceutil/trace.go:171","msg":"trace[1109757026] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:539; }","duration":"387.699366ms","start":"2026-03-17T21:56:52.182731Z","end":"2026-03-17T21:56:52.570431Z","steps":["trace[1109757026] 'range keys from in-memory index tree'  (duration: 387.49439ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:56:52.570495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:56:52.182715Z","time spent":"387.770007ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-17T21:56:52.570257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"955.255671ms","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-17T21:56:52.570581Z","caller":"traceutil/trace.go:171","msg":"trace[723033028] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:539; }","duration":"955.6285ms","start":"2026-03-17T21:56:51.614931Z","end":"2026-03-17T21:56:52.57056Z","steps":["trace[723033028] 'range keys from in-memory index tree'  (duration: 955.092836ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:56:52.570636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:56:51.614912Z","time spent":"955.708323ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-17T21:56:57.294887Z","caller":"traceutil/trace.go:171","msg":"trace[127044265] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"137.736816ms","start":"2026-03-17T21:56:57.157125Z","end":"2026-03-17T21:56:57.294862Z","steps":["trace[127044265] 'process raft request'  (duration: 137.14514ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:57:12.442233Z","caller":"traceutil/trace.go:171","msg":"trace[1080889025] linearizableReadLoop","detail":"{readStateIndex:753; appliedIndex:752; }","duration":"259.037089ms","start":"2026-03-17T21:57:12.183162Z","end":"2026-03-17T21:57:12.442199Z","steps":["trace[1080889025] 'read index received'  (duration: 258.908584ms)","trace[1080889025] 'applied index is now lower than readState.Index'  (duration: 127.445µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:57:12.44233Z","caller":"traceutil/trace.go:171","msg":"trace[1667428668] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"534.494969ms","start":"2026-03-17T21:57:11.907798Z","end":"2026-03-17T21:57:12.442293Z","steps":["trace[1667428668] 'process raft request'  (duration: 534.276643ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:57:12.442418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.236323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-17T21:57:12.442448Z","caller":"traceutil/trace.go:171","msg":"trace[1108986694] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:727; }","duration":"259.326456ms","start":"2026-03-17T21:57:12.183113Z","end":"2026-03-17T21:57:12.442439Z","steps":["trace[1108986694] 'agreement among raft nodes before linearized reading'  (duration: 259.205593ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:57:12.442527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:57:11.907778Z","time spent":"534.659983ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:722 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-17T21:57:13.187893Z","caller":"traceutil/trace.go:171","msg":"trace[846413650] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"514.487024ms","start":"2026-03-17T21:57:12.673381Z","end":"2026-03-17T21:57:13.187868Z","steps":["trace[846413650] 'process raft request'  (duration: 514.34712ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:57:13.188039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:57:12.673364Z","time spent":"514.598036ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:723 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-17T21:57:13.190476Z","caller":"traceutil/trace.go:171","msg":"trace[2042299667] linearizableReadLoop","detail":"{readStateIndex:755; appliedIndex:753; }","duration":"437.478162ms","start":"2026-03-17T21:57:12.752966Z","end":"2026-03-17T21:57:13.190444Z","steps":["trace[2042299667] 'read index received'  (duration: 434.831893ms)","trace[2042299667] 'applied index is now lower than readState.Index'  (duration: 2.645189ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:57:13.190516Z","caller":"traceutil/trace.go:171","msg":"trace[1327779939] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"516.498196ms","start":"2026-03-17T21:57:12.673984Z","end":"2026-03-17T21:57:13.190482Z","steps":["trace[1327779939] 'process raft request'  (duration: 516.362002ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:57:13.190657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:57:12.673971Z","time spent":"516.613569ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:724 > 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-17T21:57:13.190723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.747929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-17T21:57:13.190788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.761284ms","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-17T21:57:13.190785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.958305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-17T21:57:13.190802Z","caller":"traceutil/trace.go:171","msg":"trace[1807559852] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:729; }","duration":"437.863093ms","start":"2026-03-17T21:57:12.75292Z","end":"2026-03-17T21:57:13.190783Z","steps":["trace[1807559852] 'agreement among raft nodes before linearized reading'  (duration: 437.631497ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:57:13.190825Z","caller":"traceutil/trace.go:171","msg":"trace[1087504191] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:729; }","duration":"276.820716ms","start":"2026-03-17T21:57:12.913992Z","end":"2026-03-17T21:57:13.190813Z","steps":["trace[1087504191] 'agreement among raft nodes before linearized reading'  (duration: 276.720013ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:57:13.190679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.853766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-17T21:57:13.190888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:57:12.752905Z","time spent":"437.954595ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-17T21:57:13.190923Z","caller":"traceutil/trace.go:171","msg":"trace[1660916774] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:729; }","duration":"408.123292ms","start":"2026-03-17T21:57:12.782781Z","end":"2026-03-17T21:57:13.190905Z","steps":["trace[1660916774] 'agreement among raft nodes before linearized reading'  (duration: 407.822755ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:57:13.190996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:57:12.782776Z","time spent":"408.197674ms","remote":"127.0.0.1:37890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":11,"response size":30,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "}
{"level":"info","ts":"2026-03-17T21:57:13.190865Z","caller":"traceutil/trace.go:171","msg":"trace[200754182] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:729; }","duration":"390.080368ms","start":"2026-03-17T21:57:12.800767Z","end":"2026-03-17T21:57:13.190847Z","steps":["trace[200754182] 'agreement among raft nodes before linearized reading'  (duration: 389.950884ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:57:13.191087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:57:12.800749Z","time spent":"390.325624ms","remote":"127.0.0.1:37944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":4,"response size":30,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "}
{"level":"info","ts":"2026-03-17T21:57:13.459396Z","caller":"traceutil/trace.go:171","msg":"trace[1187661206] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"264.071422ms","start":"2026-03-17T21:57:13.195296Z","end":"2026-03-17T21:57:13.459367Z","steps":["trace[1187661206] 'process raft request'  (duration: 263.993479ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:57:13.459666Z","caller":"traceutil/trace.go:171","msg":"trace[547960467] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"264.972465ms","start":"2026-03-17T21:57:13.194666Z","end":"2026-03-17T21:57:13.459638Z","steps":["trace[547960467] 'process raft request'  (duration: 225.714085ms)","trace[547960467] 'compare'  (duration: 38.668325ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:57:14.297986Z","caller":"traceutil/trace.go:171","msg":"trace[1342504057] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"175.052444ms","start":"2026-03-17T21:57:14.122915Z","end":"2026-03-17T21:57:14.297968Z","steps":["trace[1342504057] 'process raft request'  (duration: 174.946231ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:57:14.678919Z","caller":"traceutil/trace.go:171","msg":"trace[666032854] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"228.090486ms","start":"2026-03-17T21:57:14.450801Z","end":"2026-03-17T21:57:14.678892Z","steps":["trace[666032854] 'process raft request'  (duration: 223.180697ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:57:37.525543Z","caller":"traceutil/trace.go:171","msg":"trace[1004024155] linearizableReadLoop","detail":"{readStateIndex:835; appliedIndex:834; }","duration":"224.620382ms","start":"2026-03-17T21:57:37.300891Z","end":"2026-03-17T21:57:37.525511Z","steps":["trace[1004024155] 'read index received'  (duration: 224.438488ms)","trace[1004024155] 'applied index is now lower than readState.Index'  (duration: 180.364µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:57:37.525577Z","caller":"traceutil/trace.go:171","msg":"trace[634427667] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"227.382414ms","start":"2026-03-17T21:57:37.298169Z","end":"2026-03-17T21:57:37.525552Z","steps":["trace[634427667] 'process raft request'  (duration: 227.18297ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:57:37.525845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.938042ms","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-17T21:57:37.525911Z","caller":"traceutil/trace.go:171","msg":"trace[122467971] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:803; }","duration":"225.043195ms","start":"2026-03-17T21:57:37.300849Z","end":"2026-03-17T21:57:37.525892Z","steps":["trace[122467971] 'agreement among raft nodes before linearized reading'  (duration: 224.850169ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:57:37.658942Z","caller":"traceutil/trace.go:171","msg":"trace[213441599] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"129.101285ms","start":"2026-03-17T21:57:37.529816Z","end":"2026-03-17T21:57:37.658917Z","steps":["trace[213441599] 'process raft request'  (duration: 57.173082ms)","trace[213441599] 'compare'  (duration: 71.756757ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:57:37.886813Z","caller":"traceutil/trace.go:171","msg":"trace[1668140368] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"177.795748ms","start":"2026-03-17T21:57:37.708982Z","end":"2026-03-17T21:57:37.886778Z","steps":["trace[1668140368] 'process raft request'  (duration: 163.643804ms)","trace[1668140368] 'compare'  (duration: 13.942489ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:57:49.821539Z","caller":"traceutil/trace.go:171","msg":"trace[1409335634] linearizableReadLoop","detail":"{readStateIndex:924; appliedIndex:923; }","duration":"177.520989ms","start":"2026-03-17T21:57:49.643998Z","end":"2026-03-17T21:57:49.821519Z","steps":["trace[1409335634] 'read index received'  (duration: 177.396566ms)","trace[1409335634] 'applied index is now lower than readState.Index'  (duration: 123.443µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:57:49.821627Z","caller":"traceutil/trace.go:171","msg":"trace[494782661] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"242.77732ms","start":"2026-03-17T21:57:49.578841Z","end":"2026-03-17T21:57:49.821618Z","steps":["trace[494782661] 'process raft request'  (duration: 242.570454ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:57:49.821756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.735466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T21:57:49.821782Z","caller":"traceutil/trace.go:171","msg":"trace[1461908150] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:889; }","duration":"177.805287ms","start":"2026-03-17T21:57:49.643969Z","end":"2026-03-17T21:57:49.821774Z","steps":["trace[1461908150] 'agreement among raft nodes before linearized reading'  (duration: 177.744866ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:57:50.195267Z","caller":"traceutil/trace.go:171","msg":"trace[1099652792] linearizableReadLoop","detail":"{readStateIndex:925; appliedIndex:924; }","duration":"373.657389ms","start":"2026-03-17T21:57:49.821591Z","end":"2026-03-17T21:57:50.195249Z","steps":["trace[1099652792] 'read index received'  (duration: 366.086534ms)","trace[1099652792] 'applied index is now lower than readState.Index'  (duration: 7.569775ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:57:50.195467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.844636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-17T21:57:50.195504Z","caller":"traceutil/trace.go:171","msg":"trace[1509866428] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:889; }","duration":"415.893427ms","start":"2026-03-17T21:57:49.7796Z","end":"2026-03-17T21:57:50.195494Z","steps":["trace[1509866428] 'agreement among raft nodes before linearized reading'  (duration: 415.764453ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:57:50.195532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:57:49.779553Z","time spent":"415.973639ms","remote":"127.0.0.1:38050","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-17T21:57:50.195735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.83119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-17T21:57:50.195664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.771042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-03-17T21:57:50.195789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.42372ms","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-17T21:57:50.19585Z","caller":"traceutil/trace.go:171","msg":"trace[622160431] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:889; }","duration":"447.529902ms","start":"2026-03-17T21:57:49.748306Z","end":"2026-03-17T21:57:50.195836Z","steps":["trace[622160431] 'agreement among raft nodes before linearized reading'  (duration: 447.326687ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:57:50.195883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:57:49.748289Z","time spent":"447.588114ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-17T21:57:50.195802Z","caller":"traceutil/trace.go:171","msg":"trace[1294427971] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:889; }","duration":"477.962166ms","start":"2026-03-17T21:57:49.717818Z","end":"2026-03-17T21:57:50.19578Z","steps":["trace[1294427971] 'agreement among raft nodes before linearized reading'  (duration: 477.598888ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:57:50.195945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:57:49.717801Z","time spent":"478.13544ms","remote":"127.0.0.1:38050","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-17T21:57:50.195764Z","caller":"traceutil/trace.go:171","msg":"trace[11325435] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:889; }","duration":"372.908862ms","start":"2026-03-17T21:57:49.822849Z","end":"2026-03-17T21:57:50.195757Z","steps":["trace[11325435] 'agreement among raft nodes before linearized reading'  (duration: 372.84756ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:57:50.196013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:57:49.822828Z","time spent":"373.179298ms","remote":"127.0.0.1:37846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-17T21:58:08.689735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.453774ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826220150 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:963 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-17T21:58:08.689909Z","caller":"traceutil/trace.go:171","msg":"trace[1829279695] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"408.22888ms","start":"2026-03-17T21:58:08.281664Z","end":"2026-03-17T21:58:08.689893Z","steps":["trace[1829279695] 'process raft request'  (duration: 408.163589ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:08.690072Z","caller":"traceutil/trace.go:171","msg":"trace[1274998292] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"409.595696ms","start":"2026-03-17T21:58:08.28044Z","end":"2026-03-17T21:58:08.690036Z","steps":["trace[1274998292] 'process raft request'  (duration: 65.393444ms)","trace[1274998292] 'compare'  (duration: 343.33909ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:08.690231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:08.281653Z","time spent":"408.290572ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:964 > 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-17T21:58:08.690258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:08.280431Z","time spent":"409.722119ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:963 > 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-17T21:58:08.694438Z","caller":"traceutil/trace.go:171","msg":"trace[862471558] linearizableReadLoop","detail":"{readStateIndex:1010; appliedIndex:1009; }","duration":"266.784499ms","start":"2026-03-17T21:58:08.427635Z","end":"2026-03-17T21:58:08.694419Z","steps":["trace[862471558] 'read index received'  (duration: 266.669426ms)","trace[862471558] 'applied index is now lower than readState.Index'  (duration: 113.752µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:08.69445Z","caller":"traceutil/trace.go:171","msg":"trace[2046600125] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"342.346174ms","start":"2026-03-17T21:58:08.352088Z","end":"2026-03-17T21:58:08.694434Z","steps":["trace[2046600125] 'process raft request'  (duration: 342.227591ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:08.694549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.920782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T21:58:08.69482Z","caller":"traceutil/trace.go:171","msg":"trace[1013343698] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:971; }","duration":"267.238691ms","start":"2026-03-17T21:58:08.427569Z","end":"2026-03-17T21:58:08.694808Z","steps":["trace[1013343698] 'agreement among raft nodes before linearized reading'  (duration: 266.912442ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:08.694784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:08.352064Z","time spent":"342.672563ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":779,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-pwq7t.189dbfc6b11dd82d\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-pwq7t.189dbfc6b11dd82d\" value_size:675 lease:1958675501826219563 >> failure:<>"}
{"level":"info","ts":"2026-03-17T21:58:08.710471Z","caller":"traceutil/trace.go:171","msg":"trace[414980051] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"138.506966ms","start":"2026-03-17T21:58:08.571947Z","end":"2026-03-17T21:58:08.710454Z","steps":["trace[414980051] 'process raft request'  (duration: 138.128847ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:09.299293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.131394ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826220155 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:424 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-17T21:58:09.299378Z","caller":"traceutil/trace.go:171","msg":"trace[1555971820] linearizableReadLoop","detail":"{readStateIndex:1012; appliedIndex:1011; }","duration":"587.6852ms","start":"2026-03-17T21:58:08.711678Z","end":"2026-03-17T21:58:09.299364Z","steps":["trace[1555971820] 'read index received'  (duration: 157.421133ms)","trace[1555971820] 'applied index is now lower than readState.Index'  (duration: 430.262867ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:09.29947Z","caller":"traceutil/trace.go:171","msg":"trace[716690152] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"600.704275ms","start":"2026-03-17T21:58:08.698756Z","end":"2026-03-17T21:58:09.29946Z","steps":["trace[716690152] 'process raft request'  (duration: 170.355066ms)","trace[716690152] 'compare'  (duration: 430.020651ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:09.299514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:08.698732Z","time spent":"600.764087ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:424 >> failure:<>"}
{"level":"warn","ts":"2026-03-17T21:58:09.299757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.07373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T21:58:09.299804Z","caller":"traceutil/trace.go:171","msg":"trace[559754348] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:973; }","duration":"588.154582ms","start":"2026-03-17T21:58:08.711639Z","end":"2026-03-17T21:58:09.299794Z","steps":["trace[559754348] 'agreement among raft nodes before linearized reading'  (duration: 588.042559ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:09.299841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:08.711523Z","time spent":"588.309126ms","remote":"127.0.0.1:37846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-17T21:58:09.800101Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958675501826220158,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-17T21:58:09.905483Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.024827705s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-17T21:58:09.90579Z","caller":"traceutil/trace.go:171","msg":"trace[397083054] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"1.025331917s","start":"2026-03-17T21:58:08.880443Z","end":"2026-03-17T21:58:09.905775Z","steps":["trace[397083054] 'process raft request'  (duration: 1.025232385s)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:09.905867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:08.880386Z","time spent":"1.02543693s","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":779,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-pwq7t.189dbfc6d07be092\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-pwq7t.189dbfc6d07be092\" value_size:675 lease:1958675501826219563 >> failure:<>"}
{"level":"info","ts":"2026-03-17T21:58:09.939084Z","caller":"traceutil/trace.go:171","msg":"trace[2101273476] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"634.703261ms","start":"2026-03-17T21:58:09.304306Z","end":"2026-03-17T21:58:09.939009Z","steps":["trace[2101273476] 'process raft request'  (duration: 634.479226ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:09.939302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:09.304288Z","time spent":"634.878546ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":868,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/external-resizer-rbd-csi-ceph-com.189dbfc6e9d2f1c5\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/external-resizer-rbd-csi-ceph-com.189dbfc6e9d2f1c5\" value_size:771 lease:1958675501826219563 >> failure:<>"}
{"level":"info","ts":"2026-03-17T21:58:10.029231Z","caller":"traceutil/trace.go:171","msg":"trace[2003996138] linearizableReadLoop","detail":"{readStateIndex:1015; appliedIndex:1013; }","duration":"729.799059ms","start":"2026-03-17T21:58:09.299402Z","end":"2026-03-17T21:58:10.029201Z","steps":["trace[2003996138] 'read index received'  (duration: 606.492975ms)","trace[2003996138] 'applied index is now lower than readState.Index'  (duration: 123.300984ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:10.029322Z","caller":"traceutil/trace.go:171","msg":"trace[1861099751] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"120.361599ms","start":"2026-03-17T21:58:09.908896Z","end":"2026-03-17T21:58:10.029258Z","steps":["trace[1861099751] 'process raft request'  (duration: 120.161044ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:10.105431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"995.47865ms","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-17T21:58:10.105512Z","caller":"traceutil/trace.go:171","msg":"trace[475587786] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:976; }","duration":"995.597142ms","start":"2026-03-17T21:58:09.109898Z","end":"2026-03-17T21:58:10.105495Z","steps":["trace[475587786] 'agreement among raft nodes before linearized reading'  (duration: 919.39403ms)","trace[475587786] 'range keys from in-memory index tree'  (duration: 76.005056ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:10.105555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:09.109867Z","time spent":"995.672774ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-17T21:58:10.105734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.767404ms","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-17T21:58:10.105799Z","caller":"traceutil/trace.go:171","msg":"trace[2002790622] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:976; }","duration":"187.864657ms","start":"2026-03-17T21:58:09.917919Z","end":"2026-03-17T21:58:10.105783Z","steps":["trace[2002790622] 'agreement among raft nodes before linearized reading'  (duration: 111.46317ms)","trace[2002790622] 'range keys from in-memory index tree'  (duration: 76.231843ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:10.105954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.23659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-03-17T21:58:10.105981Z","caller":"traceutil/trace.go:171","msg":"trace[704148865] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:976; }","duration":"803.296441ms","start":"2026-03-17T21:58:09.302677Z","end":"2026-03-17T21:58:10.105973Z","steps":["trace[704148865] 'agreement among raft nodes before linearized reading'  (duration: 726.686699ms)","trace[704148865] 'range keys from in-memory index tree'  (duration: 76.53108ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:10.106001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:09.302663Z","time spent":"803.331892ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-03-17T21:58:10.106062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.532436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T21:58:10.106085Z","caller":"traceutil/trace.go:171","msg":"trace[958918666] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:976; }","duration":"648.598459ms","start":"2026-03-17T21:58:09.45748Z","end":"2026-03-17T21:58:10.106079Z","steps":["trace[958918666] 'agreement among raft nodes before linearized reading'  (duration: 571.892794ms)","trace[958918666] 'count revisions from in-memory index tree'  (duration: 76.675463ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:10.106104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:09.457466Z","time spent":"648.63354ms","remote":"127.0.0.1:38206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "}
{"level":"warn","ts":"2026-03-17T21:58:10.10649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.797072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-17T21:58:10.106584Z","caller":"traceutil/trace.go:171","msg":"trace[385725171] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:976; }","duration":"371.954766ms","start":"2026-03-17T21:58:09.734603Z","end":"2026-03-17T21:58:10.106558Z","steps":["trace[385725171] 'agreement among raft nodes before linearized reading'  (duration: 294.763118ms)","trace[385725171] 'count revisions from in-memory index tree'  (duration: 77.010273ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:10.106669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:09.734579Z","time spent":"372.054768ms","remote":"127.0.0.1:38154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":30,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "}
{"level":"info","ts":"2026-03-17T21:58:10.275735Z","caller":"traceutil/trace.go:171","msg":"trace[203727722] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"162.920955ms","start":"2026-03-17T21:58:10.112788Z","end":"2026-03-17T21:58:10.275709Z","steps":["trace[203727722] 'process raft request'  (duration: 162.852293ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:10.275772Z","caller":"traceutil/trace.go:171","msg":"trace[2010218119] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"164.890445ms","start":"2026-03-17T21:58:10.110871Z","end":"2026-03-17T21:58:10.275761Z","steps":["trace[2010218119] 'process raft request'  (duration: 164.567476ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:11.005988Z","caller":"traceutil/trace.go:171","msg":"trace[1640451581] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"307.745273ms","start":"2026-03-17T21:58:10.698216Z","end":"2026-03-17T21:58:11.005961Z","steps":["trace[1640451581] 'process raft request'  (duration: 307.568739ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:11.006304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:10.698188Z","time spent":"308.02015ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:970 > 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-17T21:58:11.550842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.748466ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826220174 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:969 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-17T21:58:11.550947Z","caller":"traceutil/trace.go:171","msg":"trace[897978983] linearizableReadLoop","detail":"{readStateIndex:1022; appliedIndex:1021; }","duration":"567.555422ms","start":"2026-03-17T21:58:10.983379Z","end":"2026-03-17T21:58:11.550934Z","steps":["trace[897978983] 'read index received'  (duration: 22.764676ms)","trace[897978983] 'applied index is now lower than readState.Index'  (duration: 544.789616ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:11.551112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.514487ms","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-17T21:58:11.551201Z","caller":"traceutil/trace.go:171","msg":"trace[586463687] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:982; }","duration":"246.642671ms","start":"2026-03-17T21:58:11.304531Z","end":"2026-03-17T21:58:11.551174Z","steps":["trace[586463687] 'agreement among raft nodes before linearized reading'  (duration: 246.502556ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:11.551246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.86071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"}
{"level":"info","ts":"2026-03-17T21:58:11.551283Z","caller":"traceutil/trace.go:171","msg":"trace[456354318] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:982; }","duration":"567.938652ms","start":"2026-03-17T21:58:10.983337Z","end":"2026-03-17T21:58:11.551276Z","steps":["trace[456354318] 'agreement among raft nodes before linearized reading'  (duration: 567.753748ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:11.551318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:10.98332Z","time spent":"567.988253ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":495,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"info","ts":"2026-03-17T21:58:11.551454Z","caller":"traceutil/trace.go:171","msg":"trace[165882114] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"852.395655ms","start":"2026-03-17T21:58:10.698623Z","end":"2026-03-17T21:58:11.551019Z","steps":["trace[165882114] 'process raft request'  (duration: 533.405033ms)","trace[165882114] 'compare'  (duration: 318.452079ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:11.551534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:10.698598Z","time spent":"852.904309ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:969 > 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-17T21:58:11.722429Z","caller":"traceutil/trace.go:171","msg":"trace[787054445] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"167.480802ms","start":"2026-03-17T21:58:11.554884Z","end":"2026-03-17T21:58:11.722364Z","steps":["trace[787054445] 'process raft request'  (duration: 137.224603ms)","trace[787054445] 'compare'  (duration: 29.952861ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:12.337669Z","caller":"traceutil/trace.go:171","msg":"trace[1284866849] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"202.858943ms","start":"2026-03-17T21:58:12.134782Z","end":"2026-03-17T21:58:12.337641Z","steps":["trace[1284866849] 'process raft request'  (duration: 202.546936ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:12.452214Z","caller":"traceutil/trace.go:171","msg":"trace[1030242886] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"110.438274ms","start":"2026-03-17T21:58:12.341754Z","end":"2026-03-17T21:58:12.452192Z","steps":["trace[1030242886] 'process raft request'  (duration: 110.3013ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:12.454178Z","caller":"traceutil/trace.go:171","msg":"trace[714488499] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"112.389353ms","start":"2026-03-17T21:58:12.341765Z","end":"2026-03-17T21:58:12.454154Z","steps":["trace[714488499] 'process raft request'  (duration: 112.248929ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:13.26508Z","caller":"traceutil/trace.go:171","msg":"trace[1479142331] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"250.463559ms","start":"2026-03-17T21:58:13.014598Z","end":"2026-03-17T21:58:13.265061Z","steps":["trace[1479142331] 'process raft request'  (duration: 250.328815ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:13.658975Z","caller":"traceutil/trace.go:171","msg":"trace[1173011847] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"100.566309ms","start":"2026-03-17T21:58:13.558395Z","end":"2026-03-17T21:58:13.658961Z","steps":["trace[1173011847] 'process raft request'  (duration: 100.307353ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:14.578932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.933837ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826220201 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.19.213.112\" mod_revision:939 > success:<request_put:<key:\"/registry/masterleases/199.19.213.112\" value_size:67 lease:1958675501826220198 >> failure:<request_range:<key:\"/registry/masterleases/199.19.213.112\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-17T21:58:14.579094Z","caller":"traceutil/trace.go:171","msg":"trace[1617689954] linearizableReadLoop","detail":"{readStateIndex:1031; appliedIndex:1029; }","duration":"121.729184ms","start":"2026-03-17T21:58:14.457352Z","end":"2026-03-17T21:58:14.579082Z","steps":["trace[1617689954] 'read index received'  (duration: 52.4342ms)","trace[1617689954] 'applied index is now lower than readState.Index'  (duration: 69.293984ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:14.579166Z","caller":"traceutil/trace.go:171","msg":"trace[1961784163] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"199.132738ms","start":"2026-03-17T21:58:14.380026Z","end":"2026-03-17T21:58:14.579159Z","steps":["trace[1961784163] 'process raft request'  (duration: 198.998705ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:14.5794Z","caller":"traceutil/trace.go:171","msg":"trace[914277787] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"201.947829ms","start":"2026-03-17T21:58:14.377422Z","end":"2026-03-17T21:58:14.57937Z","steps":["trace[914277787] 'process raft request'  (duration: 48.514909ms)","trace[914277787] 'compare'  (duration: 152.809404ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:14.579469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.115243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-17T21:58:14.579494Z","caller":"traceutil/trace.go:171","msg":"trace[1260110604] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:990; }","duration":"122.176425ms","start":"2026-03-17T21:58:14.45731Z","end":"2026-03-17T21:58:14.579487Z","steps":["trace[1260110604] 'agreement among raft nodes before linearized reading'  (duration: 122.082993ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:14.579489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.58658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-17T21:58:14.579546Z","caller":"traceutil/trace.go:171","msg":"trace[1212124335] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:990; }","duration":"121.701363ms","start":"2026-03-17T21:58:14.457831Z","end":"2026-03-17T21:58:14.579532Z","steps":["trace[1212124335] 'agreement among raft nodes before linearized reading'  (duration: 121.444407ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:14.697726Z","caller":"traceutil/trace.go:171","msg":"trace[1629074901] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"114.269311ms","start":"2026-03-17T21:58:14.583432Z","end":"2026-03-17T21:58:14.697701Z","steps":["trace[1629074901] 'process raft request'  (duration: 113.569713ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:14.701365Z","caller":"traceutil/trace.go:171","msg":"trace[144103087] linearizableReadLoop","detail":"{readStateIndex:1033; appliedIndex:1031; }","duration":"116.820117ms","start":"2026-03-17T21:58:14.584506Z","end":"2026-03-17T21:58:14.701326Z","steps":["trace[144103087] 'read index received'  (duration: 112.512947ms)","trace[144103087] 'applied index is now lower than readState.Index'  (duration: 4.30618ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:14.701871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.341771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-03-17T21:58:14.701926Z","caller":"traceutil/trace.go:171","msg":"trace[1796882545] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:992; }","duration":"117.428904ms","start":"2026-03-17T21:58:14.584484Z","end":"2026-03-17T21:58:14.701913Z","steps":["trace[1796882545] 'agreement among raft nodes before linearized reading'  (duration: 117.325411ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:14.701671Z","caller":"traceutil/trace.go:171","msg":"trace[1450533805] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"118.216293ms","start":"2026-03-17T21:58:14.583439Z","end":"2026-03-17T21:58:14.701655Z","steps":["trace[1450533805] 'process raft request'  (duration: 117.72493ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:20.35127Z","caller":"traceutil/trace.go:171","msg":"trace[852679278] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"145.923558ms","start":"2026-03-17T21:58:20.205321Z","end":"2026-03-17T21:58:20.351245Z","steps":["trace[852679278] 'process raft request'  (duration: 145.742063ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:20.772765Z","caller":"traceutil/trace.go:171","msg":"trace[325208060] linearizableReadLoop","detail":"{readStateIndex:1082; appliedIndex:1081; }","duration":"170.778557ms","start":"2026-03-17T21:58:20.601963Z","end":"2026-03-17T21:58:20.772742Z","steps":["trace[325208060] 'read index received'  (duration: 170.617702ms)","trace[325208060] 'applied index is now lower than readState.Index'  (duration: 159.685µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:20.773551Z","caller":"traceutil/trace.go:171","msg":"trace[418201165] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"418.882855ms","start":"2026-03-17T21:58:20.354636Z","end":"2026-03-17T21:58:20.773519Z","steps":["trace[418201165] 'process raft request'  (duration: 417.989432ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:20.773679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:20.354622Z","time spent":"418.969807ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:1001 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:424 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-03-17T21:58:20.774624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.622064ms","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-17T21:58:20.774799Z","caller":"traceutil/trace.go:171","msg":"trace[1479712851] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1039; }","duration":"172.85943ms","start":"2026-03-17T21:58:20.601906Z","end":"2026-03-17T21:58:20.774766Z","steps":["trace[1479712851] 'agreement among raft nodes before linearized reading'  (duration: 172.430109ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:22.986111Z","caller":"traceutil/trace.go:171","msg":"trace[995715142] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"111.603352ms","start":"2026-03-17T21:58:22.874479Z","end":"2026-03-17T21:58:22.986082Z","steps":["trace[995715142] 'process raft request'  (duration: 111.549291ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:22.986169Z","caller":"traceutil/trace.go:171","msg":"trace[1436811935] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"111.663213ms","start":"2026-03-17T21:58:22.874473Z","end":"2026-03-17T21:58:22.986136Z","steps":["trace[1436811935] 'process raft request'  (duration: 105.342802ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:24.531902Z","caller":"traceutil/trace.go:171","msg":"trace[1324916747] linearizableReadLoop","detail":"{readStateIndex:1098; appliedIndex:1097; }","duration":"117.479556ms","start":"2026-03-17T21:58:24.414394Z","end":"2026-03-17T21:58:24.531874Z","steps":["trace[1324916747] 'read index received'  (duration: 109.009781ms)","trace[1324916747] 'applied index is now lower than readState.Index'  (duration: 8.468815ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:24.532106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.66507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-03-17T21:58:24.53215Z","caller":"traceutil/trace.go:171","msg":"trace[529023272] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1054; }","duration":"117.812191ms","start":"2026-03-17T21:58:24.414324Z","end":"2026-03-17T21:58:24.532137Z","steps":["trace[529023272] 'agreement among raft nodes before linearized reading'  (duration: 117.647739ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:24.532109Z","caller":"traceutil/trace.go:171","msg":"trace[1857431462] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"127.291313ms","start":"2026-03-17T21:58:24.404666Z","end":"2026-03-17T21:58:24.531957Z","steps":["trace[1857431462] 'process raft request'  (duration: 118.648456ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:25.964307Z","caller":"traceutil/trace.go:171","msg":"trace[1446922148] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"179.476597ms","start":"2026-03-17T21:58:25.784805Z","end":"2026-03-17T21:58:25.964282Z","steps":["trace[1446922148] 'process raft request'  (duration: 105.685788ms)","trace[1446922148] 'compare'  (duration: 73.553245ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:27.280946Z","caller":"traceutil/trace.go:171","msg":"trace[464058698] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"192.547226ms","start":"2026-03-17T21:58:27.088365Z","end":"2026-03-17T21:58:27.280912Z","steps":["trace[464058698] 'process raft request'  (duration: 174.62254ms)","trace[464058698] 'compare'  (duration: 17.788934ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:29.316126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.887915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-17T21:58:29.316206Z","caller":"traceutil/trace.go:171","msg":"trace[1521870423] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1072; }","duration":"165.018376ms","start":"2026-03-17T21:58:29.15117Z","end":"2026-03-17T21:58:29.316189Z","steps":["trace[1521870423] 'range keys from in-memory index tree'  (duration: 164.725552ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:29.316176Z","caller":"traceutil/trace.go:171","msg":"trace[2137882970] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"151.339328ms","start":"2026-03-17T21:58:29.164815Z","end":"2026-03-17T21:58:29.316154Z","steps":["trace[2137882970] 'process raft request'  (duration: 135.438503ms)","trace[2137882970] 'compare'  (duration: 15.629331ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:29.6797Z","caller":"traceutil/trace.go:171","msg":"trace[1264934585] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"359.103336ms","start":"2026-03-17T21:58:29.320215Z","end":"2026-03-17T21:58:29.679318Z","steps":["trace[1264934585] 'process raft request'  (duration: 358.940882ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:29.680659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:29.32019Z","time spent":"360.154823ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1068 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-17T21:58:29.737085Z","caller":"traceutil/trace.go:171","msg":"trace[650550304] linearizableReadLoop","detail":"{readStateIndex:1119; appliedIndex:1117; }","duration":"301.338883ms","start":"2026-03-17T21:58:29.435721Z","end":"2026-03-17T21:58:29.73706Z","steps":["trace[650550304] 'read index received'  (duration: 243.337416ms)","trace[650550304] 'applied index is now lower than readState.Index'  (duration: 58.000587ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:29.737157Z","caller":"traceutil/trace.go:171","msg":"trace[919883809] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"416.755367ms","start":"2026-03-17T21:58:29.320386Z","end":"2026-03-17T21:58:29.737141Z","steps":["trace[919883809] 'process raft request'  (duration: 416.542414ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:29.737259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:29.320365Z","time spent":"416.829508ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1067 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-17T21:58:29.737472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.73382ms","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-17T21:58:29.737534Z","caller":"traceutil/trace.go:171","msg":"trace[383773461] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1075; }","duration":"301.826171ms","start":"2026-03-17T21:58:29.435693Z","end":"2026-03-17T21:58:29.73752Z","steps":["trace[383773461] 'agreement among raft nodes before linearized reading'  (duration: 301.455705ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:29.737615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:29.43568Z","time spent":"301.926423ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-17T21:58:29.906436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.950735ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826220388 > lease_revoke:<id:1b2e9cfdcc9ca0a6>","response":"size:28"}
{"level":"info","ts":"2026-03-17T21:58:29.906784Z","caller":"traceutil/trace.go:171","msg":"trace[1372416971] linearizableReadLoop","detail":"{readStateIndex:1121; appliedIndex:1119; }","duration":"101.536133ms","start":"2026-03-17T21:58:29.805234Z","end":"2026-03-17T21:58:29.90677Z","steps":["trace[1372416971] 'read index received'  (duration: 34.222µs)","trace[1372416971] 'applied index is now lower than readState.Index'  (duration: 101.501291ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:29.906838Z","caller":"traceutil/trace.go:171","msg":"trace[1530570188] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"165.654577ms","start":"2026-03-17T21:58:29.741142Z","end":"2026-03-17T21:58:29.906796Z","steps":["trace[1530570188] 'process raft request'  (duration: 165.393282ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:29.906983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.738316ms","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-17T21:58:29.907016Z","caller":"traceutil/trace.go:171","msg":"trace[99701475] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1076; }","duration":"101.803797ms","start":"2026-03-17T21:58:29.805202Z","end":"2026-03-17T21:58:29.907006Z","steps":["trace[99701475] 'agreement among raft nodes before linearized reading'  (duration: 101.651214ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:30.064598Z","caller":"traceutil/trace.go:171","msg":"trace[883948424] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"106.952628ms","start":"2026-03-17T21:58:29.957622Z","end":"2026-03-17T21:58:30.064575Z","steps":["trace[883948424] 'process raft request'  (duration: 106.796416ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:31.10424Z","caller":"traceutil/trace.go:171","msg":"trace[464750396] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"126.819796ms","start":"2026-03-17T21:58:30.977384Z","end":"2026-03-17T21:58:31.104203Z","steps":["trace[464750396] 'process raft request'  (duration: 126.558092ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:31.992063Z","caller":"traceutil/trace.go:171","msg":"trace[791529107] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"184.261303ms","start":"2026-03-17T21:58:31.807766Z","end":"2026-03-17T21:58:31.992027Z","steps":["trace[791529107] 'process raft request'  (duration: 184.126211ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:32.160455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.632822ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826220415 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1076 > 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-17T21:58:32.160578Z","caller":"traceutil/trace.go:171","msg":"trace[1927990737] linearizableReadLoop","detail":"{readStateIndex:1131; appliedIndex:1130; }","duration":"127.910594ms","start":"2026-03-17T21:58:32.032646Z","end":"2026-03-17T21:58:32.160557Z","steps":["trace[1927990737] 'read index received'  (duration: 17.972787ms)","trace[1927990737] 'applied index is now lower than readState.Index'  (duration: 109.936167ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:32.160748Z","caller":"traceutil/trace.go:171","msg":"trace[825279160] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"164.550738ms","start":"2026-03-17T21:58:31.996182Z","end":"2026-03-17T21:58:32.160733Z","steps":["trace[825279160] 'process raft request'  (duration: 54.546271ms)","trace[825279160] 'compare'  (duration: 109.508319ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:32.160891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.233758ms","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-17T21:58:32.160953Z","caller":"traceutil/trace.go:171","msg":"trace[1931180214] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1086; }","duration":"128.31719ms","start":"2026-03-17T21:58:32.032619Z","end":"2026-03-17T21:58:32.160936Z","steps":["trace[1931180214] 'agreement among raft nodes before linearized reading'  (duration: 128.023136ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:32.82147Z","caller":"traceutil/trace.go:171","msg":"trace[435749339] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"115.848901ms","start":"2026-03-17T21:58:32.705564Z","end":"2026-03-17T21:58:32.821413Z","steps":["trace[435749339] 'process raft request'  (duration: 115.725619ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:33.907944Z","caller":"traceutil/trace.go:171","msg":"trace[465497529] linearizableReadLoop","detail":"{readStateIndex:1135; appliedIndex:1134; }","duration":"102.918444ms","start":"2026-03-17T21:58:33.805002Z","end":"2026-03-17T21:58:33.907921Z","steps":["trace[465497529] 'read index received'  (duration: 102.670859ms)","trace[465497529] 'applied index is now lower than readState.Index'  (duration: 246.565µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:33.907995Z","caller":"traceutil/trace.go:171","msg":"trace[38050149] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"114.387928ms","start":"2026-03-17T21:58:33.793587Z","end":"2026-03-17T21:58:33.907975Z","steps":["trace[38050149] 'process raft request'  (duration: 114.187345ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:33.908163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.135437ms","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-17T21:58:33.908216Z","caller":"traceutil/trace.go:171","msg":"trace[759860978] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1090; }","duration":"103.236309ms","start":"2026-03-17T21:58:33.804966Z","end":"2026-03-17T21:58:33.908202Z","steps":["trace[759860978] 'agreement among raft nodes before linearized reading'  (duration: 103.056566ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:34.105209Z","caller":"traceutil/trace.go:171","msg":"trace[1281470969] linearizableReadLoop","detail":"{readStateIndex:1136; appliedIndex:1135; }","duration":"157.351404ms","start":"2026-03-17T21:58:33.947832Z","end":"2026-03-17T21:58:34.105183Z","steps":["trace[1281470969] 'read index received'  (duration: 157.17449ms)","trace[1281470969] 'applied index is now lower than readState.Index'  (duration: 176.014µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:34.105327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.466465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-17T21:58:34.105381Z","caller":"traceutil/trace.go:171","msg":"trace[892252495] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1091; }","duration":"157.565626ms","start":"2026-03-17T21:58:33.947802Z","end":"2026-03-17T21:58:34.105368Z","steps":["trace[892252495] 'agreement among raft nodes before linearized reading'  (duration: 157.469425ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:34.105349Z","caller":"traceutil/trace.go:171","msg":"trace[396914988] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"193.771035ms","start":"2026-03-17T21:58:33.911543Z","end":"2026-03-17T21:58:34.105314Z","steps":["trace[396914988] 'process raft request'  (duration: 193.49227ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:34.508718Z","caller":"traceutil/trace.go:171","msg":"trace[1127840501] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"117.593679ms","start":"2026-03-17T21:58:34.391093Z","end":"2026-03-17T21:58:34.508687Z","steps":["trace[1127840501] 'process raft request'  (duration: 68.21201ms)","trace[1127840501] 'compare'  (duration: 49.235047ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:35.14803Z","caller":"traceutil/trace.go:171","msg":"trace[421017145] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"314.786569ms","start":"2026-03-17T21:58:34.833208Z","end":"2026-03-17T21:58:35.147995Z","steps":["trace[421017145] 'process raft request'  (duration: 314.460964ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:35.148222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:34.833192Z","time spent":"314.92802ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":516,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1088 > 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\" > >"}
{"level":"info","ts":"2026-03-17T21:58:35.51791Z","caller":"traceutil/trace.go:171","msg":"trace[561772486] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"263.487198ms","start":"2026-03-17T21:58:35.254388Z","end":"2026-03-17T21:58:35.517875Z","steps":["trace[561772486] 'process raft request'  (duration: 175.29591ms)","trace[561772486] 'compare'  (duration: 88.058856ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:36.235859Z","caller":"traceutil/trace.go:171","msg":"trace[1535900240] linearizableReadLoop","detail":"{readStateIndex:1145; appliedIndex:1144; }","duration":"147.13533ms","start":"2026-03-17T21:58:36.088699Z","end":"2026-03-17T21:58:36.235834Z","steps":["trace[1535900240] 'read index received'  (duration: 146.995348ms)","trace[1535900240] 'applied index is now lower than readState.Index'  (duration: 139.052µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:36.23597Z","caller":"traceutil/trace.go:171","msg":"trace[304437730] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"201.55428ms","start":"2026-03-17T21:58:36.034382Z","end":"2026-03-17T21:58:36.235936Z","steps":["trace[304437730] 'process raft request'  (duration: 201.296246ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:36.236046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.318033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-17T21:58:36.236108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.795786ms","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-17T21:58:36.236143Z","caller":"traceutil/trace.go:171","msg":"trace[1054722795] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1099; }","duration":"126.876837ms","start":"2026-03-17T21:58:36.109256Z","end":"2026-03-17T21:58:36.236133Z","steps":["trace[1054722795] 'agreement among raft nodes before linearized reading'  (duration: 126.717474ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:36.236144Z","caller":"traceutil/trace.go:171","msg":"trace[1084207716] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1099; }","duration":"147.437594ms","start":"2026-03-17T21:58:36.088684Z","end":"2026-03-17T21:58:36.236121Z","steps":["trace[1084207716] 'agreement among raft nodes before linearized reading'  (duration: 147.265512ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:36.236287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.544597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-03-17T21:58:36.236338Z","caller":"traceutil/trace.go:171","msg":"trace[1730923694] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1099; }","duration":"125.635147ms","start":"2026-03-17T21:58:36.110688Z","end":"2026-03-17T21:58:36.236323Z","steps":["trace[1730923694] 'agreement among raft nodes before linearized reading'  (duration: 125.474994ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:36.391322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.33867ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826220453 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:1080 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:423 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-17T21:58:36.391539Z","caller":"traceutil/trace.go:171","msg":"trace[616108527] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"149.290504ms","start":"2026-03-17T21:58:36.242229Z","end":"2026-03-17T21:58:36.39152Z","steps":["trace[616108527] 'process raft request'  (duration: 149.225874ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:36.391608Z","caller":"traceutil/trace.go:171","msg":"trace[1836529871] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"150.92793ms","start":"2026-03-17T21:58:36.240605Z","end":"2026-03-17T21:58:36.391533Z","steps":["trace[1836529871] 'process raft request'  (duration: 37.305785ms)","trace[1836529871] 'compare'  (duration: 113.234979ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:36.391757Z","caller":"traceutil/trace.go:171","msg":"trace[1332175160] linearizableReadLoop","detail":"{readStateIndex:1146; appliedIndex:1145; }","duration":"150.431813ms","start":"2026-03-17T21:58:36.241315Z","end":"2026-03-17T21:58:36.391746Z","steps":["trace[1332175160] 'read index received'  (duration: 36.590254ms)","trace[1332175160] 'applied index is now lower than readState.Index'  (duration: 113.840629ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:36.391825Z","caller":"traceutil/trace.go:171","msg":"trace[819161455] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"150.340712ms","start":"2026-03-17T21:58:36.241478Z","end":"2026-03-17T21:58:36.391819Z","steps":["trace[819161455] 'process raft request'  (duration: 149.932995ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:36.392038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.701777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-17T21:58:36.392096Z","caller":"traceutil/trace.go:171","msg":"trace[174603797] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1102; }","duration":"150.811619ms","start":"2026-03-17T21:58:36.241272Z","end":"2026-03-17T21:58:36.392084Z","steps":["trace[174603797] 'agreement among raft nodes before linearized reading'  (duration: 150.571765ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:36.392207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.537488ms","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-17T21:58:36.392299Z","caller":"traceutil/trace.go:171","msg":"trace[1823463681] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1102; }","duration":"112.674329ms","start":"2026-03-17T21:58:36.279603Z","end":"2026-03-17T21:58:36.392277Z","steps":["trace[1823463681] 'agreement among raft nodes before linearized reading'  (duration: 112.307304ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:46.638289Z","caller":"traceutil/trace.go:171","msg":"trace[34033728] linearizableReadLoop","detail":"{readStateIndex:1190; appliedIndex:1189; }","duration":"104.139434ms","start":"2026-03-17T21:58:46.534103Z","end":"2026-03-17T21:58:46.638242Z","steps":["trace[34033728] 'read index received'  (duration: 103.387542ms)","trace[34033728] 'applied index is now lower than readState.Index'  (duration: 750.782µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:46.638368Z","caller":"traceutil/trace.go:171","msg":"trace[851127552] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"161.185264ms","start":"2026-03-17T21:58:46.47714Z","end":"2026-03-17T21:58:46.638325Z","steps":["trace[851127552] 'process raft request'  (duration: 160.402092ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:46.638604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.489939ms","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-17T21:58:46.63873Z","caller":"traceutil/trace.go:171","msg":"trace[1128694416] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1142; }","duration":"104.626001ms","start":"2026-03-17T21:58:46.534051Z","end":"2026-03-17T21:58:46.638677Z","steps":["trace[1128694416] 'agreement among raft nodes before linearized reading'  (duration: 104.344627ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:46.870236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.353805ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826220558 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1134 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-17T21:58:46.870415Z","caller":"traceutil/trace.go:171","msg":"trace[1359643146] linearizableReadLoop","detail":"{readStateIndex:1192; appliedIndex:1190; }","duration":"198.972787ms","start":"2026-03-17T21:58:46.671427Z","end":"2026-03-17T21:58:46.8704Z","steps":["trace[1359643146] 'read index received'  (duration: 81.45341ms)","trace[1359643146] 'applied index is now lower than readState.Index'  (duration: 117.518407ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:46.870577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.156971ms","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-17T21:58:46.87057Z","caller":"traceutil/trace.go:171","msg":"trace[1652119989] transaction","detail":"{read_only:false; response_revision:1143; number_of_response:1; }","duration":"227.29733ms","start":"2026-03-17T21:58:46.643225Z","end":"2026-03-17T21:58:46.870522Z","steps":["trace[1652119989] 'process raft request'  (duration: 109.57917ms)","trace[1652119989] 'compare'  (duration: 117.225763ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:46.870546Z","caller":"traceutil/trace.go:171","msg":"trace[108961227] transaction","detail":"{read_only:false; response_revision:1144; number_of_response:1; }","duration":"220.308658ms","start":"2026-03-17T21:58:46.650201Z","end":"2026-03-17T21:58:46.87051Z","steps":["trace[108961227] 'process raft request'  (duration: 220.143016ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:46.870618Z","caller":"traceutil/trace.go:171","msg":"trace[469187141] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1144; }","duration":"199.262103ms","start":"2026-03-17T21:58:46.671345Z","end":"2026-03-17T21:58:46.870607Z","steps":["trace[469187141] 'agreement among raft nodes before linearized reading'  (duration: 199.10118ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:47.458458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.26057ms","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:530"}
{"level":"info","ts":"2026-03-17T21:58:47.458516Z","caller":"traceutil/trace.go:171","msg":"trace[21656268] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1146; }","duration":"175.376261ms","start":"2026-03-17T21:58:47.283129Z","end":"2026-03-17T21:58:47.458505Z","steps":["trace[21656268] 'range keys from in-memory index tree'  (duration: 174.991885ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:49.046786Z","caller":"traceutil/trace.go:171","msg":"trace[1037888422] transaction","detail":"{read_only:false; response_revision:1152; number_of_response:1; }","duration":"121.109265ms","start":"2026-03-17T21:58:48.925654Z","end":"2026-03-17T21:58:49.046763Z","steps":["trace[1037888422] 'process raft request'  (duration: 119.049612ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:49.136167Z","caller":"traceutil/trace.go:171","msg":"trace[1329536247] transaction","detail":"{read_only:false; response_revision:1153; number_of_response:1; }","duration":"117.510337ms","start":"2026-03-17T21:58:49.018639Z","end":"2026-03-17T21:58:49.136149Z","steps":["trace[1329536247] 'process raft request'  (duration: 117.296343ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:49.966236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.790815ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826220584 > lease_revoke:<id:1b2e9cfdcc9ca192>","response":"size:28"}
{"level":"info","ts":"2026-03-17T21:58:50.040889Z","caller":"traceutil/trace.go:171","msg":"trace[391906284] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"259.026008ms","start":"2026-03-17T21:58:49.781828Z","end":"2026-03-17T21:58:50.040854Z","steps":["trace[391906284] 'process raft request'  (duration: 258.802824ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:50.495683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.976354ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826220586 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1114 > 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-17T21:58:50.495795Z","caller":"traceutil/trace.go:171","msg":"trace[1280749134] linearizableReadLoop","detail":"{readStateIndex:1205; appliedIndex:1204; }","duration":"134.095043ms","start":"2026-03-17T21:58:50.361681Z","end":"2026-03-17T21:58:50.495776Z","steps":["trace[1280749134] 'read index received'  (duration: 41.041µs)","trace[1280749134] 'applied index is now lower than readState.Index'  (duration: 134.052662ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:50.495878Z","caller":"traceutil/trace.go:171","msg":"trace[207398268] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"662.013345ms","start":"2026-03-17T21:58:49.833852Z","end":"2026-03-17T21:58:50.495865Z","steps":["trace[207398268] 'process raft request'  (duration: 466.525552ms)","trace[207398268] 'compare'  (duration: 194.711061ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:50.49594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:49.833823Z","time spent":"662.086446ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1114 > 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-17T21:58:50.496526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.792674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-17T21:58:50.497151Z","caller":"traceutil/trace.go:171","msg":"trace[694326915] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1156; }","duration":"135.480174ms","start":"2026-03-17T21:58:50.361646Z","end":"2026-03-17T21:58:50.497126Z","steps":["trace[694326915] 'agreement among raft nodes before linearized reading'  (duration: 134.62463ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:50.863031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.628333ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826220589 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" mod_revision:1137 > success:<request_put:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" value_size:439 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-17T21:58:50.863253Z","caller":"traceutil/trace.go:171","msg":"trace[562066428] linearizableReadLoop","detail":"{readStateIndex:1207; appliedIndex:1205; }","duration":"216.713282ms","start":"2026-03-17T21:58:50.64651Z","end":"2026-03-17T21:58:50.863224Z","steps":["trace[562066428] 'read index received'  (duration: 131.43592ms)","trace[562066428] 'applied index is now lower than readState.Index'  (duration: 85.276222ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:50.863442Z","caller":"traceutil/trace.go:171","msg":"trace[646169079] transaction","detail":"{read_only:false; response_revision:1157; number_of_response:1; }","duration":"363.472036ms","start":"2026-03-17T21:58:50.499957Z","end":"2026-03-17T21:58:50.863429Z","steps":["trace[646169079] 'process raft request'  (duration: 102.361085ms)","trace[646169079] 'compare'  (duration: 260.41541ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:50.863516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:50.499941Z","time spent":"363.536157ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" mod_revision:1137 > success:<request_put:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" value_size:439 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-03-17T21:58:50.863518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.989446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T21:58:50.863631Z","caller":"traceutil/trace.go:171","msg":"trace[1631525402] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1158; }","duration":"217.137628ms","start":"2026-03-17T21:58:50.646475Z","end":"2026-03-17T21:58:50.863612Z","steps":["trace[1631525402] 'agreement among raft nodes before linearized reading'  (duration: 216.964515ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:50.863552Z","caller":"traceutil/trace.go:171","msg":"trace[215095666] transaction","detail":"{read_only:false; response_revision:1158; number_of_response:1; }","duration":"362.48935ms","start":"2026-03-17T21:58:50.501032Z","end":"2026-03-17T21:58:50.863521Z","steps":["trace[215095666] 'process raft request'  (duration: 362.114444ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:50.86397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:50.501023Z","time spent":"362.851866ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1149 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-17T21:58:51.162987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.818537ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826220594 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1150 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-17T21:58:51.163513Z","caller":"traceutil/trace.go:171","msg":"trace[1346060525] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"237.875569ms","start":"2026-03-17T21:58:50.925568Z","end":"2026-03-17T21:58:51.163444Z","steps":["trace[1346060525] 'process raft request'  (duration: 63.509734ms)","trace[1346060525] 'compare'  (duration: 173.535942ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:51.163638Z","caller":"traceutil/trace.go:171","msg":"trace[932341421] transaction","detail":"{read_only:false; response_revision:1160; number_of_response:1; }","duration":"235.316659ms","start":"2026-03-17T21:58:50.928291Z","end":"2026-03-17T21:58:51.163607Z","steps":["trace[932341421] 'process raft request'  (duration: 235.034774ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:51.163869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.766318ms","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-17T21:58:51.163911Z","caller":"traceutil/trace.go:171","msg":"trace[526350153] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1160; }","duration":"113.859419ms","start":"2026-03-17T21:58:51.05004Z","end":"2026-03-17T21:58:51.1639Z","steps":["trace[526350153] 'agreement among raft nodes before linearized reading'  (duration: 113.705657ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:51.163411Z","caller":"traceutil/trace.go:171","msg":"trace[2044093934] linearizableReadLoop","detail":"{readStateIndex:1209; appliedIndex:1207; }","duration":"113.282479ms","start":"2026-03-17T21:58:51.050108Z","end":"2026-03-17T21:58:51.163391Z","steps":["trace[2044093934] 'read index received'  (duration: 111.340869ms)","trace[2044093934] 'applied index is now lower than readState.Index'  (duration: 1.94065ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:51.428872Z","caller":"traceutil/trace.go:171","msg":"trace[1020495578] transaction","detail":"{read_only:false; response_revision:1161; number_of_response:1; }","duration":"260.652193ms","start":"2026-03-17T21:58:51.168182Z","end":"2026-03-17T21:58:51.428834Z","steps":["trace[1020495578] 'process raft request'  (duration: 177.493975ms)","trace[1020495578] 'compare'  (duration: 82.863443ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:51.705866Z","caller":"traceutil/trace.go:171","msg":"trace[904385890] linearizableReadLoop","detail":"{readStateIndex:1212; appliedIndex:1210; }","duration":"168.126525ms","start":"2026-03-17T21:58:51.53772Z","end":"2026-03-17T21:58:51.705847Z","steps":["trace[904385890] 'read index received'  (duration: 167.938112ms)","trace[904385890] 'applied index is now lower than readState.Index'  (duration: 187.113µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:51.705952Z","caller":"traceutil/trace.go:171","msg":"trace[24027932] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"251.218173ms","start":"2026-03-17T21:58:51.454708Z","end":"2026-03-17T21:58:51.705926Z","steps":["trace[24027932] 'process raft request'  (duration: 250.963499ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:51.706024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.284147ms","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-17T21:58:51.706049Z","caller":"traceutil/trace.go:171","msg":"trace[591591836] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1163; }","duration":"168.373079ms","start":"2026-03-17T21:58:51.537668Z","end":"2026-03-17T21:58:51.706041Z","steps":["trace[591591836] 'agreement among raft nodes before linearized reading'  (duration: 168.256987ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:51.706027Z","caller":"traceutil/trace.go:171","msg":"trace[824887820] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"251.254074ms","start":"2026-03-17T21:58:51.454731Z","end":"2026-03-17T21:58:51.705985Z","steps":["trace[824887820] 'process raft request'  (duration: 251.076481ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:51.920373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.919535ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826220604 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:1154 > 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-17T21:58:51.920475Z","caller":"traceutil/trace.go:171","msg":"trace[1791249399] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"209.786132ms","start":"2026-03-17T21:58:51.710666Z","end":"2026-03-17T21:58:51.920452Z","steps":["trace[1791249399] 'process raft request'  (duration: 64.708863ms)","trace[1791249399] 'compare'  (duration: 144.808884ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:53.556827Z","caller":"traceutil/trace.go:171","msg":"trace[1672406019] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"355.942602ms","start":"2026-03-17T21:58:53.200858Z","end":"2026-03-17T21:58:53.556801Z","steps":["trace[1672406019] 'process raft request'  (duration: 355.784228ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:53.556974Z","caller":"traceutil/trace.go:171","msg":"trace[1448333993] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"356.078586ms","start":"2026-03-17T21:58:53.200871Z","end":"2026-03-17T21:58:53.556949Z","steps":["trace[1448333993] 'process raft request'  (duration: 355.897751ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:53.557002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:53.200831Z","time spent":"356.090706ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1159 > 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-17T21:58:53.557014Z","caller":"traceutil/trace.go:171","msg":"trace[1787269114] linearizableReadLoop","detail":"{readStateIndex:1218; appliedIndex:1216; }","duration":"198.764803ms","start":"2026-03-17T21:58:53.358227Z","end":"2026-03-17T21:58:53.556992Z","steps":["trace[1787269114] 'read index received'  (duration: 198.326922ms)","trace[1787269114] 'applied index is now lower than readState.Index'  (duration: 435.831µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:53.557098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:53.200844Z","time spent":"356.191989ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1160 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-17T21:58:53.557174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.947168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-17T21:58:53.557345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.120727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-17T21:58:53.55742Z","caller":"traceutil/trace.go:171","msg":"trace[1912515280] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1169; }","duration":"124.238741ms","start":"2026-03-17T21:58:53.433167Z","end":"2026-03-17T21:58:53.557406Z","steps":["trace[1912515280] 'agreement among raft nodes before linearized reading'  (duration: 124.056326ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:53.557506Z","caller":"traceutil/trace.go:171","msg":"trace[1652127243] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1169; }","duration":"199.219114ms","start":"2026-03-17T21:58:53.358177Z","end":"2026-03-17T21:58:53.557396Z","steps":["trace[1652127243] 'agreement among raft nodes before linearized reading'  (duration: 198.947908ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:55.747137Z","caller":"traceutil/trace.go:171","msg":"trace[594124885] linearizableReadLoop","detail":"{readStateIndex:1227; appliedIndex:1226; }","duration":"100.530836ms","start":"2026-03-17T21:58:55.646585Z","end":"2026-03-17T21:58:55.747116Z","steps":["trace[594124885] 'read index received'  (duration: 96.40112ms)","trace[594124885] 'applied index is now lower than readState.Index'  (duration: 4.128726ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:55.747264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.648978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T21:58:55.747296Z","caller":"traceutil/trace.go:171","msg":"trace[1368756459] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1177; }","duration":"100.737791ms","start":"2026-03-17T21:58:55.64655Z","end":"2026-03-17T21:58:55.747288Z","steps":["trace[1368756459] 'agreement among raft nodes before linearized reading'  (duration: 100.644109ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:55.747334Z","caller":"traceutil/trace.go:171","msg":"trace[1374494596] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"101.275485ms","start":"2026-03-17T21:58:55.646012Z","end":"2026-03-17T21:58:55.747287Z","steps":["trace[1374494596] 'process raft request'  (duration: 96.964165ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:56.13882Z","caller":"traceutil/trace.go:171","msg":"trace[180265878] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"158.993307ms","start":"2026-03-17T21:58:55.979806Z","end":"2026-03-17T21:58:56.1388Z","steps":["trace[180265878] 'process raft request'  (duration: 108.825116ms)","trace[180265878] 'compare'  (duration: 50.091099ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:56.826117Z","caller":"traceutil/trace.go:171","msg":"trace[1334426354] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"110.753206ms","start":"2026-03-17T21:58:56.715335Z","end":"2026-03-17T21:58:56.826088Z","steps":["trace[1334426354] 'process raft request'  (duration: 110.602012ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:57.028041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.103595ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826220654 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" mod_revision:1162 > success:<request_put:<key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" value_size:432 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-17T21:58:57.028708Z","caller":"traceutil/trace.go:171","msg":"trace[819896619] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"313.033978ms","start":"2026-03-17T21:58:56.715636Z","end":"2026-03-17T21:58:57.02867Z","steps":["trace[819896619] 'process raft request'  (duration: 190.196034ms)","trace[819896619] 'compare'  (duration: 121.988863ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:57.0288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:56.715623Z","time spent":"313.13485ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" mod_revision:1162 > success:<request_put:<key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" value_size:432 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-03-17T21:58:57.0294Z","caller":"traceutil/trace.go:171","msg":"trace[77985847] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"215.099388ms","start":"2026-03-17T21:58:56.814245Z","end":"2026-03-17T21:58:57.029345Z","steps":["trace[77985847] 'process raft request'  (duration: 214.39295ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:57.301144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.944256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:471"}
{"level":"info","ts":"2026-03-17T21:58:57.301228Z","caller":"traceutil/trace.go:171","msg":"trace[2033567849] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1184; }","duration":"132.10696ms","start":"2026-03-17T21:58:57.169102Z","end":"2026-03-17T21:58:57.301209Z","steps":["trace[2033567849] 'range keys from in-memory index tree'  (duration: 131.785652ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:58:57.949616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.754607ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826220666 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1176 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-17T21:58:57.949785Z","caller":"traceutil/trace.go:171","msg":"trace[894487050] linearizableReadLoop","detail":"{readStateIndex:1237; appliedIndex:1236; }","duration":"176.183936ms","start":"2026-03-17T21:58:57.773584Z","end":"2026-03-17T21:58:57.949768Z","steps":["trace[894487050] 'read index received'  (duration: 43.08801ms)","trace[894487050] 'applied index is now lower than readState.Index'  (duration: 133.094576ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:58:57.949856Z","caller":"traceutil/trace.go:171","msg":"trace[247867684] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"299.166463ms","start":"2026-03-17T21:58:57.650661Z","end":"2026-03-17T21:58:57.949828Z","steps":["trace[247867684] 'process raft request'  (duration: 166.085867ms)","trace[247867684] 'compare'  (duration: 132.568813ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:58:57.950036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.449342ms","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-17T21:58:57.950128Z","caller":"traceutil/trace.go:171","msg":"trace[1582157319] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1187; }","duration":"176.576225ms","start":"2026-03-17T21:58:57.773534Z","end":"2026-03-17T21:58:57.95011Z","steps":["trace[1582157319] 'agreement among raft nodes before linearized reading'  (duration: 176.305889ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:58:59.964995Z","caller":"traceutil/trace.go:171","msg":"trace[2069634654] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"224.97254ms","start":"2026-03-17T21:58:59.739973Z","end":"2026-03-17T21:58:59.964946Z","steps":["trace[2069634654] 'process raft request'  (duration: 224.713424ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:59:00.101241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.689993ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826220680 > lease_revoke:<id:1b2e9cfdcc9ca1ef>","response":"size:28"}
{"level":"info","ts":"2026-03-17T21:59:00.101335Z","caller":"traceutil/trace.go:171","msg":"trace[710716497] linearizableReadLoop","detail":"{readStateIndex:1243; appliedIndex:1241; }","duration":"147.566696ms","start":"2026-03-17T21:58:59.95375Z","end":"2026-03-17T21:59:00.101317Z","steps":["trace[710716497] 'read index received'  (duration: 10.94504ms)","trace[710716497] 'applied index is now lower than readState.Index'  (duration: 136.620276ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:59:00.101623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.843193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-17T21:59:00.101693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.570849ms","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-17T21:59:00.101758Z","caller":"traceutil/trace.go:171","msg":"trace[112317229] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1192; }","duration":"104.677711ms","start":"2026-03-17T21:58:59.997063Z","end":"2026-03-17T21:59:00.101741Z","steps":["trace[112317229] 'agreement among raft nodes before linearized reading'  (duration: 104.373563ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:59:00.101756Z","caller":"traceutil/trace.go:171","msg":"trace[1571376496] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1192; }","duration":"148.017187ms","start":"2026-03-17T21:58:59.953716Z","end":"2026-03-17T21:59:00.101733Z","steps":["trace[1571376496] 'agreement among raft nodes before linearized reading'  (duration: 147.693948ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:59:01.37292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.875107ms","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-17T21:59:01.372985Z","caller":"traceutil/trace.go:171","msg":"trace[524201865] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1198; }","duration":"291.989651ms","start":"2026-03-17T21:59:01.080983Z","end":"2026-03-17T21:59:01.372972Z","steps":["trace[524201865] 'range keys from in-memory index tree'  (duration: 291.657701ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:59:02.277815Z","caller":"traceutil/trace.go:171","msg":"trace[1694299192] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"136.266948ms","start":"2026-03-17T21:59:02.141527Z","end":"2026-03-17T21:59:02.277794Z","steps":["trace[1694299192] 'process raft request'  (duration: 94.722548ms)","trace[1694299192] 'compare'  (duration: 41.372506ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:59:02.527612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.676755ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826220712 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1196 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-17T21:59:02.527718Z","caller":"traceutil/trace.go:171","msg":"trace[2011321451] linearizableReadLoop","detail":"{readStateIndex:1257; appliedIndex:1256; }","duration":"210.297686ms","start":"2026-03-17T21:59:02.317404Z","end":"2026-03-17T21:59:02.527702Z","steps":["trace[2011321451] 'read index received'  (duration: 108.389265ms)","trace[2011321451] 'applied index is now lower than readState.Index'  (duration: 101.907111ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:59:02.52785Z","caller":"traceutil/trace.go:171","msg":"trace[1237366706] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"240.012555ms","start":"2026-03-17T21:59:02.287815Z","end":"2026-03-17T21:59:02.527828Z","steps":["trace[1237366706] 'process raft request'  (duration: 138.026642ms)","trace[1237366706] 'compare'  (duration: 101.559751ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:59:02.528137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.546173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:471"}
{"level":"info","ts":"2026-03-17T21:59:02.528177Z","caller":"traceutil/trace.go:171","msg":"trace[1296534023] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1206; }","duration":"210.860622ms","start":"2026-03-17T21:59:02.317304Z","end":"2026-03-17T21:59:02.528165Z","steps":["trace[1296534023] 'agreement among raft nodes before linearized reading'  (duration: 210.438751ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:59:02.878146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.705342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T21:59:02.878239Z","caller":"traceutil/trace.go:171","msg":"trace[5404694] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1207; }","duration":"231.877228ms","start":"2026-03-17T21:59:02.646344Z","end":"2026-03-17T21:59:02.878221Z","steps":["trace[5404694] 'range keys from in-memory index tree'  (duration: 231.626681ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:59:04.544085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.973861ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826220730 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:1205 > 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-17T21:59:04.54421Z","caller":"traceutil/trace.go:171","msg":"trace[1913298715] linearizableReadLoop","detail":"{readStateIndex:1263; appliedIndex:1261; }","duration":"201.978003ms","start":"2026-03-17T21:59:04.34221Z","end":"2026-03-17T21:59:04.544188Z","steps":["trace[1913298715] 'read index received'  (duration: 36.404179ms)","trace[1913298715] 'applied index is now lower than readState.Index'  (duration: 165.569904ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:59:04.544306Z","caller":"traceutil/trace.go:171","msg":"trace[288026823] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"227.610527ms","start":"2026-03-17T21:59:04.31666Z","end":"2026-03-17T21:59:04.54427Z","steps":["trace[288026823] 'process raft request'  (duration: 71.315029ms)","trace[288026823] 'compare'  (duration: 155.842908ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:59:04.544441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.23089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.112\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-17T21:59:04.544501Z","caller":"traceutil/trace.go:171","msg":"trace[1223248189] range","detail":"{range_begin:/registry/masterleases/199.19.213.112; range_end:; response_count:1; response_revision:1212; }","duration":"202.328123ms","start":"2026-03-17T21:59:04.342158Z","end":"2026-03-17T21:59:04.544486Z","steps":["trace[1223248189] 'agreement among raft nodes before linearized reading'  (duration: 202.156718ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:59:04.689079Z","caller":"traceutil/trace.go:171","msg":"trace[789506610] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"141.223113ms","start":"2026-03-17T21:59:04.547815Z","end":"2026-03-17T21:59:04.689038Z","steps":["trace[789506610] 'process raft request'  (duration: 140.365402ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:59:05.625954Z","caller":"traceutil/trace.go:171","msg":"trace[423258831] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"102.951047ms","start":"2026-03-17T21:59:05.522976Z","end":"2026-03-17T21:59:05.625927Z","steps":["trace[423258831] 'process raft request'  (duration: 102.760362ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:59:06.473152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.443431ms","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-17T21:59:06.473218Z","caller":"traceutil/trace.go:171","msg":"trace[481640226] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1217; }","duration":"156.561295ms","start":"2026-03-17T21:59:06.316642Z","end":"2026-03-17T21:59:06.473203Z","steps":["trace[481640226] 'range keys from in-memory index tree'  (duration: 156.274598ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:59:06.584465Z","caller":"traceutil/trace.go:171","msg":"trace[1571720084] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"107.973995ms","start":"2026-03-17T21:59:06.476475Z","end":"2026-03-17T21:59:06.584449Z","steps":["trace[1571720084] 'process raft request'  (duration: 107.871153ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:59:06.624885Z","caller":"traceutil/trace.go:171","msg":"trace[1214727717] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"147.361089ms","start":"2026-03-17T21:59:06.477497Z","end":"2026-03-17T21:59:06.624858Z","steps":["trace[1214727717] 'process raft request'  (duration: 147.201295ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:59:06.855557Z","caller":"traceutil/trace.go:171","msg":"trace[1773723830] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"129.197438ms","start":"2026-03-17T21:59:06.726313Z","end":"2026-03-17T21:59:06.85551Z","steps":["trace[1773723830] 'process raft request'  (duration: 129.047773ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:59:07.035352Z","caller":"traceutil/trace.go:171","msg":"trace[1866844309] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"172.684176ms","start":"2026-03-17T21:59:06.862636Z","end":"2026-03-17T21:59:07.035321Z","steps":["trace[1866844309] 'process raft request'  (duration: 103.724087ms)","trace[1866844309] 'compare'  (duration: 68.812345ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:59:07.547652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.440203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T21:59:07.547729Z","caller":"traceutil/trace.go:171","msg":"trace[1895971846] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1222; }","duration":"363.576386ms","start":"2026-03-17T21:59:07.184132Z","end":"2026-03-17T21:59:07.547708Z","steps":["trace[1895971846] 'count revisions from in-memory index tree'  (duration: 363.345442ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:59:07.547775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:59:07.184111Z","time spent":"363.653139ms","remote":"127.0.0.1:46542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "}
{"level":"warn","ts":"2026-03-17T21:59:07.547893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.320807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:524"}
{"level":"info","ts":"2026-03-17T21:59:07.547968Z","caller":"traceutil/trace.go:171","msg":"trace[412448602] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1222; }","duration":"404.469851ms","start":"2026-03-17T21:59:07.143481Z","end":"2026-03-17T21:59:07.547951Z","steps":["trace[412448602] 'range keys from in-memory index tree'  (duration: 404.117472ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:59:07.547949Z","caller":"traceutil/trace.go:171","msg":"trace[2443790] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"202.755443ms","start":"2026-03-17T21:59:07.345166Z","end":"2026-03-17T21:59:07.547922Z","steps":["trace[2443790] 'process raft request'  (duration: 128.272672ms)","trace[2443790] 'compare'  (duration: 74.369079ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:59:07.548001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:59:07.14346Z","time spent":"404.533942ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":547,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-03-17T21:59:07.822527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.811334ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826220765 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:1207 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:404 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-17T21:59:07.822664Z","caller":"traceutil/trace.go:171","msg":"trace[2102909296] linearizableReadLoop","detail":"{readStateIndex:1277; appliedIndex:1276; }","duration":"191.690231ms","start":"2026-03-17T21:59:07.630951Z","end":"2026-03-17T21:59:07.822642Z","steps":["trace[2102909296] 'read index received'  (duration: 21.595021ms)","trace[2102909296] 'applied index is now lower than readState.Index'  (duration: 170.09327ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:59:07.822703Z","caller":"traceutil/trace.go:171","msg":"trace[1797025211] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"192.490481ms","start":"2026-03-17T21:59:07.630164Z","end":"2026-03-17T21:59:07.822654Z","steps":["trace[1797025211] 'process raft request'  (duration: 22.419372ms)","trace[1797025211] 'compare'  (duration: 169.617047ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:59:07.822895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.951121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T21:59:07.822952Z","caller":"traceutil/trace.go:171","msg":"trace[2070750277] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1225; }","duration":"178.059804ms","start":"2026-03-17T21:59:07.644877Z","end":"2026-03-17T21:59:07.822937Z","steps":["trace[2070750277] 'agreement among raft nodes before linearized reading'  (duration: 177.95126ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:59:07.822883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.926907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-17T21:59:07.823115Z","caller":"traceutil/trace.go:171","msg":"trace[1330226034] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1225; }","duration":"192.256496ms","start":"2026-03-17T21:59:07.630842Z","end":"2026-03-17T21:59:07.823099Z","steps":["trace[1330226034] 'agreement among raft nodes before linearized reading'  (duration: 191.918917ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:59:08.1141Z","caller":"traceutil/trace.go:171","msg":"trace[1912922011] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"283.811542ms","start":"2026-03-17T21:59:07.830231Z","end":"2026-03-17T21:59:08.114042Z","steps":["trace[1912922011] 'process raft request'  (duration: 283.641448ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:59:08.731332Z","caller":"traceutil/trace.go:171","msg":"trace[96070930] linearizableReadLoop","detail":"{readStateIndex:1280; appliedIndex:1279; }","duration":"102.371753ms","start":"2026-03-17T21:59:08.628937Z","end":"2026-03-17T21:59:08.731309Z","steps":["trace[96070930] 'read index received'  (duration: 102.200458ms)","trace[96070930] 'applied index is now lower than readState.Index'  (duration: 170.745µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:59:08.731394Z","caller":"traceutil/trace.go:171","msg":"trace[329820035] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"102.590427ms","start":"2026-03-17T21:59:08.62879Z","end":"2026-03-17T21:59:08.73138Z","steps":["trace[329820035] 'process raft request'  (duration: 102.393943ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:59:08.73149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.533756ms","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-17T21:59:08.731695Z","caller":"traceutil/trace.go:171","msg":"trace[278511615] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1228; }","duration":"102.759792ms","start":"2026-03-17T21:59:08.628915Z","end":"2026-03-17T21:59:08.731675Z","steps":["trace[278511615] 'agreement among raft nodes before linearized reading'  (duration: 102.471924ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:59:08.868658Z","caller":"traceutil/trace.go:171","msg":"trace[44087487] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"132.653934ms","start":"2026-03-17T21:59:08.735976Z","end":"2026-03-17T21:59:08.86863Z","steps":["trace[44087487] 'process raft request'  (duration: 103.405188ms)","trace[44087487] 'compare'  (duration: 28.796855ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:59:08.868713Z","caller":"traceutil/trace.go:171","msg":"trace[1054513152] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"132.692255ms","start":"2026-03-17T21:59:08.735988Z","end":"2026-03-17T21:59:08.86868Z","steps":["trace[1054513152] 'process raft request'  (duration: 132.324136ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:59:10.275338Z","caller":"traceutil/trace.go:171","msg":"trace[603454641] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"122.009123ms","start":"2026-03-17T21:59:10.153306Z","end":"2026-03-17T21:59:10.275315Z","steps":["trace[603454641] 'process raft request'  (duration: 121.818438ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:59:10.974295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.190423ms","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-17T21:59:10.974359Z","caller":"traceutil/trace.go:171","msg":"trace[1840718787] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1234; }","duration":"101.309006ms","start":"2026-03-17T21:59:10.873037Z","end":"2026-03-17T21:59:10.974346Z","steps":["trace[1840718787] 'range keys from in-memory index tree'  (duration: 101.001458ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:59:10.9743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.175392ms","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-17T21:59:10.974477Z","caller":"traceutil/trace.go:171","msg":"trace[677875966] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1234; }","duration":"101.355786ms","start":"2026-03-17T21:59:10.873101Z","end":"2026-03-17T21:59:10.974456Z","steps":["trace[677875966] 'range keys from in-memory index tree'  (duration: 101.022548ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:59:12.904253Z","caller":"traceutil/trace.go:171","msg":"trace[2093513062] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"113.178538ms","start":"2026-03-17T21:59:12.791043Z","end":"2026-03-17T21:59:12.904222Z","steps":["trace[2093513062] 'process raft request'  (duration: 112.922891ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:59:14.778948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.403849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T21:59:14.779254Z","caller":"traceutil/trace.go:171","msg":"trace[540403518] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1251; }","duration":"132.756729ms","start":"2026-03-17T21:59:14.646474Z","end":"2026-03-17T21:59:14.779231Z","steps":["trace[540403518] 'range keys from in-memory index tree'  (duration: 132.337187ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:59:17.239989Z","caller":"traceutil/trace.go:171","msg":"trace[1387105145] linearizableReadLoop","detail":"{readStateIndex:1313; appliedIndex:1312; }","duration":"140.161157ms","start":"2026-03-17T21:59:17.099804Z","end":"2026-03-17T21:59:17.239965Z","steps":["trace[1387105145] 'read index received'  (duration: 139.944001ms)","trace[1387105145] 'applied index is now lower than readState.Index'  (duration: 216.226µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:59:17.240022Z","caller":"traceutil/trace.go:171","msg":"trace[1414596166] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"301.218266ms","start":"2026-03-17T21:59:16.938779Z","end":"2026-03-17T21:59:17.239997Z","steps":["trace[1414596166] 'process raft request'  (duration: 301.056841ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:59:17.240213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.397103ms","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-17T21:59:17.240249Z","caller":"traceutil/trace.go:171","msg":"trace[119847147] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1259; }","duration":"140.489805ms","start":"2026-03-17T21:59:17.099749Z","end":"2026-03-17T21:59:17.240239Z","steps":["trace[119847147] 'agreement among raft nodes before linearized reading'  (duration: 140.331871ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:59:17.240295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:59:16.938755Z","time spent":"301.409091ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1252 > 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-17T21:59:17.485426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.931678ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826220865 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1253 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-17T21:59:17.485548Z","caller":"traceutil/trace.go:171","msg":"trace[1748255154] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"241.861532ms","start":"2026-03-17T21:59:17.243659Z","end":"2026-03-17T21:59:17.48552Z","steps":["trace[1748255154] 'process raft request'  (duration: 123.760709ms)","trace[1748255154] 'compare'  (duration: 117.799105ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:59:17.512006Z","caller":"traceutil/trace.go:171","msg":"trace[382536507] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"267.863405ms","start":"2026-03-17T21:59:17.244118Z","end":"2026-03-17T21:59:17.511981Z","steps":["trace[382536507] 'process raft request'  (duration: 267.790773ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:59:17.512058Z","caller":"traceutil/trace.go:171","msg":"trace[1783938289] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"267.950428ms","start":"2026-03-17T21:59:17.244062Z","end":"2026-03-17T21:59:17.512013Z","steps":["trace[1783938289] 'process raft request'  (duration: 267.725712ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T21:59:17.512173Z","caller":"traceutil/trace.go:171","msg":"trace[1170891519] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"267.236889ms","start":"2026-03-17T21:59:17.244905Z","end":"2026-03-17T21:59:17.512142Z","steps":["trace[1170891519] 'process raft request'  (duration: 267.045084ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:59:17.834086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.733492ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826220869 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1223 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-17T21:59:17.834164Z","caller":"traceutil/trace.go:171","msg":"trace[1587077880] linearizableReadLoop","detail":"{readStateIndex:1318; appliedIndex:1317; }","duration":"188.683304ms","start":"2026-03-17T21:59:17.645468Z","end":"2026-03-17T21:59:17.834151Z","steps":["trace[1587077880] 'read index received'  (duration: 45.715817ms)","trace[1587077880] 'applied index is now lower than readState.Index'  (duration: 142.966677ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T21:59:17.834232Z","caller":"traceutil/trace.go:171","msg":"trace[1262923702] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"263.045011ms","start":"2026-03-17T21:59:17.571179Z","end":"2026-03-17T21:59:17.834224Z","steps":["trace[1262923702] 'process raft request'  (duration: 120.111934ms)","trace[1262923702] 'compare'  (duration: 142.65093ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T21:59:17.834342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.87648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T21:59:17.834361Z","caller":"traceutil/trace.go:171","msg":"trace[361445585] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1264; }","duration":"188.946151ms","start":"2026-03-17T21:59:17.645409Z","end":"2026-03-17T21:59:17.834355Z","steps":["trace[361445585] 'agreement among raft nodes before linearized reading'  (duration: 188.91203ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T21:59:17.834535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.505951ms","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:525"}
{"level":"info","ts":"2026-03-17T21:59:17.834573Z","caller":"traceutil/trace.go:171","msg":"trace[545488232] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1264; }","duration":"170.564902ms","start":"2026-03-17T21:59:17.663997Z","end":"2026-03-17T21:59:17.834562Z","steps":["trace[545488232] 'agreement among raft nodes before linearized reading'  (duration: 170.47259ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:00:19.041426Z","caller":"traceutil/trace.go:171","msg":"trace[710187168] linearizableReadLoop","detail":"{readStateIndex:1579; appliedIndex:1578; }","duration":"121.075205ms","start":"2026-03-17T22:00:18.920325Z","end":"2026-03-17T22:00:19.0414Z","steps":["trace[710187168] 'read index received'  (duration: 105.89116ms)","trace[710187168] 'applied index is now lower than readState.Index'  (duration: 15.182925ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:00:19.041516Z","caller":"traceutil/trace.go:171","msg":"trace[1137080395] transaction","detail":"{read_only:false; response_revision:1513; number_of_response:1; }","duration":"151.100177ms","start":"2026-03-17T22:00:18.89037Z","end":"2026-03-17T22:00:19.04147Z","steps":["trace[1137080395] 'process raft request'  (duration: 135.87128ms)","trace[1137080395] 'compare'  (duration: 15.042412ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:00:19.041747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.402163ms","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-17T22:00:19.041794Z","caller":"traceutil/trace.go:171","msg":"trace[438146230] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1513; }","duration":"121.510647ms","start":"2026-03-17T22:00:18.920272Z","end":"2026-03-17T22:00:19.041782Z","steps":["trace[438146230] 'agreement among raft nodes before linearized reading'  (duration: 121.268741ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:00:58.320023Z","caller":"traceutil/trace.go:171","msg":"trace[1565980724] linearizableReadLoop","detail":"{readStateIndex:1746; appliedIndex:1745; }","duration":"106.059402ms","start":"2026-03-17T22:00:58.213942Z","end":"2026-03-17T22:00:58.320001Z","steps":["trace[1565980724] 'read index received'  (duration: 105.936869ms)","trace[1565980724] 'applied index is now lower than readState.Index'  (duration: 121.443µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:00:58.320073Z","caller":"traceutil/trace.go:171","msg":"trace[1958727681] transaction","detail":"{read_only:false; response_revision:1672; number_of_response:1; }","duration":"106.647458ms","start":"2026-03-17T22:00:58.213384Z","end":"2026-03-17T22:00:58.320031Z","steps":["trace[1958727681] 'process raft request'  (duration: 106.480794ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:00:58.320407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.449744ms","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-17T22:00:58.32044Z","caller":"traceutil/trace.go:171","msg":"trace[141151818] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1672; }","duration":"106.520755ms","start":"2026-03-17T22:00:58.213911Z","end":"2026-03-17T22:00:58.320432Z","steps":["trace[141151818] 'agreement among raft nodes before linearized reading'  (duration: 106.215646ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:30.829126Z","caller":"traceutil/trace.go:171","msg":"trace[696503547] transaction","detail":"{read_only:false; response_revision:1804; number_of_response:1; }","duration":"179.997233ms","start":"2026-03-17T22:01:30.649105Z","end":"2026-03-17T22:01:30.829102Z","steps":["trace[696503547] 'process raft request'  (duration: 179.855778ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:30.895303Z","caller":"traceutil/trace.go:171","msg":"trace[948446091] transaction","detail":"{read_only:false; response_revision:1805; number_of_response:1; }","duration":"245.716458ms","start":"2026-03-17T22:01:30.649567Z","end":"2026-03-17T22:01:30.895284Z","steps":["trace[948446091] 'process raft request'  (duration: 242.563677ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:30.895437Z","caller":"traceutil/trace.go:171","msg":"trace[1497194728] transaction","detail":"{read_only:false; response_revision:1806; number_of_response:1; }","duration":"244.977529ms","start":"2026-03-17T22:01:30.650438Z","end":"2026-03-17T22:01:30.895415Z","steps":["trace[1497194728] 'process raft request'  (duration: 244.810705ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:33.400176Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958675501826222284,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-17T22:01:33.448333Z","caller":"traceutil/trace.go:171","msg":"trace[5221764] linearizableReadLoop","detail":"{readStateIndex:1892; appliedIndex:1891; }","duration":"548.205149ms","start":"2026-03-17T22:01:32.900109Z","end":"2026-03-17T22:01:33.448314Z","steps":["trace[5221764] 'read index received'  (duration: 548.010244ms)","trace[5221764] 'applied index is now lower than readState.Index'  (duration: 193.675µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:01:33.448751Z","caller":"traceutil/trace.go:171","msg":"trace[1818568605] transaction","detail":"{read_only:false; response_revision:1811; number_of_response:1; }","duration":"611.876832ms","start":"2026-03-17T22:01:32.836847Z","end":"2026-03-17T22:01:33.448724Z","steps":["trace[1818568605] 'process raft request'  (duration: 611.327539ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:33.44879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.66033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-17T22:01:33.448843Z","caller":"traceutil/trace.go:171","msg":"trace[2101465039] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1811; }","duration":"548.758574ms","start":"2026-03-17T22:01:32.900069Z","end":"2026-03-17T22:01:33.448828Z","steps":["trace[2101465039] 'agreement among raft nodes before linearized reading'  (duration: 548.598649ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:33.448878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:32.900053Z","time spent":"548.817166ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-17T22:01:33.448879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:32.836834Z","time spent":"611.968844ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":516,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1804 > 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\" > >"}
{"level":"warn","ts":"2026-03-17T22:01:33.449155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.906107ms","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-17T22:01:33.449265Z","caller":"traceutil/trace.go:171","msg":"trace[249567853] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1811; }","duration":"549.040031ms","start":"2026-03-17T22:01:32.900206Z","end":"2026-03-17T22:01:33.449246Z","steps":["trace[249567853] 'agreement among raft nodes before linearized reading'  (duration: 548.785305ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:33.449363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:32.900194Z","time spent":"549.157184ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-17T22:01:33.449598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.381375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:524"}
{"level":"info","ts":"2026-03-17T22:01:33.44984Z","caller":"traceutil/trace.go:171","msg":"trace[579487408] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1811; }","duration":"261.652351ms","start":"2026-03-17T22:01:33.188167Z","end":"2026-03-17T22:01:33.449819Z","steps":["trace[579487408] 'agreement among raft nodes before linearized reading'  (duration: 261.350404ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:33.449717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.113891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-03-17T22:01:33.450081Z","caller":"traceutil/trace.go:171","msg":"trace[1162642588] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1811; }","duration":"443.498961ms","start":"2026-03-17T22:01:33.006561Z","end":"2026-03-17T22:01:33.45006Z","steps":["trace[1162642588] 'agreement among raft nodes before linearized reading'  (duration: 443.092271ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:33.450145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:33.006545Z","time spent":"443.584573ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-03-17T22:01:33.449312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.159518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-03-17T22:01:33.450248Z","caller":"traceutil/trace.go:171","msg":"trace[937700278] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1811; }","duration":"126.141344ms","start":"2026-03-17T22:01:33.324097Z","end":"2026-03-17T22:01:33.450239Z","steps":["trace[937700278] 'agreement among raft nodes before linearized reading'  (duration: 125.141498ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:33.887538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.258329ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:01:33.887656Z","caller":"traceutil/trace.go:171","msg":"trace[350378953] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1811; }","duration":"316.391612ms","start":"2026-03-17T22:01:33.571252Z","end":"2026-03-17T22:01:33.887644Z","steps":["trace[350378953] 'range keys from in-memory index tree'  (duration: 316.246059ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:33.887902Z","caller":"traceutil/trace.go:171","msg":"trace[1123179658] transaction","detail":"{read_only:false; response_revision:1812; number_of_response:1; }","duration":"433.755069ms","start":"2026-03-17T22:01:33.454122Z","end":"2026-03-17T22:01:33.887877Z","steps":["trace[1123179658] 'process raft request'  (duration: 430.522815ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:33.888041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:33.454106Z","time spent":"433.866512ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1805 > 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-17T22:01:33.888666Z","caller":"traceutil/trace.go:171","msg":"trace[434811819] linearizableReadLoop","detail":"{readStateIndex:1898; appliedIndex:1892; }","duration":"344.352938ms","start":"2026-03-17T22:01:33.544304Z","end":"2026-03-17T22:01:33.888657Z","steps":["trace[434811819] 'read index received'  (duration: 340.343624ms)","trace[434811819] 'applied index is now lower than readState.Index'  (duration: 4.008434ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:01:33.88901Z","caller":"traceutil/trace.go:171","msg":"trace[444772286] transaction","detail":"{read_only:false; response_revision:1813; number_of_response:1; }","duration":"434.747474ms","start":"2026-03-17T22:01:33.454127Z","end":"2026-03-17T22:01:33.888874Z","steps":["trace[444772286] 'process raft request'  (duration: 434.314143ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:33.889094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:33.454108Z","time spent":"434.95289ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" mod_revision:1794 > success:<request_put:<key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-03-17T22:01:33.889193Z","caller":"traceutil/trace.go:171","msg":"trace[208681140] transaction","detail":"{read_only:false; response_revision:1814; number_of_response:1; }","duration":"434.972611ms","start":"2026-03-17T22:01:33.454207Z","end":"2026-03-17T22:01:33.889179Z","steps":["trace[208681140] 'process raft request'  (duration: 434.286713ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:33.889263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:33.454185Z","time spent":"435.041653ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1806 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-17T22:01:33.889376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.061336ms","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-17T22:01:33.889544Z","caller":"traceutil/trace.go:171","msg":"trace[683962069] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1818; }","duration":"345.252892ms","start":"2026-03-17T22:01:33.544282Z","end":"2026-03-17T22:01:33.889534Z","steps":["trace[683962069] 'agreement among raft nodes before linearized reading'  (duration: 344.977285ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:33.889775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:33.544274Z","time spent":"345.489387ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-17T22:01:33.889413Z","caller":"traceutil/trace.go:171","msg":"trace[1019290705] transaction","detail":"{read_only:false; response_revision:1815; number_of_response:1; }","duration":"433.392719ms","start":"2026-03-17T22:01:33.455995Z","end":"2026-03-17T22:01:33.889388Z","steps":["trace[1019290705] 'process raft request'  (duration: 432.521427ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:33.889894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:33.455988Z","time spent":"433.85016ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1807 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-17T22:01:33.889422Z","caller":"traceutil/trace.go:171","msg":"trace[580382850] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"432.828174ms","start":"2026-03-17T22:01:33.456581Z","end":"2026-03-17T22:01:33.889409Z","steps":["trace[580382850] 'process raft request'  (duration: 431.961482ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:33.889979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:33.456574Z","time spent":"433.391629ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:1793 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:423 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-03-17T22:01:33.889442Z","caller":"traceutil/trace.go:171","msg":"trace[597418583] transaction","detail":"{read_only:false; response_revision:1817; number_of_response:1; }","duration":"424.56283ms","start":"2026-03-17T22:01:33.464843Z","end":"2026-03-17T22:01:33.889406Z","steps":["trace[597418583] 'process raft request'  (duration: 423.76801ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:33.890053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:33.464833Z","time spent":"425.206248ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:1796 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:404 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-03-17T22:01:33.889466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.223164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:01:33.890102Z","caller":"traceutil/trace.go:171","msg":"trace[370414869] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1818; }","duration":"243.881991ms","start":"2026-03-17T22:01:33.646214Z","end":"2026-03-17T22:01:33.890096Z","steps":["trace[370414869] 'agreement among raft nodes before linearized reading'  (duration: 243.227014ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:34.923454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.163023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.112\" ","response":"range_response_count:1 size:135"}
{"level":"warn","ts":"2026-03-17T22:01:34.923498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.744782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-17T22:01:34.92353Z","caller":"traceutil/trace.go:171","msg":"trace[1733238169] range","detail":"{range_begin:/registry/masterleases/199.19.213.112; range_end:; response_count:1; response_revision:1819; }","duration":"416.286296ms","start":"2026-03-17T22:01:34.507227Z","end":"2026-03-17T22:01:34.923514Z","steps":["trace[1733238169] 'range keys from in-memory index tree'  (duration: 415.985938ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:34.923556Z","caller":"traceutil/trace.go:171","msg":"trace[1950552633] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1819; }","duration":"415.840224ms","start":"2026-03-17T22:01:34.507693Z","end":"2026-03-17T22:01:34.923533Z","steps":["trace[1950552633] 'count revisions from in-memory index tree'  (duration: 415.606139ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:34.923623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:34.507209Z","time spent":"416.353708ms","remote":"127.0.0.1:37866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.112\" "}
{"level":"warn","ts":"2026-03-17T22:01:34.923621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:34.507661Z","time spent":"415.950267ms","remote":"127.0.0.1:37988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "}
{"level":"warn","ts":"2026-03-17T22:01:34.923696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.449206ms","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-17T22:01:34.923765Z","caller":"traceutil/trace.go:171","msg":"trace[2035234639] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1819; }","duration":"684.568329ms","start":"2026-03-17T22:01:34.239179Z","end":"2026-03-17T22:01:34.923747Z","steps":["trace[2035234639] 'range keys from in-memory index tree'  (duration: 684.25259ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:34.923805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.606682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-17T22:01:34.923813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:34.239161Z","time spent":"684.643761ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-17T22:01:34.923855Z","caller":"traceutil/trace.go:171","msg":"trace[1611714002] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1819; }","duration":"169.704855ms","start":"2026-03-17T22:01:34.754135Z","end":"2026-03-17T22:01:34.92384Z","steps":["trace[1611714002] 'count revisions from in-memory index tree'  (duration: 169.484019ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:37.437819Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958675501826222323,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-17T22:01:37.836446Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.269012409s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-17T22:01:37.836875Z","caller":"traceutil/trace.go:171","msg":"trace[164436096] linearizableReadLoop","detail":"{readStateIndex:1909; appliedIndex:1908; }","duration":"899.390744ms","start":"2026-03-17T22:01:36.937459Z","end":"2026-03-17T22:01:37.83685Z","steps":["trace[164436096] 'read index received'  (duration: 899.136668ms)","trace[164436096] 'applied index is now lower than readState.Index'  (duration: 252.866µs)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:01:37.837005Z","caller":"traceutil/trace.go:171","msg":"trace[742199440] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"1.269607974s","start":"2026-03-17T22:01:36.567339Z","end":"2026-03-17T22:01:37.836947Z","steps":["trace[742199440] 'process raft request'  (duration: 1.269347387s)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:37.837108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.991134ms","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-17T22:01:37.837143Z","caller":"traceutil/trace.go:171","msg":"trace[495319375] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1827; }","duration":"375.072785ms","start":"2026-03-17T22:01:37.462059Z","end":"2026-03-17T22:01:37.837132Z","steps":["trace[495319375] 'agreement among raft nodes before linearized reading'  (duration: 374.89804ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:37.837119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.181462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-17T22:01:37.83716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.723763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-17T22:01:37.837178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:37.462044Z","time spent":"375.125967ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}
{"level":"warn","ts":"2026-03-17T22:01:37.837177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:36.567326Z","time spent":"1.269754088s","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" mod_revision:1809 > success:<request_put:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" value_size:439 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-03-17T22:01:37.837194Z","caller":"traceutil/trace.go:171","msg":"trace[931679636] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1827; }","duration":"249.765834ms","start":"2026-03-17T22:01:37.587418Z","end":"2026-03-17T22:01:37.837183Z","steps":["trace[931679636] 'agreement among raft nodes before linearized reading'  (duration: 249.691952ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:37.837194Z","caller":"traceutil/trace.go:171","msg":"trace[1325269842] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1827; }","duration":"191.285394ms","start":"2026-03-17T22:01:37.645891Z","end":"2026-03-17T22:01:37.837176Z","steps":["trace[1325269842] 'agreement among raft nodes before linearized reading'  (duration: 191.149761ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:37.837549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"900.091552ms","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-17T22:01:37.837586Z","caller":"traceutil/trace.go:171","msg":"trace[404446646] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1827; }","duration":"900.164134ms","start":"2026-03-17T22:01:36.937415Z","end":"2026-03-17T22:01:37.837579Z","steps":["trace[404446646] 'agreement among raft nodes before linearized reading'  (duration: 899.539028ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:37.837603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:36.937329Z","time spent":"900.268898ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-17T22:01:38.937858Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958675501826222326,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-17T22:01:39.438334Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958675501826222326,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-17T22:01:39.839409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.995505825s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-03-17T22:01:39.839467Z","caller":"traceutil/trace.go:171","msg":"trace[1538214017] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.995588017s","start":"2026-03-17T22:01:37.843869Z","end":"2026-03-17T22:01:39.839457Z","steps":["trace[1538214017] 'agreement among raft nodes before linearized reading'  (duration: 1.995517145s)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:39.839494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:37.843857Z","time spent":"1.995631849s","remote":"127.0.0.1:37846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/03/17 22:01:39 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-17T22:01:39.939052Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958675501826222326,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-17T22:01:40.43934Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958675501826222326,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-17T22:01:40.539485Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.698185994s","expected-duration":"1s"}
{"level":"warn","ts":"2026-03-17T22:01:40.698665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.72629ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826222327 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:1822 > 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-17T22:01:40.69953Z","caller":"traceutil/trace.go:171","msg":"trace[254160024] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"2.858268697s","start":"2026-03-17T22:01:37.841219Z","end":"2026-03-17T22:01:40.699488Z","steps":["trace[254160024] 'process raft request'  (duration: 2.698563292s)","trace[254160024] 'compare'  (duration: 158.284569ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:01:40.699769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:37.841202Z","time spent":"2.858444123s","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":516,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1822 > 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\" > >"}
{"level":"info","ts":"2026-03-17T22:01:40.699806Z","caller":"traceutil/trace.go:171","msg":"trace[379781707] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"2.853826334s","start":"2026-03-17T22:01:37.845937Z","end":"2026-03-17T22:01:40.699763Z","steps":["trace[379781707] 'process raft request'  (duration: 2.85290519s)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:40.700449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:37.845926Z","time spent":"2.854377378s","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1821 > 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-17T22:01:40.785213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:39.843326Z","time spent":"941.877888ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-03-17T22:01:40.785266Z","caller":"traceutil/trace.go:171","msg":"trace[1376351005] linearizableReadLoop","detail":"{readStateIndex:1913; appliedIndex:1909; }","duration":"2.941358736s","start":"2026-03-17T22:01:37.843886Z","end":"2026-03-17T22:01:40.785245Z","steps":["trace[1376351005] 'read index received'  (duration: 2.695901835s)","trace[1376351005] 'applied index is now lower than readState.Index'  (duration: 245.456021ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:01:40.78556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.845743248s","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-17T22:01:40.785594Z","caller":"traceutil/trace.go:171","msg":"trace[1988461074] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1830; }","duration":"1.845807459s","start":"2026-03-17T22:01:38.939775Z","end":"2026-03-17T22:01:40.785582Z","steps":["trace[1988461074] 'agreement among raft nodes before linearized reading'  (duration: 1.845676396s)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:40.785619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:38.939768Z","time spent":"1.84584506s","remote":"127.0.0.1:38050","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-17T22:01:40.7857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.87569588s","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-17T22:01:40.785744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"967.202674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:01:40.785766Z","caller":"traceutil/trace.go:171","msg":"trace[1048620586] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1830; }","duration":"967.256626ms","start":"2026-03-17T22:01:39.818504Z","end":"2026-03-17T22:01:40.78576Z","steps":["trace[1048620586] 'agreement among raft nodes before linearized reading'  (duration: 967.221025ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:40.785783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:39.818489Z","time spent":"967.289046ms","remote":"127.0.0.1:38090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "}
{"level":"info","ts":"2026-03-17T22:01:40.78593Z","caller":"traceutil/trace.go:171","msg":"trace[2060559638] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1830; }","duration":"2.875769212s","start":"2026-03-17T22:01:37.90996Z","end":"2026-03-17T22:01:40.785729Z","steps":["trace[2060559638] 'agreement among raft nodes before linearized reading'  (duration: 2.875546496s)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:40.785947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.889524945s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"}
{"level":"info","ts":"2026-03-17T22:01:40.786005Z","caller":"traceutil/trace.go:171","msg":"trace[1123477983] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1830; }","duration":"1.889600476s","start":"2026-03-17T22:01:38.896388Z","end":"2026-03-17T22:01:40.785988Z","steps":["trace[1123477983] 'agreement among raft nodes before linearized reading'  (duration: 1.889437152s)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:40.786016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.876059911s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-17T22:01:40.786043Z","caller":"traceutil/trace.go:171","msg":"trace[1571482899] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1830; }","duration":"2.876097041s","start":"2026-03-17T22:01:37.909941Z","end":"2026-03-17T22:01:40.786038Z","steps":["trace[1571482899] 'agreement among raft nodes before linearized reading'  (duration: 2.87603275s)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:40.786046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:38.896385Z","time spent":"1.889654117s","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":495,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-03-17T22:01:40.786068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:37.909937Z","time spent":"2.876124262s","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-17T22:01:40.786126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:37.909956Z","time spent":"2.876001469s","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-17T22:01:40.786158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.876220494s","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-17T22:01:40.786179Z","caller":"traceutil/trace.go:171","msg":"trace[706543964] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1830; }","duration":"2.876251035s","start":"2026-03-17T22:01:37.909922Z","end":"2026-03-17T22:01:40.786173Z","steps":["trace[706543964] 'agreement among raft nodes before linearized reading'  (duration: 2.876192613s)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:40.786194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:37.909918Z","time spent":"2.876272645s","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-17T22:01:40.785716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"941.584189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-17T22:01:40.786258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.889843882s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:524"}
{"level":"info","ts":"2026-03-17T22:01:40.786319Z","caller":"traceutil/trace.go:171","msg":"trace[1622646695] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1830; }","duration":"942.199896ms","start":"2026-03-17T22:01:39.844114Z","end":"2026-03-17T22:01:40.786314Z","steps":["trace[1622646695] 'agreement among raft nodes before linearized reading'  (duration: 941.58667ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:40.786341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:39.844109Z","time spent":"942.225077ms","remote":"127.0.0.1:37860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-17T22:01:40.786355Z","caller":"traceutil/trace.go:171","msg":"trace[2026635751] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1830; }","duration":"1.889981935s","start":"2026-03-17T22:01:38.896344Z","end":"2026-03-17T22:01:40.786326Z","steps":["trace[2026635751] 'agreement among raft nodes before linearized reading'  (duration: 1.889729269s)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:40.786419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:38.89633Z","time spent":"1.890078959s","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":547,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-03-17T22:01:40.786574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.876674496s","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-17T22:01:40.786602Z","caller":"traceutil/trace.go:171","msg":"trace[1343339419] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1830; }","duration":"2.876723018s","start":"2026-03-17T22:01:37.909872Z","end":"2026-03-17T22:01:40.786595Z","steps":["trace[1343339419] 'agreement among raft nodes before linearized reading'  (duration: 2.875537707s)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:40.78662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:37.909862Z","time spent":"2.876754749s","remote":"127.0.0.1:38050","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-17T22:01:40.89396Z","caller":"traceutil/trace.go:171","msg":"trace[2078210995] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"104.545894ms","start":"2026-03-17T22:01:40.789387Z","end":"2026-03-17T22:01:40.893933Z","steps":["trace[2078210995] 'process raft request'  (duration: 96.083844ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:40.894831Z","caller":"traceutil/trace.go:171","msg":"trace[916067390] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"101.294568ms","start":"2026-03-17T22:01:40.793513Z","end":"2026-03-17T22:01:40.894808Z","steps":["trace[916067390] 'process raft request'  (duration: 101.238307ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:40.895071Z","caller":"traceutil/trace.go:171","msg":"trace[30643812] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"103.597439ms","start":"2026-03-17T22:01:40.791463Z","end":"2026-03-17T22:01:40.89506Z","steps":["trace[30643812] 'process raft request'  (duration: 103.144937ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:40.895293Z","caller":"traceutil/trace.go:171","msg":"trace[1385626410] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"101.794363ms","start":"2026-03-17T22:01:40.793488Z","end":"2026-03-17T22:01:40.895282Z","steps":["trace[1385626410] 'process raft request'  (duration: 101.226538ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:40.895679Z","caller":"traceutil/trace.go:171","msg":"trace[1284769097] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"102.1232ms","start":"2026-03-17T22:01:40.793537Z","end":"2026-03-17T22:01:40.89566Z","steps":["trace[1284769097] 'process raft request'  (duration: 101.256328ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:40.8957Z","caller":"traceutil/trace.go:171","msg":"trace[750295988] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"101.470913ms","start":"2026-03-17T22:01:40.794209Z","end":"2026-03-17T22:01:40.89568Z","steps":["trace[750295988] 'process raft request'  (duration: 101.072623ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:40.895847Z","caller":"traceutil/trace.go:171","msg":"trace[596988845] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"102.315955ms","start":"2026-03-17T22:01:40.793524Z","end":"2026-03-17T22:01:40.89584Z","steps":["trace[596988845] 'process raft request'  (duration: 101.678099ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:40.895915Z","caller":"traceutil/trace.go:171","msg":"trace[426457463] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"102.337676ms","start":"2026-03-17T22:01:40.793571Z","end":"2026-03-17T22:01:40.895908Z","steps":["trace[426457463] 'process raft request'  (duration: 101.686609ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:54.875174Z","caller":"traceutil/trace.go:171","msg":"trace[752353472] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"112.962392ms","start":"2026-03-17T22:01:54.762007Z","end":"2026-03-17T22:01:54.874969Z","steps":["trace[752353472] 'process raft request'  (duration: 112.861599ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:55.075308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.443679ms","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-17T22:01:55.075392Z","caller":"traceutil/trace.go:171","msg":"trace[924944091] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1894; }","duration":"107.599432ms","start":"2026-03-17T22:01:54.967773Z","end":"2026-03-17T22:01:55.075372Z","steps":["trace[924944091] 'range keys from in-memory index tree'  (duration: 107.108711ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:01:55.075689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.734617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-03-17T22:01:55.075724Z","caller":"traceutil/trace.go:171","msg":"trace[1910292463] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1894; }","duration":"107.787578ms","start":"2026-03-17T22:01:54.967927Z","end":"2026-03-17T22:01:55.075715Z","steps":["trace[1910292463] 'range keys from in-memory index tree'  (duration: 107.636035ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:55.24654Z","caller":"traceutil/trace.go:171","msg":"trace[1611736096] transaction","detail":"{read_only:false; response_revision:1899; number_of_response:1; }","duration":"159.927162ms","start":"2026-03-17T22:01:55.086581Z","end":"2026-03-17T22:01:55.246508Z","steps":["trace[1611736096] 'process raft request'  (duration: 105.5283ms)","trace[1611736096] 'compare'  (duration: 54.257018ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:01:55.481843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.139858ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826222511 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/default/test-pvc-pod\" mod_revision:1899 > success:<request_put:<key:\"/registry/pods/default/test-pvc-pod\" value_size:1890 >> failure:<request_range:<key:\"/registry/pods/default/test-pvc-pod\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-17T22:01:55.481929Z","caller":"traceutil/trace.go:171","msg":"trace[803787252] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"196.436649ms","start":"2026-03-17T22:01:55.285476Z","end":"2026-03-17T22:01:55.481913Z","steps":["trace[803787252] 'process raft request'  (duration: 75.87297ms)","trace[803787252] 'compare'  (duration: 120.015594ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:01:56.190167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.63674ms","expected-duration":"100ms","prefix":"","request":"header:<ID:1958675501826222517 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" mod_revision:1875 > success:<request_put:<key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" value_size:432 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-17T22:01:56.190345Z","caller":"traceutil/trace.go:171","msg":"trace[1042922600] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"265.159062ms","start":"2026-03-17T22:01:55.925168Z","end":"2026-03-17T22:01:56.190328Z","steps":["trace[1042922600] 'process raft request'  (duration: 265.103381ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:56.190728Z","caller":"traceutil/trace.go:171","msg":"trace[2017808209] transaction","detail":"{read_only:false; response_revision:1903; number_of_response:1; }","duration":"266.819266ms","start":"2026-03-17T22:01:55.923855Z","end":"2026-03-17T22:01:56.190674Z","steps":["trace[2017808209] 'process raft request'  (duration: 105.591221ms)","trace[2017808209] 'compare'  (duration: 160.519177ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:01:57.240375Z","caller":"traceutil/trace.go:171","msg":"trace[1306226531] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"101.550056ms","start":"2026-03-17T22:01:57.1388Z","end":"2026-03-17T22:01:57.240351Z","steps":["trace[1306226531] 'process raft request'  (duration: 101.388982ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:57.385742Z","caller":"traceutil/trace.go:171","msg":"trace[1996222802] linearizableReadLoop","detail":"{readStateIndex:1997; appliedIndex:1995; }","duration":"114.775198ms","start":"2026-03-17T22:01:57.27095Z","end":"2026-03-17T22:01:57.385726Z","steps":["trace[1996222802] 'read index received'  (duration: 70.786877ms)","trace[1996222802] 'applied index is now lower than readState.Index'  (duration: 43.987601ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:01:57.385827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.858371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:01:57.385846Z","caller":"traceutil/trace.go:171","msg":"trace[201426946] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1910; }","duration":"114.932724ms","start":"2026-03-17T22:01:57.270907Z","end":"2026-03-17T22:01:57.385839Z","steps":["trace[201426946] 'agreement among raft nodes before linearized reading'  (duration: 114.881163ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:01:57.385991Z","caller":"traceutil/trace.go:171","msg":"trace[1853876901] transaction","detail":"{read_only:false; response_revision:1909; number_of_response:1; }","duration":"246.364164ms","start":"2026-03-17T22:01:57.139616Z","end":"2026-03-17T22:01:57.38598Z","steps":["trace[1853876901] 'process raft request'  (duration: 202.168358ms)","trace[1853876901] 'compare'  (duration: 43.652592ms)"],"step_count":2}
{"level":"info","ts":"2026-03-17T22:01:57.386054Z","caller":"traceutil/trace.go:171","msg":"trace[425099599] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"245.865061ms","start":"2026-03-17T22:01:57.140184Z","end":"2026-03-17T22:01:57.386049Z","steps":["trace[425099599] 'process raft request'  (duration: 245.506731ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:02:01.033602Z","caller":"traceutil/trace.go:171","msg":"trace[854005032] transaction","detail":"{read_only:false; response_revision:1929; number_of_response:1; }","duration":"167.376435ms","start":"2026-03-17T22:02:00.866204Z","end":"2026-03-17T22:02:01.03358Z","steps":["trace[854005032] 'process raft request'  (duration: 167.022385ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:02:01.119842Z","caller":"traceutil/trace.go:171","msg":"trace[1141254148] transaction","detail":"{read_only:false; response_revision:1930; number_of_response:1; }","duration":"215.744649ms","start":"2026-03-17T22:02:00.904054Z","end":"2026-03-17T22:02:01.119798Z","steps":["trace[1141254148] 'process raft request'  (duration: 211.058257ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:02:01.119891Z","caller":"traceutil/trace.go:171","msg":"trace[1208284489] linearizableReadLoop","detail":"{readStateIndex:2018; appliedIndex:2016; }","duration":"203.157963ms","start":"2026-03-17T22:02:00.916671Z","end":"2026-03-17T22:02:01.119829Z","steps":["trace[1208284489] 'read index received'  (duration: 116.811822ms)","trace[1208284489] 'applied index is now lower than readState.Index'  (duration: 86.344741ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-17T22:02:01.12022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.177897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-17T22:02:01.120284Z","caller":"traceutil/trace.go:171","msg":"trace[439810624] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1931; }","duration":"143.27752ms","start":"2026-03-17T22:02:00.976991Z","end":"2026-03-17T22:02:01.120268Z","steps":["trace[439810624] 'agreement among raft nodes before linearized reading'  (duration: 143.169967ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:02:01.120379Z","caller":"traceutil/trace.go:171","msg":"trace[1230078116] transaction","detail":"{read_only:false; response_revision:1931; number_of_response:1; }","duration":"167.362334ms","start":"2026-03-17T22:02:00.952998Z","end":"2026-03-17T22:02:01.120361Z","steps":["trace[1230078116] 'process raft request'  (duration: 166.731738ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-17T22:02:01.120275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.587804ms","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":"warn","ts":"2026-03-17T22:02:01.120553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.720408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-03-17T22:02:01.120573Z","caller":"traceutil/trace.go:171","msg":"trace[1612928194] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1931; }","duration":"203.900012ms","start":"2026-03-17T22:02:00.916661Z","end":"2026-03-17T22:02:01.120561Z","steps":["trace[1612928194] 'agreement among raft nodes before linearized reading'  (duration: 203.463481ms)"],"step_count":1}
{"level":"info","ts":"2026-03-17T22:02:01.120668Z","caller":"traceutil/trace.go:171","msg":"trace[640688208] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1931; }","duration":"136.847881ms","start":"2026-03-17T22:02:00.983803Z","end":"2026-03-17T22:02:01.120651Z","steps":["trace[640688208] 'agreement among raft nodes before linearized reading'  (duration: 136.616956ms)"],"step_count":1}