{"level":"warn","ts":"2026-02-11T01:49:30.484062Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-11T01:49:30.484154Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.132:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.132:2380","--initial-cluster=instance=https://199.204.45.132:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.132:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.132:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-02-11T01:49:30.484213Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-11T01:49:30.484223Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.132:2380"]} {"level":"info","ts":"2026-02-11T01:49:30.484268Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-02-11T01:49:30.484926Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"]} {"level":"info","ts":"2026-02-11T01:49:30.485Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.132:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-02-11T01:49:30.488694Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.520958ms"} {"level":"info","ts":"2026-02-11T01:49:30.503885Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"56c01ea8fdc90390","cluster-id":"c930fe821aab8609"} {"level":"info","ts":"2026-02-11T01:49:30.503962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=()"} {"level":"info","ts":"2026-02-11T01:49:30.503982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 0"} {"level":"info","ts":"2026-02-11T01:49:30.504005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 56c01ea8fdc90390 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-11T01:49:30.504015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 1"} {"level":"info","ts":"2026-02-11T01:49:30.504048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"warn","ts":"2026-02-11T01:49:30.511161Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-11T01:49:30.512442Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-11T01:49:30.513353Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-02-11T01:49:30.516271Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"56c01ea8fdc90390","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-11T01:49:30.517739Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"56c01ea8fdc90390","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-11T01:49:30.517951Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-11T01:49:30.518009Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-11T01:49:30.518018Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-11T01:49:30.524598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"info","ts":"2026-02-11T01:49:30.524651Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-02-11T01:49:30.524696Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","added-peer-id":"56c01ea8fdc90390","added-peer-peer-urls":["https://199.204.45.132:2380"]} {"level":"info","ts":"2026-02-11T01:49:30.524846Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"56c01ea8fdc90390","initial-advertise-peer-urls":["https://199.204.45.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-11T01:49:30.524877Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-11T01:49:30.525331Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-02-11T01:49:30.525355Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-02-11T01:49:31.404362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 is starting a new election at term 1"} {"level":"info","ts":"2026-02-11T01:49:31.404405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-11T01:49:31.404429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgPreVoteResp from 56c01ea8fdc90390 at term 1"} {"level":"info","ts":"2026-02-11T01:49:31.404448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became candidate at term 2"} {"level":"info","ts":"2026-02-11T01:49:31.404458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgVoteResp from 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-02-11T01:49:31.404468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became leader at term 2"} {"level":"info","ts":"2026-02-11T01:49:31.404479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 56c01ea8fdc90390 elected leader 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-02-11T01:49:31.406616Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"56c01ea8fdc90390","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.132:2379]}","request-path":"/0/members/56c01ea8fdc90390/attributes","cluster-id":"c930fe821aab8609","publish-timeout":"7s"} {"level":"info","ts":"2026-02-11T01:49:31.406766Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-11T01:49:31.407201Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T01:49:31.409711Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-11T01:49:31.410011Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-11T01:49:31.410031Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-11T01:49:31.411868Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.132:2379"} {"level":"info","ts":"2026-02-11T01:49:31.415707Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-11T01:49:31.415936Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T01:49:31.418912Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T01:49:31.418936Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T01:49:50.208586Z","caller":"traceutil/trace.go:171","msg":"trace[1604047826] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"362.720167ms","start":"2026-02-11T01:49:49.84584Z","end":"2026-02-11T01:49:50.20856Z","steps":["trace[1604047826] 'process raft request' (duration: 362.628504ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:49:50.209163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:49:49.845824Z","time spent":"362.820099ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:49:51.154059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"882.648163ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-11T01:49:51.15417Z","caller":"traceutil/trace.go:171","msg":"trace[1122113244] linearizableReadLoop","detail":"{readStateIndex:472; appliedIndex:471; }","duration":"185.486738ms","start":"2026-02-11T01:49:50.968666Z","end":"2026-02-11T01:49:51.154153Z","steps":["trace[1122113244] 'read index received' (duration: 68.022µs)","trace[1122113244] 'applied index is now lower than readState.Index' (duration: 185.417346ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:49:51.154319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.644052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-11T01:49:51.154348Z","caller":"traceutil/trace.go:171","msg":"trace[72695487] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:457; }","duration":"185.742165ms","start":"2026-02-11T01:49:50.968596Z","end":"2026-02-11T01:49:51.154338Z","steps":["trace[72695487] 'agreement among raft nodes before linearized reading' (duration: 185.661083ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:49:51.154452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.830347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-11T01:49:51.154497Z","caller":"traceutil/trace.go:171","msg":"trace[590308616] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:457; }","duration":"148.926149ms","start":"2026-02-11T01:49:51.005558Z","end":"2026-02-11T01:49:51.154484Z","steps":["trace[590308616] 'agreement among raft nodes before linearized reading' (duration: 148.822756ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:49:57.424409Z","caller":"traceutil/trace.go:171","msg":"trace[1575279829] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"200.790925ms","start":"2026-02-11T01:49:57.223598Z","end":"2026-02-11T01:49:57.424388Z","steps":["trace[1575279829] 'process raft request' (duration: 200.705283ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:49:57.424628Z","caller":"traceutil/trace.go:171","msg":"trace[1273903947] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"201.69162ms","start":"2026-02-11T01:49:57.222917Z","end":"2026-02-11T01:49:57.424609Z","steps":["trace[1273903947] 'process raft request' (duration: 179.08585ms)","trace[1273903947] 'compare' (duration: 21.918691ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:50:02.190148Z","caller":"traceutil/trace.go:171","msg":"trace[395305152] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"417.054579ms","start":"2026-02-11T01:50:01.773071Z","end":"2026-02-11T01:50:02.190125Z","steps":["trace[395305152] 'process raft request' (duration: 416.925715ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:02.190328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:01.773036Z","time spent":"417.208033ms","remote":"127.0.0.1:43816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4254,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:50:03.643843Z","caller":"traceutil/trace.go:171","msg":"trace[483182258] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:537; }","duration":"176.440446ms","start":"2026-02-11T01:50:03.467385Z","end":"2026-02-11T01:50:03.643825Z","steps":["trace[483182258] 'read index received' (duration: 176.260241ms)","trace[483182258] 'applied index is now lower than readState.Index' (duration: 179.585µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:50:03.64409Z","caller":"traceutil/trace.go:171","msg":"trace[57881854] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"182.494625ms","start":"2026-02-11T01:50:03.461587Z","end":"2026-02-11T01:50:03.644082Z","steps":["trace[57881854] 'process raft request' (duration: 182.114225ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:03.644246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.838117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-11T01:50:03.644271Z","caller":"traceutil/trace.go:171","msg":"trace[977573919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:521; }","duration":"176.90634ms","start":"2026-02-11T01:50:03.467359Z","end":"2026-02-11T01:50:03.644265Z","steps":["trace[977573919] 'agreement among raft nodes before linearized reading' (duration: 176.841788ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:03.644377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.57049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-11T01:50:03.644395Z","caller":"traceutil/trace.go:171","msg":"trace[330960686] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:521; }","duration":"176.58921ms","start":"2026-02-11T01:50:03.467801Z","end":"2026-02-11T01:50:03.64439Z","steps":["trace[330960686] 'agreement among raft nodes before linearized reading' (duration: 176.548389ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:50:03.858627Z","caller":"traceutil/trace.go:171","msg":"trace[407833825] linearizableReadLoop","detail":"{readStateIndex:540; appliedIndex:538; }","duration":"104.562804ms","start":"2026-02-11T01:50:03.754042Z","end":"2026-02-11T01:50:03.858605Z","steps":["trace[407833825] 'read index received' (duration: 93.376702ms)","trace[407833825] 'applied index is now lower than readState.Index' (duration: 11.185212ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:50:03.858786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.710748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:50:03.858821Z","caller":"traceutil/trace.go:171","msg":"trace[879913651] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:523; }","duration":"104.797331ms","start":"2026-02-11T01:50:03.754012Z","end":"2026-02-11T01:50:03.858809Z","steps":["trace[879913651] 'agreement among raft nodes before linearized reading' (duration: 104.677997ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:50:03.858819Z","caller":"traceutil/trace.go:171","msg":"trace[1408579144] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"206.612377ms","start":"2026-02-11T01:50:03.652189Z","end":"2026-02-11T01:50:03.858802Z","steps":["trace[1408579144] 'process raft request' (duration: 195.272781ms)","trace[1408579144] 'compare' (duration: 10.989507ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:50:03.858995Z","caller":"traceutil/trace.go:171","msg":"trace[428237914] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"206.624078ms","start":"2026-02-11T01:50:03.652366Z","end":"2026-02-11T01:50:03.858991Z","steps":["trace[428237914] 'process raft request' (duration: 206.201216ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:50:05.615367Z","caller":"traceutil/trace.go:171","msg":"trace[326396290] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"234.461333ms","start":"2026-02-11T01:50:05.380879Z","end":"2026-02-11T01:50:05.615341Z","steps":["trace[326396290] 'process raft request' (duration: 234.278778ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:50:09.753271Z","caller":"traceutil/trace.go:171","msg":"trace[2090050591] linearizableReadLoop","detail":"{readStateIndex:556; appliedIndex:555; }","duration":"127.672788ms","start":"2026-02-11T01:50:09.625559Z","end":"2026-02-11T01:50:09.753232Z","steps":["trace[2090050591] 'read index received' (duration: 127.40329ms)","trace[2090050591] 'applied index is now lower than readState.Index' (duration: 268.748µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:50:09.753572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.997637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-11T01:50:09.753692Z","caller":"traceutil/trace.go:171","msg":"trace[1112271876] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:538; }","duration":"128.161951ms","start":"2026-02-11T01:50:09.625519Z","end":"2026-02-11T01:50:09.753681Z","steps":["trace[1112271876] 'agreement among raft nodes before linearized reading' (duration: 127.927885ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:50:09.75428Z","caller":"traceutil/trace.go:171","msg":"trace[2019233116] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"848.720759ms","start":"2026-02-11T01:50:08.905548Z","end":"2026-02-11T01:50:09.754269Z","steps":["trace[2019233116] 'process raft request' (duration: 847.503975ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:09.754417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:08.905528Z","time spent":"848.844182ms","remote":"127.0.0.1:43830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:50:10.173808Z","caller":"traceutil/trace.go:171","msg":"trace[1191723009] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"406.736873ms","start":"2026-02-11T01:50:09.767022Z","end":"2026-02-11T01:50:10.173759Z","steps":["trace[1191723009] 'process raft request' (duration: 406.432764ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:10.174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:09.767013Z","time spent":"406.891577ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:50:10.177301Z","caller":"traceutil/trace.go:171","msg":"trace[763445940] linearizableReadLoop","detail":"{readStateIndex:557; appliedIndex:557; }","duration":"295.536504ms","start":"2026-02-11T01:50:09.881754Z","end":"2026-02-11T01:50:10.17729Z","steps":["trace[763445940] 'read index received' (duration: 295.530324ms)","trace[763445940] 'applied index is now lower than readState.Index' (duration: 5.52µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:50:10.17751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-11T01:50:10.177556Z","caller":"traceutil/trace.go:171","msg":"trace[2006592537] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:539; }","duration":"295.782331ms","start":"2026-02-11T01:50:09.881748Z","end":"2026-02-11T01:50:10.177531Z","steps":["trace[2006592537] 'agreement among raft nodes before linearized reading' (duration: 295.639317ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:10.185112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.308015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-11T01:50:10.185157Z","caller":"traceutil/trace.go:171","msg":"trace[98730592] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:540; }","duration":"301.363397ms","start":"2026-02-11T01:50:09.883773Z","end":"2026-02-11T01:50:10.185136Z","steps":["trace[98730592] 'agreement among raft nodes before linearized reading' (duration: 301.196412ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:10.185176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:09.883762Z","time spent":"301.408688ms","remote":"127.0.0.1:43934","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-02-11T01:50:12.318231Z","caller":"traceutil/trace.go:171","msg":"trace[1495499439] linearizableReadLoop","detail":"{readStateIndex:581; appliedIndex:580; }","duration":"136.77243ms","start":"2026-02-11T01:50:12.181436Z","end":"2026-02-11T01:50:12.318209Z","steps":["trace[1495499439] 'read index received' (duration: 136.682718ms)","trace[1495499439] 'applied index is now lower than readState.Index' (duration: 88.512µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:50:12.318379Z","caller":"traceutil/trace.go:171","msg":"trace[24111330] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"186.719582ms","start":"2026-02-11T01:50:12.131638Z","end":"2026-02-11T01:50:12.318357Z","steps":["trace[24111330] 'process raft request' (duration: 186.441545ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:12.319329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.480223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-11T01:50:12.319518Z","caller":"traceutil/trace.go:171","msg":"trace[1305465959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:562; }","duration":"127.237575ms","start":"2026-02-11T01:50:12.192257Z","end":"2026-02-11T01:50:12.319495Z","steps":["trace[1305465959] 'agreement among raft nodes before linearized reading' (duration: 126.314509ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:12.319587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.274992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-11T01:50:12.329166Z","caller":"traceutil/trace.go:171","msg":"trace[334882382] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:562; }","duration":"133.85145ms","start":"2026-02-11T01:50:12.195277Z","end":"2026-02-11T01:50:12.329129Z","steps":["trace[334882382] 'agreement among raft nodes before linearized reading' (duration: 124.255562ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:12.319403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.956404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-11T01:50:12.329665Z","caller":"traceutil/trace.go:171","msg":"trace[665889736] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:562; }","duration":"148.259191ms","start":"2026-02-11T01:50:12.181397Z","end":"2026-02-11T01:50:12.329656Z","steps":["trace[665889736] 'agreement among raft nodes before linearized reading' (duration: 137.924193ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:22.977327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.023959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-11T01:50:22.977387Z","caller":"traceutil/trace.go:171","msg":"trace[1939572328] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:668; }","duration":"600.112121ms","start":"2026-02-11T01:50:22.37726Z","end":"2026-02-11T01:50:22.977373Z","steps":["trace[1939572328] 'range keys from in-memory index tree' (duration: 599.859134ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:22.977414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:22.377248Z","time spent":"600.160743ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-11T01:50:22.977563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.63842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-11T01:50:22.977581Z","caller":"traceutil/trace.go:171","msg":"trace[904632923] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:668; }","duration":"598.782404ms","start":"2026-02-11T01:50:22.378793Z","end":"2026-02-11T01:50:22.977575Z","steps":["trace[904632923] 'range keys from in-memory index tree' (duration: 598.588598ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:22.977597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:22.378788Z","time spent":"598.805555ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-11T01:50:22.977702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.51056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-11T01:50:22.97772Z","caller":"traceutil/trace.go:171","msg":"trace[976966122] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:668; }","duration":"592.53675ms","start":"2026-02-11T01:50:22.385177Z","end":"2026-02-11T01:50:22.977714Z","steps":["trace[976966122] 'range keys from in-memory index tree' (duration: 592.464968ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:22.977736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:22.385172Z","time spent":"592.559861ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-11T01:50:22.977862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.676942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-11T01:50:22.97788Z","caller":"traceutil/trace.go:171","msg":"trace[1558871531] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:668; }","duration":"584.705063ms","start":"2026-02-11T01:50:22.393169Z","end":"2026-02-11T01:50:22.977874Z","steps":["trace[1558871531] 'range keys from in-memory index tree' (duration: 584.60293ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:22.977899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:22.393163Z","time spent":"584.732243ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-11T01:50:22.978222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.345817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:50:22.978242Z","caller":"traceutil/trace.go:171","msg":"trace[590952666] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:668; }","duration":"225.387659ms","start":"2026-02-11T01:50:22.752848Z","end":"2026-02-11T01:50:22.978236Z","steps":["trace[590952666] 'range keys from in-memory index tree' (duration: 225.291306ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:50:32.747053Z","caller":"traceutil/trace.go:171","msg":"trace[500200685] linearizableReadLoop","detail":"{readStateIndex:764; appliedIndex:763; }","duration":"402.306539ms","start":"2026-02-11T01:50:32.344707Z","end":"2026-02-11T01:50:32.747014Z","steps":["trace[500200685] 'read index received' (duration: 402.090933ms)","trace[500200685] 'applied index is now lower than readState.Index' (duration: 214.696µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:50:32.74721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.470504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T01:50:32.747245Z","caller":"traceutil/trace.go:171","msg":"trace[1659285183] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:740; }","duration":"402.555647ms","start":"2026-02-11T01:50:32.344679Z","end":"2026-02-11T01:50:32.747234Z","steps":["trace[1659285183] 'agreement among raft nodes before linearized reading' (duration: 402.450394ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:32.747284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:32.344668Z","time spent":"402.603548ms","remote":"127.0.0.1:43846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":40,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"info","ts":"2026-02-11T01:50:32.747311Z","caller":"traceutil/trace.go:171","msg":"trace[1425320089] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"507.041123ms","start":"2026-02-11T01:50:32.240249Z","end":"2026-02-11T01:50:32.74729Z","steps":["trace[1425320089] 'process raft request' (duration: 506.638512ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:32.747432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:32.240231Z","time spent":"507.127485ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:50:48.390571Z","caller":"traceutil/trace.go:171","msg":"trace[1491106340] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"287.869427ms","start":"2026-02-11T01:50:48.102683Z","end":"2026-02-11T01:50:48.390552Z","steps":["trace[1491106340] 'process raft request' (duration: 287.729233ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:50.448818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.164594ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:50:50.448895Z","caller":"traceutil/trace.go:171","msg":"trace[1804646128] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:796; }","duration":"261.261807ms","start":"2026-02-11T01:50:50.187622Z","end":"2026-02-11T01:50:50.448884Z","steps":["trace[1804646128] 'range keys from in-memory index tree' (duration: 261.148314ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:50.449028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.968878ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-02-11T01:50:51.779942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.954807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-02-11T01:50:51.780472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.156564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T01:50:51.780505Z","caller":"traceutil/trace.go:171","msg":"trace[1409825841] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:797; }","duration":"563.217915ms","start":"2026-02-11T01:50:51.217279Z","end":"2026-02-11T01:50:51.780497Z","steps":["trace[1409825841] 'count revisions from in-memory index tree' (duration: 563.03325ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:51.78053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:51.217267Z","time spent":"563.256637ms","remote":"127.0.0.1:44038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":51,"response size":30,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"warn","ts":"2026-02-11T01:50:51.780744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.141394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-11T01:50:51.780763Z","caller":"traceutil/trace.go:171","msg":"trace[1266228198] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:797; }","duration":"576.183866ms","start":"2026-02-11T01:50:51.204573Z","end":"2026-02-11T01:50:51.780757Z","steps":["trace[1266228198] 'range keys from in-memory index tree' (duration: 576.066082ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:51.78078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:51.204562Z","time spent":"576.212946ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-11T01:50:51.78Z","caller":"traceutil/trace.go:171","msg":"trace[2131527019] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:797; }","duration":"609.05951ms","start":"2026-02-11T01:50:51.170926Z","end":"2026-02-11T01:50:51.779985Z","steps":["trace[2131527019] 'range keys from in-memory index tree' (duration: 608.802843ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:51.781114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:51.170903Z","time spent":"610.201372ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-11T01:50:51.781376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.696598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-11T01:50:51.781408Z","caller":"traceutil/trace.go:171","msg":"trace[353618037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:797; }","duration":"563.74153ms","start":"2026-02-11T01:50:51.21766Z","end":"2026-02-11T01:50:51.781401Z","steps":["trace[353618037] 'range keys from in-memory index tree' (duration: 563.613356ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:51.781587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:51.217651Z","time spent":"563.923385ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-11T01:50:51.781807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.478035ms","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-02-11T01:50:51.781833Z","caller":"traceutil/trace.go:171","msg":"trace[841296181] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:797; }","duration":"571.546477ms","start":"2026-02-11T01:50:51.21028Z","end":"2026-02-11T01:50:51.781827Z","steps":["trace[841296181] 'range keys from in-memory index tree' (duration: 571.341281ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:51.783366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:51.210258Z","time spent":"573.096969ms","remote":"127.0.0.1:43934","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-02-11T01:50:52.262086Z","caller":"traceutil/trace.go:171","msg":"trace[1194100905] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"475.722831ms","start":"2026-02-11T01:50:51.786341Z","end":"2026-02-11T01:50:52.262064Z","steps":["trace[1194100905] 'process raft request' (duration: 475.548576ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:52.262258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:51.786328Z","time spent":"475.847185ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:50:52.660484Z","caller":"traceutil/trace.go:171","msg":"trace[2119059467] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"874.028629ms","start":"2026-02-11T01:50:51.786435Z","end":"2026-02-11T01:50:52.660464Z","steps":["trace[2119059467] 'process raft request' (duration: 873.72137ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:52.661316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:51.786416Z","time spent":"874.824291ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:50:52.660664Z","caller":"traceutil/trace.go:171","msg":"trace[376924753] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"872.576728ms","start":"2026-02-11T01:50:51.788068Z","end":"2026-02-11T01:50:52.660645Z","steps":["trace[376924753] 'process raft request' (duration: 872.348912ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:52.661527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:51.788059Z","time spent":"873.440043ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:50:52.660864Z","caller":"traceutil/trace.go:171","msg":"trace[1985747361] linearizableReadLoop","detail":"{readStateIndex:830; appliedIndex:827; }","duration":"717.530366ms","start":"2026-02-11T01:50:51.943323Z","end":"2026-02-11T01:50:52.660853Z","steps":["trace[1985747361] 'read index received' (duration: 319.423034ms)","trace[1985747361] 'applied index is now lower than readState.Index' (duration: 398.106572ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:50:52.661844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.82498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T01:50:52.661891Z","caller":"traceutil/trace.go:171","msg":"trace[157449715] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:801; }","duration":"568.904542ms","start":"2026-02-11T01:50:52.092975Z","end":"2026-02-11T01:50:52.66188Z","steps":["trace[157449715] 'agreement among raft nodes before linearized reading' (duration: 568.83222ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:52.661924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:52.092958Z","time spent":"568.957374ms","remote":"127.0.0.1:44172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":3,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-02-11T01:50:52.660949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"717.622389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:50:52.662116Z","caller":"traceutil/trace.go:171","msg":"trace[918918641] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:801; }","duration":"718.824532ms","start":"2026-02-11T01:50:51.943271Z","end":"2026-02-11T01:50:52.662096Z","steps":["trace[918918641] 'agreement among raft nodes before linearized reading' (duration: 717.616429ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:52.662151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:51.943256Z","time spent":"718.885854ms","remote":"127.0.0.1:43898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-02-11T01:50:52.662305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.576775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:50:52.662384Z","caller":"traceutil/trace.go:171","msg":"trace[1869758593] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:801; }","duration":"462.655297ms","start":"2026-02-11T01:50:52.199719Z","end":"2026-02-11T01:50:52.662375Z","steps":["trace[1869758593] 'agreement among raft nodes before linearized reading' (duration: 462.562814ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:52.662414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:52.19968Z","time spent":"462.725449ms","remote":"127.0.0.1:43964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"info","ts":"2026-02-11T01:50:52.661057Z","caller":"traceutil/trace.go:171","msg":"trace[1168452909] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"872.539497ms","start":"2026-02-11T01:50:51.788502Z","end":"2026-02-11T01:50:52.661041Z","steps":["trace[1168452909] 'process raft request' (duration: 872.093785ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:50:52.66263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:50:51.788497Z","time spent":"874.099721ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:51:04.895597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.441442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-11T01:51:04.895691Z","caller":"traceutil/trace.go:171","msg":"trace[1551094954] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:887; }","duration":"128.577506ms","start":"2026-02-11T01:51:04.7671Z","end":"2026-02-11T01:51:04.895677Z","steps":["trace[1551094954] 'agreement among raft nodes before linearized reading' (duration: 81.553058ms)","trace[1551094954] 'range keys from in-memory index tree' (duration: 46.866294ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:51:04.895927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.925174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:51:04.895942Z","caller":"traceutil/trace.go:171","msg":"trace[691851441] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:887; }","duration":"138.955844ms","start":"2026-02-11T01:51:04.756981Z","end":"2026-02-11T01:51:04.895937Z","steps":["trace[691851441] 'agreement among raft nodes before linearized reading' (duration: 91.811003ms)","trace[691851441] 'range keys from in-memory index tree' (duration: 47.124521ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:51:04.896118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.609596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-11T01:51:04.896137Z","caller":"traceutil/trace.go:171","msg":"trace[1405064705] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:887; }","duration":"110.649828ms","start":"2026-02-11T01:51:04.78548Z","end":"2026-02-11T01:51:04.89613Z","steps":["trace[1405064705] 'agreement among raft nodes before linearized reading' (duration: 63.317031ms)","trace[1405064705] 'range keys from in-memory index tree' (duration: 46.690629ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:51:05.310949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.125473ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-02-11T01:51:05.311068Z","caller":"traceutil/trace.go:171","msg":"trace[1421855390] linearizableReadLoop","detail":"{readStateIndex:923; appliedIndex:922; }","duration":"306.901006ms","start":"2026-02-11T01:51:05.004106Z","end":"2026-02-11T01:51:05.311007Z","steps":["trace[1421855390] 'read index received' (duration: 86.665751ms)","trace[1421855390] 'applied index is now lower than readState.Index' (duration: 220.234075ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:51:05.311124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:04.930266Z","time spent":"380.855453ms","remote":"127.0.0.1:43668","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-11T01:51:05.311327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.211775ms","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-02-11T01:51:05.311348Z","caller":"traceutil/trace.go:171","msg":"trace[371185346] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:889; }","duration":"307.259456ms","start":"2026-02-11T01:51:05.004081Z","end":"2026-02-11T01:51:05.31134Z","steps":["trace[371185346] 'agreement among raft nodes before linearized reading' (duration: 307.164394ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:05.311366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:05.004069Z","time spent":"307.293237ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-11T01:51:05.312138Z","caller":"traceutil/trace.go:171","msg":"trace[91282623] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"152.980055ms","start":"2026-02-11T01:51:05.159139Z","end":"2026-02-11T01:51:05.312119Z","steps":["trace[91282623] 'process raft request' (duration: 152.507642ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:07.413869Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877022073458588,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-11T01:51:07.640648Z","caller":"traceutil/trace.go:171","msg":"trace[555719614] linearizableReadLoop","detail":"{readStateIndex:928; appliedIndex:927; }","duration":"727.622438ms","start":"2026-02-11T01:51:06.912987Z","end":"2026-02-11T01:51:07.64061Z","steps":["trace[555719614] 'read index received' (duration: 727.413772ms)","trace[555719614] 'applied index is now lower than readState.Index' (duration: 207.706µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:51:07.640756Z","caller":"traceutil/trace.go:171","msg":"trace[1367728511] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"785.501058ms","start":"2026-02-11T01:51:06.855243Z","end":"2026-02-11T01:51:07.640744Z","steps":["trace[1367728511] 'process raft request' (duration: 785.23062ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:07.640858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:06.855228Z","time spent":"785.5634ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:51:07.641053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"724.708167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-11T01:51:07.641116Z","caller":"traceutil/trace.go:171","msg":"trace[1589025252] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:894; }","duration":"724.79683ms","start":"2026-02-11T01:51:06.916304Z","end":"2026-02-11T01:51:07.6411Z","steps":["trace[1589025252] 'agreement among raft nodes before linearized reading' (duration: 724.628425ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:07.641155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:06.916298Z","time spent":"724.849061ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-11T01:51:07.641326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.341428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-11T01:51:07.641344Z","caller":"traceutil/trace.go:171","msg":"trace[345730682] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:894; }","duration":"728.380279ms","start":"2026-02-11T01:51:06.912958Z","end":"2026-02-11T01:51:07.641338Z","steps":["trace[345730682] 'agreement among raft nodes before linearized reading' (duration: 728.327638ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:07.64136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:06.912931Z","time spent":"728.42546ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-11T01:51:07.641469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.0506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-11T01:51:07.641489Z","caller":"traceutil/trace.go:171","msg":"trace[156219803] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:894; }","duration":"275.106311ms","start":"2026-02-11T01:51:07.366377Z","end":"2026-02-11T01:51:07.641483Z","steps":["trace[156219803] 'agreement among raft nodes before linearized reading' (duration: 275.05456ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:51:08.015325Z","caller":"traceutil/trace.go:171","msg":"trace[999147158] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"369.167268ms","start":"2026-02-11T01:51:07.646142Z","end":"2026-02-11T01:51:08.015309Z","steps":["trace[999147158] 'process raft request' (duration: 369.071635ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:08.015423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:07.646125Z","time spent":"369.24795ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:51:08.431121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.207818ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T01:51:08.431207Z","caller":"traceutil/trace.go:171","msg":"trace[2035274732] linearizableReadLoop","detail":"{readStateIndex:931; appliedIndex:929; }","duration":"676.017622ms","start":"2026-02-11T01:51:07.755181Z","end":"2026-02-11T01:51:08.431198Z","steps":["trace[2035274732] 'read index received' (duration: 260.281749ms)","trace[2035274732] 'applied index is now lower than readState.Index' (duration: 415.735303ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:51:08.431325Z","caller":"traceutil/trace.go:171","msg":"trace[1966381738] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"778.244625ms","start":"2026-02-11T01:51:07.653073Z","end":"2026-02-11T01:51:08.431317Z","steps":["trace[1966381738] 'process raft request' (duration: 586.796361ms)","trace[1966381738] 'compare' (duration: 191.152846ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:51:08.431354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:07.653057Z","time spent":"778.282507ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:51:08.431439Z","caller":"traceutil/trace.go:171","msg":"trace[240924252] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"778.140203ms","start":"2026-02-11T01:51:07.653294Z","end":"2026-02-11T01:51:08.431434Z","steps":["trace[240924252] 'process raft request' (duration: 777.879115ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:08.431462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:07.653289Z","time spent":"778.160013ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:51:08.431523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.343001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:51:08.431536Z","caller":"traceutil/trace.go:171","msg":"trace[1392049193] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:897; }","duration":"676.378432ms","start":"2026-02-11T01:51:07.755153Z","end":"2026-02-11T01:51:08.431532Z","steps":["trace[1392049193] 'agreement among raft nodes before linearized reading' (duration: 676.356882ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:08.431548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:07.755141Z","time spent":"676.404773ms","remote":"127.0.0.1:43632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-11T01:51:08.431619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.833667ms","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-02-11T01:51:08.431643Z","caller":"traceutil/trace.go:171","msg":"trace[445488022] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:897; }","duration":"122.870787ms","start":"2026-02-11T01:51:08.308757Z","end":"2026-02-11T01:51:08.431627Z","steps":["trace[445488022] 'agreement among raft nodes before linearized reading' (duration: 122.848947ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:08.979042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.050644ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T01:51:08.979218Z","caller":"traceutil/trace.go:171","msg":"trace[1733179469] transaction","detail":"{read_only:false; response_revision:899; number_of_response:1; }","duration":"207.240725ms","start":"2026-02-11T01:51:08.771965Z","end":"2026-02-11T01:51:08.979206Z","steps":["trace[1733179469] 'process raft request' (duration: 207.151322ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:51:08.979437Z","caller":"traceutil/trace.go:171","msg":"trace[1178757746] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"542.835249ms","start":"2026-02-11T01:51:08.436593Z","end":"2026-02-11T01:51:08.979428Z","steps":["trace[1178757746] 'process raft request' (duration: 127.341902ms)","trace[1178757746] 'compare' (duration: 413.898312ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:51:08.979479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:08.436584Z","time spent":"542.870529ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:51:08.979558Z","caller":"traceutil/trace.go:171","msg":"trace[496701429] linearizableReadLoop","detail":"{readStateIndex:932; appliedIndex:931; }","duration":"235.735847ms","start":"2026-02-11T01:51:08.743815Z","end":"2026-02-11T01:51:08.979551Z","steps":["trace[496701429] 'read index received' (duration: 36.661µs)","trace[496701429] 'applied index is now lower than readState.Index' (duration: 235.698446ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:51:08.979601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.787178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T01:51:08.979617Z","caller":"traceutil/trace.go:171","msg":"trace[279909642] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:899; }","duration":"235.831219ms","start":"2026-02-11T01:51:08.74378Z","end":"2026-02-11T01:51:08.979612Z","steps":["trace[279909642] 'agreement among raft nodes before linearized reading' (duration: 235.792968ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:11.100951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.56703ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-11T01:51:11.101012Z","caller":"traceutil/trace.go:171","msg":"trace[1442895855] linearizableReadLoop","detail":"{readStateIndex:936; appliedIndex:935; }","duration":"662.181917ms","start":"2026-02-11T01:51:10.438819Z","end":"2026-02-11T01:51:11.101001Z","steps":["trace[1442895855] 'read index received' (duration: 91.524295ms)","trace[1442895855] 'applied index is now lower than readState.Index' (duration: 570.656802ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:51:11.101162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.337033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-11T01:51:11.101176Z","caller":"traceutil/trace.go:171","msg":"trace[884620063] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:901; }","duration":"662.384643ms","start":"2026-02-11T01:51:10.438787Z","end":"2026-02-11T01:51:11.101171Z","steps":["trace[884620063] 'agreement among raft nodes before linearized reading' (duration: 662.303121ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:11.101205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:10.438772Z","time spent":"662.428775ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-11T01:51:11.101321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.768538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-11T01:51:11.101333Z","caller":"traceutil/trace.go:171","msg":"trace[1294416810] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:901; }","duration":"660.8155ms","start":"2026-02-11T01:51:10.440514Z","end":"2026-02-11T01:51:11.10133Z","steps":["trace[1294416810] 'agreement among raft nodes before linearized reading' (duration: 660.776268ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:11.101345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:10.440495Z","time spent":"660.847351ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-11T01:51:11.101451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.998232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-11T01:51:11.101464Z","caller":"traceutil/trace.go:171","msg":"trace[318171893] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:901; }","duration":"118.054703ms","start":"2026-02-11T01:51:10.983406Z","end":"2026-02-11T01:51:11.10146Z","steps":["trace[318171893] 'agreement among raft nodes before linearized reading' (duration: 118.008872ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:11.101526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.184564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:51:11.101539Z","caller":"traceutil/trace.go:171","msg":"trace[806084223] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:901; }","duration":"348.224515ms","start":"2026-02-11T01:51:10.753311Z","end":"2026-02-11T01:51:11.101536Z","steps":["trace[806084223] 'agreement among raft nodes before linearized reading' (duration: 348.204125ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:11.101552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:10.753298Z","time spent":"348.250776ms","remote":"127.0.0.1:43632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-11T01:51:11.101617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.745266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T01:51:11.101631Z","caller":"traceutil/trace.go:171","msg":"trace[143927796] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:901; }","duration":"441.780788ms","start":"2026-02-11T01:51:10.659845Z","end":"2026-02-11T01:51:11.101626Z","steps":["trace[143927796] 'agreement among raft nodes before linearized reading' (duration: 441.758537ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:11.101643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:10.659833Z","time spent":"441.806758ms","remote":"127.0.0.1:44130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-02-11T01:51:11.285534Z","caller":"traceutil/trace.go:171","msg":"trace[1793722020] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"175.244335ms","start":"2026-02-11T01:51:11.110273Z","end":"2026-02-11T01:51:11.285517Z","steps":["trace[1793722020] 'process raft request' (duration: 175.206373ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:51:11.291005Z","caller":"traceutil/trace.go:171","msg":"trace[144241467] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"181.440967ms","start":"2026-02-11T01:51:11.109549Z","end":"2026-02-11T01:51:11.29099Z","steps":["trace[144241467] 'process raft request' (duration: 110.038861ms)","trace[144241467] 'compare' (duration: 65.630685ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:51:11.96586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.05432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-11T01:51:11.965877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.328057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-11T01:51:11.965916Z","caller":"traceutil/trace.go:171","msg":"trace[487139129] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:904; }","duration":"211.142743ms","start":"2026-02-11T01:51:11.75476Z","end":"2026-02-11T01:51:11.965903Z","steps":["trace[487139129] 'range keys from in-memory index tree' (duration: 210.982819ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:51:11.965945Z","caller":"traceutil/trace.go:171","msg":"trace[448096762] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:904; }","duration":"289.404549ms","start":"2026-02-11T01:51:11.676526Z","end":"2026-02-11T01:51:11.96593Z","steps":["trace[448096762] 'range keys from in-memory index tree' (duration: 289.196874ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:12.229396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.402189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-11T01:51:12.229444Z","caller":"traceutil/trace.go:171","msg":"trace[1499902438] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:905; }","duration":"129.485271ms","start":"2026-02-11T01:51:12.099947Z","end":"2026-02-11T01:51:12.229433Z","steps":["trace[1499902438] 'range keys from in-memory index tree' (duration: 129.302146ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:12.229684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.831485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T01:51:12.229699Z","caller":"traceutil/trace.go:171","msg":"trace[36087793] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:905; }","duration":"141.870396ms","start":"2026-02-11T01:51:12.087823Z","end":"2026-02-11T01:51:12.229693Z","steps":["trace[36087793] 'count revisions from in-memory index tree' (duration: 141.782534ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:51:13.570191Z","caller":"traceutil/trace.go:171","msg":"trace[457104785] linearizableReadLoop","detail":"{readStateIndex:942; appliedIndex:941; }","duration":"274.638538ms","start":"2026-02-11T01:51:13.295531Z","end":"2026-02-11T01:51:13.570169Z","steps":["trace[457104785] 'read index received' (duration: 274.417112ms)","trace[457104785] 'applied index is now lower than readState.Index' (duration: 220.466µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:51:13.57048Z","caller":"traceutil/trace.go:171","msg":"trace[1329859557] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"380.787502ms","start":"2026-02-11T01:51:13.189685Z","end":"2026-02-11T01:51:13.570472Z","steps":["trace[1329859557] 'process raft request' (duration: 380.313198ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:13.570558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:13.189658Z","time spent":"380.847803ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:51:13.570743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.220955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-11T01:51:13.570766Z","caller":"traceutil/trace.go:171","msg":"trace[1728645329] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:907; }","duration":"275.274257ms","start":"2026-02-11T01:51:13.295484Z","end":"2026-02-11T01:51:13.570758Z","steps":["trace[1728645329] 'agreement among raft nodes before linearized reading' (duration: 275.175984ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:13.570877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.403972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-11T01:51:13.570893Z","caller":"traceutil/trace.go:171","msg":"trace[174258559] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:907; }","duration":"274.455173ms","start":"2026-02-11T01:51:13.296433Z","end":"2026-02-11T01:51:13.570888Z","steps":["trace[174258559] 'agreement among raft nodes before linearized reading' (duration: 274.408602ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:16.578878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.038977ms","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-02-11T01:51:16.578941Z","caller":"traceutil/trace.go:171","msg":"trace[1443372767] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:917; }","duration":"249.124178ms","start":"2026-02-11T01:51:16.329789Z","end":"2026-02-11T01:51:16.578913Z","steps":["trace[1443372767] 'range keys from in-memory index tree' (duration: 248.912223ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:51:16.854167Z","caller":"traceutil/trace.go:171","msg":"trace[486310918] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"272.675234ms","start":"2026-02-11T01:51:16.581437Z","end":"2026-02-11T01:51:16.854112Z","steps":["trace[486310918] 'process raft request' (duration: 271.029348ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:17.395101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.218214ms","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-02-11T01:51:17.395166Z","caller":"traceutil/trace.go:171","msg":"trace[1897702474] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:918; }","duration":"298.304886ms","start":"2026-02-11T01:51:17.096845Z","end":"2026-02-11T01:51:17.39515Z","steps":["trace[1897702474] 'count revisions from in-memory index tree' (duration: 298.135331ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:51:17.884587Z","caller":"traceutil/trace.go:171","msg":"trace[1166325090] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"207.324007ms","start":"2026-02-11T01:51:17.677248Z","end":"2026-02-11T01:51:17.884572Z","steps":["trace[1166325090] 'process raft request' (duration: 207.295406ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:51:17.884793Z","caller":"traceutil/trace.go:171","msg":"trace[1635049498] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"207.986735ms","start":"2026-02-11T01:51:17.6768Z","end":"2026-02-11T01:51:17.884787Z","steps":["trace[1635049498] 'process raft request' (duration: 129.109481ms)","trace[1635049498] 'compare' (duration: 78.555245ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:51:19.259065Z","caller":"traceutil/trace.go:171","msg":"trace[206619782] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"398.397951ms","start":"2026-02-11T01:51:18.860651Z","end":"2026-02-11T01:51:19.259049Z","steps":["trace[206619782] 'process raft request' (duration: 398.307759ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:19.259151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:18.860641Z","time spent":"398.465023ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:51:19.259423Z","caller":"traceutil/trace.go:171","msg":"trace[1914312281] linearizableReadLoop","detail":"{readStateIndex:959; appliedIndex:959; }","duration":"341.22408ms","start":"2026-02-11T01:51:18.918192Z","end":"2026-02-11T01:51:19.259416Z","steps":["trace[1914312281] 'read index received' (duration: 341.22174ms)","trace[1914312281] 'applied index is now lower than readState.Index' (duration: 2.02µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:51:19.259454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.259432ms","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-02-11T01:51:19.259469Z","caller":"traceutil/trace.go:171","msg":"trace[673111599] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:923; }","duration":"341.296453ms","start":"2026-02-11T01:51:18.918168Z","end":"2026-02-11T01:51:19.259464Z","steps":["trace[673111599] 'agreement among raft nodes before linearized reading' (duration: 341.269042ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:19.259484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:18.918155Z","time spent":"341.325254ms","remote":"127.0.0.1:44064","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":"warn","ts":"2026-02-11T01:51:20.373422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.012103ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:51:20.373501Z","caller":"traceutil/trace.go:171","msg":"trace[402265528] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:923; }","duration":"186.098116ms","start":"2026-02-11T01:51:20.187391Z","end":"2026-02-11T01:51:20.373489Z","steps":["trace[402265528] 'range keys from in-memory index tree' (duration: 186.003053ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:20.373755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.953839ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T01:51:20.373829Z","caller":"traceutil/trace.go:171","msg":"trace[1027846130] linearizableReadLoop","detail":"{readStateIndex:960; appliedIndex:959; }","duration":"696.686317ms","start":"2026-02-11T01:51:19.677135Z","end":"2026-02-11T01:51:20.373822Z","steps":["trace[1027846130] 'read index received' (duration: 490.638256ms)","trace[1027846130] 'applied index is now lower than readState.Index' (duration: 206.047171ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:51:20.373938Z","caller":"traceutil/trace.go:171","msg":"trace[855143650] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"1.207158066s","start":"2026-02-11T01:51:19.166773Z","end":"2026-02-11T01:51:20.373931Z","steps":["trace[855143650] 'process raft request' (duration: 1.000988262s)","trace[855143650] 'compare' (duration: 205.514786ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:51:20.374035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:19.166751Z","time spent":"1.207265598s","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:51:20.374245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.112529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-11T01:51:20.374261Z","caller":"traceutil/trace.go:171","msg":"trace[1980006010] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:924; }","duration":"697.12929ms","start":"2026-02-11T01:51:19.677127Z","end":"2026-02-11T01:51:20.374256Z","steps":["trace[1980006010] 'agreement among raft nodes before linearized reading' (duration: 697.051318ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:20.374275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:19.677083Z","time spent":"697.189291ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-11T01:51:20.393467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.707413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:51:20.393541Z","caller":"traceutil/trace.go:171","msg":"trace[636981365] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:925; }","duration":"639.816366ms","start":"2026-02-11T01:51:19.75371Z","end":"2026-02-11T01:51:20.393527Z","steps":["trace[636981365] 'agreement among raft nodes before linearized reading' (duration: 639.670822ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:20.393572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:19.753697Z","time spent":"639.868407ms","remote":"127.0.0.1:43632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-11T01:51:20.393802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.683315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-11T01:51:20.393846Z","caller":"traceutil/trace.go:171","msg":"trace[1621037531] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:925; }","duration":"505.746037ms","start":"2026-02-11T01:51:19.888089Z","end":"2026-02-11T01:51:20.393835Z","steps":["trace[1621037531] 'agreement among raft nodes before linearized reading' (duration: 505.636644ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:20.393867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:19.888083Z","time spent":"505.780077ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-11T01:51:20.393867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.665942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-11T01:51:20.393892Z","caller":"traceutil/trace.go:171","msg":"trace[1309609572] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:925; }","duration":"506.723634ms","start":"2026-02-11T01:51:19.887161Z","end":"2026-02-11T01:51:20.393885Z","steps":["trace[1309609572] 'agreement among raft nodes before linearized reading' (duration: 506.616881ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:20.39391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:19.887143Z","time spent":"506.762635ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-11T01:51:20.39397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.980587ms","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-02-11T01:51:20.393985Z","caller":"traceutil/trace.go:171","msg":"trace[995464942] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:925; }","duration":"225.029919ms","start":"2026-02-11T01:51:20.168951Z","end":"2026-02-11T01:51:20.393981Z","steps":["trace[995464942] 'agreement among raft nodes before linearized reading' (duration: 224.984557ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:51:26.877042Z","caller":"traceutil/trace.go:171","msg":"trace[1360724327] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"462.602168ms","start":"2026-02-11T01:51:26.41442Z","end":"2026-02-11T01:51:26.877022Z","steps":["trace[1360724327] 'process raft request' (duration: 462.513895ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:26.877202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:26.414404Z","time spent":"462.744102ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:51:26.877453Z","caller":"traceutil/trace.go:171","msg":"trace[1318092418] linearizableReadLoop","detail":"{readStateIndex:980; appliedIndex:980; }","duration":"422.53003ms","start":"2026-02-11T01:51:26.45491Z","end":"2026-02-11T01:51:26.87744Z","steps":["trace[1318092418] 'read index received' (duration: 422.52523ms)","trace[1318092418] 'applied index is now lower than readState.Index' (duration: 4.03µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:51:26.877603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.630082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-11T01:51:26.877642Z","caller":"traceutil/trace.go:171","msg":"trace[1289071855] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:942; }","duration":"422.685664ms","start":"2026-02-11T01:51:26.454947Z","end":"2026-02-11T01:51:26.877632Z","steps":["trace[1289071855] 'agreement among raft nodes before linearized reading' (duration: 422.561281ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:26.877679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:26.454941Z","time spent":"422.727725ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-11T01:51:26.877874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.960602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-11T01:51:26.877903Z","caller":"traceutil/trace.go:171","msg":"trace[169049442] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:942; }","duration":"423.023294ms","start":"2026-02-11T01:51:26.454873Z","end":"2026-02-11T01:51:26.877897Z","steps":["trace[169049442] 'agreement among raft nodes before linearized reading' (duration: 422.955842ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:26.877921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:26.454857Z","time spent":"423.060354ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-11T01:51:26.878007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.568159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:51:26.878023Z","caller":"traceutil/trace.go:171","msg":"trace[796110205] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:942; }","duration":"122.612289ms","start":"2026-02-11T01:51:26.755406Z","end":"2026-02-11T01:51:26.878018Z","steps":["trace[796110205] 'agreement among raft nodes before linearized reading' (duration: 122.585008ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:26.878246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.096333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-11T01:51:26.878272Z","caller":"traceutil/trace.go:171","msg":"trace[750212547] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:942; }","duration":"403.146024ms","start":"2026-02-11T01:51:26.47512Z","end":"2026-02-11T01:51:26.878266Z","steps":["trace[750212547] 'agreement among raft nodes before linearized reading' (duration: 403.081652ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:26.878291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:26.475082Z","time spent":"403.205097ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-11T01:51:27.149545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.472303ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T01:51:27.14972Z","caller":"traceutil/trace.go:171","msg":"trace[17066532] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"259.921095ms","start":"2026-02-11T01:51:26.889784Z","end":"2026-02-11T01:51:27.149705Z","steps":["trace[17066532] 'process raft request' (duration: 259.886744ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:51:27.149956Z","caller":"traceutil/trace.go:171","msg":"trace[528987279] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"264.005308ms","start":"2026-02-11T01:51:26.88594Z","end":"2026-02-11T01:51:27.149945Z","steps":["trace[528987279] 'process raft request' (duration: 127.071403ms)","trace[528987279] 'compare' (duration: 136.309387ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:51:27.150059Z","caller":"traceutil/trace.go:171","msg":"trace[1558885869] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"262.155197ms","start":"2026-02-11T01:51:26.887896Z","end":"2026-02-11T01:51:27.150051Z","steps":["trace[1558885869] 'process raft request' (duration: 261.731585ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:27.700465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.727506ms","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-02-11T01:51:27.700532Z","caller":"traceutil/trace.go:171","msg":"trace[1719455783] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:945; }","duration":"413.85217ms","start":"2026-02-11T01:51:27.286664Z","end":"2026-02-11T01:51:27.700516Z","steps":["trace[1719455783] 'range keys from in-memory index tree' (duration: 413.579993ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:27.70057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:27.286651Z","time spent":"413.910702ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-11T01:51:27.894926Z","caller":"traceutil/trace.go:171","msg":"trace[580762375] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"188.300135ms","start":"2026-02-11T01:51:27.706608Z","end":"2026-02-11T01:51:27.894908Z","steps":["trace[580762375] 'process raft request' (duration: 188.191712ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:51:29.035961Z","caller":"traceutil/trace.go:171","msg":"trace[2044218977] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"140.388481ms","start":"2026-02-11T01:51:28.895552Z","end":"2026-02-11T01:51:29.03594Z","steps":["trace[2044218977] 'process raft request' (duration: 140.280698ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:31.488422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.931998ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T01:51:31.488566Z","caller":"traceutil/trace.go:171","msg":"trace[1761572465] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"167.84146ms","start":"2026-02-11T01:51:31.320713Z","end":"2026-02-11T01:51:31.488555Z","steps":["trace[1761572465] 'process raft request' (duration: 167.775558ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:51:31.488772Z","caller":"traceutil/trace.go:171","msg":"trace[357391724] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"168.833828ms","start":"2026-02-11T01:51:31.31993Z","end":"2026-02-11T01:51:31.488764Z","steps":["trace[357391724] 'process raft request' (duration: 11.502779ms)","trace[357391724] 'compare' (duration: 156.778913ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:51:41.166511Z","caller":"traceutil/trace.go:171","msg":"trace[371313037] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"152.799004ms","start":"2026-02-11T01:51:41.013685Z","end":"2026-02-11T01:51:41.166484Z","steps":["trace[371313037] 'process raft request' (duration: 152.391322ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:51:44.730572Z","caller":"traceutil/trace.go:171","msg":"trace[447988405] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"706.480839ms","start":"2026-02-11T01:51:44.024072Z","end":"2026-02-11T01:51:44.730553Z","steps":["trace[447988405] 'process raft request' (duration: 706.324635ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:44.730679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:44.024056Z","time spent":"706.566532ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:51:45.837841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"905.10296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.132\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-11T01:51:45.837924Z","caller":"traceutil/trace.go:171","msg":"trace[1351251648] range","detail":"{range_begin:/registry/masterleases/199.204.45.132; range_end:; response_count:1; response_revision:1035; }","duration":"905.229323ms","start":"2026-02-11T01:51:44.932679Z","end":"2026-02-11T01:51:45.837908Z","steps":["trace[1351251648] 'range keys from in-memory index tree' (duration: 904.903714ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:45.837983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:44.932661Z","time spent":"905.311935ms","remote":"127.0.0.1:43668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.132\" "} {"level":"warn","ts":"2026-02-11T01:51:45.838966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"821.305163ms","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-02-11T01:51:45.839025Z","caller":"traceutil/trace.go:171","msg":"trace[140980383] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1035; }","duration":"821.405066ms","start":"2026-02-11T01:51:45.017606Z","end":"2026-02-11T01:51:45.839011Z","steps":["trace[140980383] 'range keys from in-memory index tree' (duration: 821.207961ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:45.839152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:45.017588Z","time spent":"821.458548ms","remote":"127.0.0.1:43934","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-02-11T01:51:45.839919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.769968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-11T01:51:45.839948Z","caller":"traceutil/trace.go:171","msg":"trace[1291370811] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1035; }","duration":"646.850851ms","start":"2026-02-11T01:51:45.193088Z","end":"2026-02-11T01:51:45.839939Z","steps":["trace[1291370811] 'range keys from in-memory index tree' (duration: 646.655515ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:45.839969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:45.193067Z","time spent":"646.895512ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-11T01:51:45.840201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.577081ms","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-02-11T01:51:45.840254Z","caller":"traceutil/trace.go:171","msg":"trace[1784827385] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1035; }","duration":"545.676574ms","start":"2026-02-11T01:51:45.294568Z","end":"2026-02-11T01:51:45.840245Z","steps":["trace[1784827385] 'range keys from in-memory index tree' (duration: 545.454948ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:45.840279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:45.294548Z","time spent":"545.724306ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-11T01:51:45.840783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.516091ms","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-02-11T01:51:45.840851Z","caller":"traceutil/trace.go:171","msg":"trace[1574433975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1035; }","duration":"519.605934ms","start":"2026-02-11T01:51:45.321236Z","end":"2026-02-11T01:51:45.840842Z","steps":["trace[1574433975] 'range keys from in-memory index tree' (duration: 519.051708ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:45.840876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:45.321224Z","time spent":"519.643934ms","remote":"127.0.0.1:43934","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-02-11T01:51:45.841916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.907275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-11T01:51:45.842029Z","caller":"traceutil/trace.go:171","msg":"trace[1205174786] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1035; }","duration":"489.042989ms","start":"2026-02-11T01:51:45.352977Z","end":"2026-02-11T01:51:45.84202Z","steps":["trace[1205174786] 'range keys from in-memory index tree' (duration: 488.799282ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:51:45.842335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:51:45.352966Z","time spent":"489.358318ms","remote":"127.0.0.1:43934","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":"info","ts":"2026-02-11T01:51:45.842786Z","caller":"traceutil/trace.go:171","msg":"trace[2082741240] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"144.930256ms","start":"2026-02-11T01:51:45.697844Z","end":"2026-02-11T01:51:45.842774Z","steps":["trace[2082741240] 'process raft request' (duration: 142.446067ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:53:42.618609Z","caller":"traceutil/trace.go:171","msg":"trace[83338445] transaction","detail":"{read_only:false; response_revision:1529; number_of_response:1; }","duration":"106.971701ms","start":"2026-02-11T01:53:42.511617Z","end":"2026-02-11T01:53:42.618589Z","steps":["trace[83338445] 'process raft request' (duration: 106.525969ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:54:33.137784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.030331ms","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-02-11T01:54:33.13787Z","caller":"traceutil/trace.go:171","msg":"trace[1671134890] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1735; }","duration":"198.125243ms","start":"2026-02-11T01:54:32.93973Z","end":"2026-02-11T01:54:33.137855Z","steps":["trace[1671134890] 'range keys from in-memory index tree' (duration: 197.66593ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:54:33.138586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.914094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-02-11T01:54:33.138677Z","caller":"traceutil/trace.go:171","msg":"trace[46553162] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1735; }","duration":"175.029206ms","start":"2026-02-11T01:54:32.963634Z","end":"2026-02-11T01:54:33.138664Z","steps":["trace[46553162] 'range keys from in-memory index tree' (duration: 173.68963ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:54:35.445192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.34078ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T01:54:35.445354Z","caller":"traceutil/trace.go:171","msg":"trace[1684647843] transaction","detail":"{read_only:false; response_revision:1748; number_of_response:1; }","duration":"102.324865ms","start":"2026-02-11T01:54:35.343017Z","end":"2026-02-11T01:54:35.445342Z","steps":["trace[1684647843] 'process raft request' (duration: 102.259943ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:54:35.445659Z","caller":"traceutil/trace.go:171","msg":"trace[2145185923] transaction","detail":"{read_only:false; response_revision:1747; number_of_response:1; }","duration":"172.336134ms","start":"2026-02-11T01:54:35.273298Z","end":"2026-02-11T01:54:35.445634Z","steps":["trace[2145185923] 'process raft request' (duration: 67.361117ms)","trace[2145185923] 'compare' (duration: 104.212996ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:54:56.223904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.441566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:54:56.224018Z","caller":"traceutil/trace.go:171","msg":"trace[232619083] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1853; }","duration":"468.600351ms","start":"2026-02-11T01:54:55.755401Z","end":"2026-02-11T01:54:56.224001Z","steps":["trace[232619083] 'range keys from in-memory index tree' (duration: 468.286892ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:54:56.224058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:54:55.755345Z","time spent":"468.704094ms","remote":"127.0.0.1:43632","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-02-11T01:54:56.232566Z","caller":"traceutil/trace.go:171","msg":"trace[2109874510] linearizableReadLoop","detail":"{readStateIndex:1935; appliedIndex:1934; }","duration":"110.915383ms","start":"2026-02-11T01:54:56.121628Z","end":"2026-02-11T01:54:56.232543Z","steps":["trace[2109874510] 'read index received' (duration: 110.738799ms)","trace[2109874510] 'applied index is now lower than readState.Index' (duration: 175.504µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:54:56.232727Z","caller":"traceutil/trace.go:171","msg":"trace[1387613796] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"355.205669ms","start":"2026-02-11T01:54:55.877508Z","end":"2026-02-11T01:54:56.232713Z","steps":["trace[1387613796] 'process raft request' (duration: 354.87159ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:54:56.23281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:54:55.877484Z","time spent":"355.27528ms","remote":"127.0.0.1:43934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:54:56.232875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.223912ms","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-02-11T01:54:56.232913Z","caller":"traceutil/trace.go:171","msg":"trace[1156025078] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1854; }","duration":"111.279343ms","start":"2026-02-11T01:54:56.121622Z","end":"2026-02-11T01:54:56.232901Z","steps":["trace[1156025078] 'agreement among raft nodes before linearized reading' (duration: 111.131069ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:55:02.968725Z","caller":"traceutil/trace.go:171","msg":"trace[1183358] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"159.932522ms","start":"2026-02-11T01:55:02.808777Z","end":"2026-02-11T01:55:02.96871Z","steps":["trace[1183358] 'process raft request' (duration: 159.527861ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:55:03.120238Z","caller":"traceutil/trace.go:171","msg":"trace[491433291] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"145.325211ms","start":"2026-02-11T01:55:02.974884Z","end":"2026-02-11T01:55:03.120209Z","steps":["trace[491433291] 'process raft request' (duration: 97.809963ms)","trace[491433291] 'compare' (duration: 47.382854ms)"],"step_count":2}