{"level":"warn","ts":"2026-02-17T23:06:28.892638Z","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-17T23:06:28.89272Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.113: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.113:2380","--initial-cluster=instance=https://199.204.45.113:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.113:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.113: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-17T23:06:28.893787Z","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-17T23:06:28.893805Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-02-17T23:06:28.894213Z","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-17T23:06:28.900851Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"]} {"level":"info","ts":"2026-02-17T23:06:28.901003Z","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.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.113: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-17T23:06:28.931129Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"25.986872ms"} {"level":"info","ts":"2026-02-17T23:06:28.947057Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a31e123290fcf0df","cluster-id":"37661d6ee45ed9e8"} {"level":"info","ts":"2026-02-17T23:06:28.947192Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=()"} {"level":"info","ts":"2026-02-17T23:06:28.947219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 0"} {"level":"info","ts":"2026-02-17T23:06:28.947227Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a31e123290fcf0df [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-17T23:06:28.947239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 1"} {"level":"info","ts":"2026-02-17T23:06:28.947305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"warn","ts":"2026-02-17T23:06:28.978867Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-17T23:06:28.983804Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-17T23:06:28.991039Z","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-17T23:06:29.004294Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a31e123290fcf0df","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-17T23:06:29.009908Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a31e123290fcf0df","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-17T23:06:29.010104Z","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-17T23:06:29.010185Z","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-17T23:06:29.01028Z","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-17T23:06:29.010734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"info","ts":"2026-02-17T23:06:29.012182Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","added-peer-id":"a31e123290fcf0df","added-peer-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-02-17T23:06:29.027666Z","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-17T23:06:29.027901Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a31e123290fcf0df","initial-advertise-peer-urls":["https://199.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-17T23:06:29.027938Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-17T23:06:29.028115Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-02-17T23:06:29.028127Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-02-17T23:06:29.751066Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df is starting a new election at term 1"} {"level":"info","ts":"2026-02-17T23:06:29.751136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became pre-candidate at term 1"} {"level":"info","ts":"2026-02-17T23:06:29.75115Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgPreVoteResp from a31e123290fcf0df at term 1"} {"level":"info","ts":"2026-02-17T23:06:29.751164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became candidate at term 2"} {"level":"info","ts":"2026-02-17T23:06:29.751173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgVoteResp from a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-02-17T23:06:29.751181Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became leader at term 2"} {"level":"info","ts":"2026-02-17T23:06:29.751191Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a31e123290fcf0df elected leader a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-02-17T23:06:29.75244Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T23:06:29.759141Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a31e123290fcf0df","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.113:2379]}","request-path":"/0/members/a31e123290fcf0df/attributes","cluster-id":"37661d6ee45ed9e8","publish-timeout":"7s"} {"level":"info","ts":"2026-02-17T23:06:29.762154Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T23:06:29.763979Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.113:2379"} {"level":"info","ts":"2026-02-17T23:06:29.764129Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T23:06:29.764059Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T23:06:29.766084Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T23:06:29.766169Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T23:06:29.776852Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-17T23:06:29.77687Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-17T23:06:29.779702Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-02-17T23:06:31.497452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.512001ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-17T23:06:31.497871Z","caller":"traceutil/trace.go:171","msg":"trace[331335023] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"258.645981ms","start":"2026-02-17T23:06:31.239207Z","end":"2026-02-17T23:06:31.497853Z","steps":["trace[331335023] 'process raft request' (duration: 258.36743ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:31.498393Z","caller":"traceutil/trace.go:171","msg":"trace[176817009] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"259.569028ms","start":"2026-02-17T23:06:31.238811Z","end":"2026-02-17T23:06:31.49838Z","steps":["trace[176817009] 'process raft request' (duration: 114.659121ms)","trace[176817009] 'compare' (duration: 143.386626ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:31.500651Z","caller":"traceutil/trace.go:171","msg":"trace[323927936] linearizableReadLoop","detail":"{readStateIndex:41; appliedIndex:37; }","duration":"254.504173ms","start":"2026-02-17T23:06:31.246134Z","end":"2026-02-17T23:06:31.500639Z","steps":["trace[323927936] 'read index received' (duration: 107.287352ms)","trace[323927936] 'applied index is now lower than readState.Index' (duration: 147.215841ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:31.501156Z","caller":"traceutil/trace.go:171","msg":"trace[1857112050] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"260.34834ms","start":"2026-02-17T23:06:31.240781Z","end":"2026-02-17T23:06:31.501129Z","steps":["trace[1857112050] 'process raft request' (duration: 259.672652ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:31.501827Z","caller":"traceutil/trace.go:171","msg":"trace[1023837943] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"255.852958ms","start":"2026-02-17T23:06:31.245962Z","end":"2026-02-17T23:06:31.501815Z","steps":["trace[1023837943] 'process raft request' (duration: 254.542525ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:31.502285Z","caller":"traceutil/trace.go:171","msg":"trace[631958155] transaction","detail":"{read_only:false; response_revision:39; number_of_response:1; }","duration":"255.888559ms","start":"2026-02-17T23:06:31.246379Z","end":"2026-02-17T23:06:31.502268Z","steps":["trace[631958155] 'process raft request' (duration: 254.204431ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:31.502434Z","caller":"traceutil/trace.go:171","msg":"trace[1321737012] transaction","detail":"{read_only:false; response_revision:40; number_of_response:1; }","duration":"254.992722ms","start":"2026-02-17T23:06:31.247431Z","end":"2026-02-17T23:06:31.502424Z","steps":["trace[1321737012] 'process raft request' (duration: 253.179549ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:31.502518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.367808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-17T23:06:31.507817Z","caller":"traceutil/trace.go:171","msg":"trace[1464183340] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:40; }","duration":"261.682935ms","start":"2026-02-17T23:06:31.246114Z","end":"2026-02-17T23:06:31.507797Z","steps":["trace[1464183340] 'agreement among raft nodes before linearized reading' (duration: 256.353678ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:31.502558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.724821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T23:06:31.508244Z","caller":"traceutil/trace.go:171","msg":"trace[709726557] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:40; }","duration":"240.38996ms","start":"2026-02-17T23:06:31.267795Z","end":"2026-02-17T23:06:31.508185Z","steps":["trace[709726557] 'agreement among raft nodes before linearized reading' (duration: 234.745911ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:31.502612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.362909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T23:06:31.508698Z","caller":"traceutil/trace.go:171","msg":"trace[1447375895] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:40; }","duration":"211.499139ms","start":"2026-02-17T23:06:31.297187Z","end":"2026-02-17T23:06:31.508686Z","steps":["trace[1447375895] 'agreement among raft nodes before linearized reading' (duration: 205.399391ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:31.502724Z","caller":"traceutil/trace.go:171","msg":"trace[911672009] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"256.451042ms","start":"2026-02-17T23:06:31.246263Z","end":"2026-02-17T23:06:31.502714Z","steps":["trace[911672009] 'process raft request' (duration: 254.291695ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:32.984822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.083859722s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-17T23:06:32.985038Z","caller":"traceutil/trace.go:171","msg":"trace[1827704110] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"1.472280726s","start":"2026-02-17T23:06:31.512714Z","end":"2026-02-17T23:06:32.984995Z","steps":["trace[1827704110] 'process raft request' (duration: 388.190625ms)","trace[1827704110] 'compare' (duration: 1.083725016s)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:32.985087Z","caller":"traceutil/trace.go:171","msg":"trace[1755060210] linearizableReadLoop","detail":"{readStateIndex:45; appliedIndex:44; }","duration":"1.470111839s","start":"2026-02-17T23:06:31.514965Z","end":"2026-02-17T23:06:32.985076Z","steps":["trace[1755060210] 'read index received' (duration: 385.953735ms)","trace[1755060210] 'applied index is now lower than readState.Index' (duration: 1.084157193s)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:32.985198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:31.512707Z","time spent":"1.472426262s","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":715,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T23:06:32.985429Z","caller":"traceutil/trace.go:171","msg":"trace[1644922550] transaction","detail":"{read_only:false; response_revision:42; number_of_response:1; }","duration":"1.469702402s","start":"2026-02-17T23:06:31.515713Z","end":"2026-02-17T23:06:32.985416Z","steps":["trace[1644922550] 'process raft request' (duration: 1.469204782s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:32.985512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:31.515707Z","time spent":"1.469773555s","remote":"127.0.0.1:60542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":326,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T23:06:32.985049Z","caller":"traceutil/trace.go:171","msg":"trace[774166950] transaction","detail":"{read_only:false; response_revision:43; number_of_response:1; }","duration":"1.464698989s","start":"2026-02-17T23:06:31.520322Z","end":"2026-02-17T23:06:32.985021Z","steps":["trace[774166950] 'process raft request' (duration: 1.464650777s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:32.985817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:31.520315Z","time spent":"1.465307534s","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:06:32.985865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.47088853s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:429"} {"level":"info","ts":"2026-02-17T23:06:32.987419Z","caller":"traceutil/trace.go:171","msg":"trace[1163148854] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:43; }","duration":"1.472453573s","start":"2026-02-17T23:06:31.514954Z","end":"2026-02-17T23:06:32.987408Z","steps":["trace[1163148854] 'agreement among raft nodes before linearized reading' (duration: 1.470873729s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:32.987485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:31.514949Z","time spent":"1.472505786s","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":452,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-17T23:06:32.985934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.470942512s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-skffx\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-02-17T23:06:32.98765Z","caller":"traceutil/trace.go:171","msg":"trace[1126826387] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-skffx; range_end:; response_count:1; response_revision:43; }","duration":"1.472661802s","start":"2026-02-17T23:06:31.51498Z","end":"2026-02-17T23:06:32.987642Z","steps":["trace[1126826387] 'agreement among raft nodes before linearized reading' (duration: 1.470929931s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:32.98769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:31.514977Z","time spent":"1.472704983s","remote":"127.0.0.1:60678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":884,"request content":"key:\"/registry/certificatesigningrequests/csr-skffx\" "} {"level":"warn","ts":"2026-02-17T23:06:32.986011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"786.069339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T23:06:32.987821Z","caller":"traceutil/trace.go:171","msg":"trace[419271388] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:43; }","duration":"787.943625ms","start":"2026-02-17T23:06:32.199855Z","end":"2026-02-17T23:06:32.987799Z","steps":["trace[419271388] 'agreement among raft nodes before linearized reading' (duration: 786.139092ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:32.987874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:32.199826Z","time spent":"788.035869ms","remote":"127.0.0.1:60430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T23:06:32.986042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.234168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T23:06:32.988007Z","caller":"traceutil/trace.go:171","msg":"trace[194458503] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:43; }","duration":"894.26698ms","start":"2026-02-17T23:06:32.093732Z","end":"2026-02-17T23:06:32.987999Z","steps":["trace[194458503] 'agreement among raft nodes before linearized reading' (duration: 892.29481ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:32.988051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:32.093706Z","time spent":"894.336353ms","remote":"127.0.0.1:60780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-02-17T23:06:32.986069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.461797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T23:06:32.988168Z","caller":"traceutil/trace.go:171","msg":"trace[1989583999] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:43; }","duration":"894.596304ms","start":"2026-02-17T23:06:32.093561Z","end":"2026-02-17T23:06:32.988158Z","steps":["trace[1989583999] 'agreement among raft nodes before linearized reading' (duration: 892.494598ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:32.988208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:32.093533Z","time spent":"894.662076ms","remote":"127.0.0.1:60806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-02-17T23:06:32.986096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.110544204s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T23:06:32.988364Z","caller":"traceutil/trace.go:171","msg":"trace[1729122837] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:43; }","duration":"1.112846628s","start":"2026-02-17T23:06:31.875506Z","end":"2026-02-17T23:06:32.988353Z","steps":["trace[1729122837] 'agreement among raft nodes before linearized reading' (duration: 1.110575595s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:32.988406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:31.875479Z","time spent":"1.11291754s","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"warn","ts":"2026-02-17T23:06:32.986126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.418455953s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:1 size:338"} {"level":"info","ts":"2026-02-17T23:06:32.988572Z","caller":"traceutil/trace.go:171","msg":"trace[979350344] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:1; response_revision:43; }","duration":"1.420938524s","start":"2026-02-17T23:06:31.567626Z","end":"2026-02-17T23:06:32.988564Z","steps":["trace[979350344] 'agreement among raft nodes before linearized reading' (duration: 1.418484415s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:32.98861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:31.567605Z","time spent":"1.420997317s","remote":"127.0.0.1:60542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":1,"response size":361,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-02-17T23:06:32.986159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.47115262s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3179"} {"level":"info","ts":"2026-02-17T23:06:32.989083Z","caller":"traceutil/trace.go:171","msg":"trace[503230436] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:43; }","duration":"1.47407804s","start":"2026-02-17T23:06:31.514996Z","end":"2026-02-17T23:06:32.989074Z","steps":["trace[503230436] 'agreement among raft nodes before linearized reading' (duration: 1.471144161s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:32.989153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:31.514994Z","time spent":"1.474149643s","remote":"127.0.0.1:60602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3202,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-02-17T23:06:36.443691Z","caller":"traceutil/trace.go:171","msg":"trace[467610432] linearizableReadLoop","detail":"{readStateIndex:297; appliedIndex:296; }","duration":"101.114466ms","start":"2026-02-17T23:06:36.342543Z","end":"2026-02-17T23:06:36.443658Z","steps":["trace[467610432] 'read index received' (duration: 20.253836ms)","trace[467610432] 'applied index is now lower than readState.Index' (duration: 80.86005ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:36.44377Z","caller":"traceutil/trace.go:171","msg":"trace[593303267] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"100.060217ms","start":"2026-02-17T23:06:36.343706Z","end":"2026-02-17T23:06:36.443766Z","steps":["trace[593303267] 'process raft request' (duration: 99.926786ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:36.443685Z","caller":"traceutil/trace.go:171","msg":"trace[1762295415] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"113.415774ms","start":"2026-02-17T23:06:36.330254Z","end":"2026-02-17T23:06:36.44367Z","steps":["trace[1762295415] 'process raft request' (duration: 73.023973ms)","trace[1762295415] 'compare' (duration: 40.220849ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:36.443935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.379529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-02-17T23:06:36.443953Z","caller":"traceutil/trace.go:171","msg":"trace[160653669] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:292; }","duration":"101.428269ms","start":"2026-02-17T23:06:36.342518Z","end":"2026-02-17T23:06:36.443947Z","steps":["trace[160653669] 'agreement among raft nodes before linearized reading' (duration: 101.365588ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:36.612088Z","caller":"traceutil/trace.go:171","msg":"trace[1090310918] linearizableReadLoop","detail":"{readStateIndex:304; appliedIndex:300; }","duration":"151.627854ms","start":"2026-02-17T23:06:36.460444Z","end":"2026-02-17T23:06:36.612072Z","steps":["trace[1090310918] 'read index received' (duration: 45.283592ms)","trace[1090310918] 'applied index is now lower than readState.Index' (duration: 106.343562ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:36.612495Z","caller":"traceutil/trace.go:171","msg":"trace[188319978] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"161.937713ms","start":"2026-02-17T23:06:36.450542Z","end":"2026-02-17T23:06:36.61248Z","steps":["trace[188319978] 'process raft request' (duration: 111.781529ms)","trace[188319978] 'compare' (duration: 49.480029ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:36.612681Z","caller":"traceutil/trace.go:171","msg":"trace[1082068332] transaction","detail":"{read_only:false; number_of_response:0; response_revision:295; }","duration":"160.860954ms","start":"2026-02-17T23:06:36.451811Z","end":"2026-02-17T23:06:36.612672Z","steps":["trace[1082068332] 'process raft request' (duration: 160.130748ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:36.613197Z","caller":"traceutil/trace.go:171","msg":"trace[2090539803] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"160.680443ms","start":"2026-02-17T23:06:36.452503Z","end":"2026-02-17T23:06:36.613183Z","steps":["trace[2090539803] 'process raft request' (duration: 159.469362ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:36.613698Z","caller":"traceutil/trace.go:171","msg":"trace[1191464865] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"155.008823ms","start":"2026-02-17T23:06:36.458677Z","end":"2026-02-17T23:06:36.613685Z","steps":["trace[1191464865] 'process raft request' (duration: 153.336908ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:36.6139Z","caller":"traceutil/trace.go:171","msg":"trace[554428171] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"153.380249ms","start":"2026-02-17T23:06:36.460484Z","end":"2026-02-17T23:06:36.613864Z","steps":["trace[554428171] 'process raft request' (duration: 151.563004ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:36.614264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.804573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3444"} {"level":"info","ts":"2026-02-17T23:06:36.614319Z","caller":"traceutil/trace.go:171","msg":"trace[1261033116] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:298; }","duration":"153.869863ms","start":"2026-02-17T23:06:36.460425Z","end":"2026-02-17T23:06:36.614295Z","steps":["trace[1261033116] 'agreement among raft nodes before linearized reading' (duration: 153.718032ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:36.619707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.180458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-17T23:06:36.620273Z","caller":"traceutil/trace.go:171","msg":"trace[179745361] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:299; }","duration":"145.779763ms","start":"2026-02-17T23:06:36.474478Z","end":"2026-02-17T23:06:36.620258Z","steps":["trace[179745361] 'agreement among raft nodes before linearized reading' (duration: 144.935256ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:36.621097Z","caller":"traceutil/trace.go:171","msg":"trace[1235031012] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"114.754495ms","start":"2026-02-17T23:06:36.506329Z","end":"2026-02-17T23:06:36.621084Z","steps":["trace[1235031012] 'process raft request' (duration: 112.724428ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:36.817211Z","caller":"traceutil/trace.go:171","msg":"trace[1687983776] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"108.821293ms","start":"2026-02-17T23:06:36.708375Z","end":"2026-02-17T23:06:36.817196Z","steps":["trace[1687983776] 'process raft request' (duration: 95.84818ms)","trace[1687983776] 'compare' (duration: 12.834761ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:36.817294Z","caller":"traceutil/trace.go:171","msg":"trace[1091312517] linearizableReadLoop","detail":"{readStateIndex:313; appliedIndex:312; }","duration":"106.771085ms","start":"2026-02-17T23:06:36.710516Z","end":"2026-02-17T23:06:36.817287Z","steps":["trace[1091312517] 'read index received' (duration: 93.713752ms)","trace[1091312517] 'applied index is now lower than readState.Index' (duration: 13.056923ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:36.817434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.845859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-17T23:06:36.817461Z","caller":"traceutil/trace.go:171","msg":"trace[719181616] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:307; }","duration":"104.897169ms","start":"2026-02-17T23:06:36.712557Z","end":"2026-02-17T23:06:36.817454Z","steps":["trace[719181616] 'agreement among raft nodes before linearized reading' (duration: 104.817578ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:36.817608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.503876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5491"} {"level":"info","ts":"2026-02-17T23:06:36.817631Z","caller":"traceutil/trace.go:171","msg":"trace[209532201] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:307; }","duration":"111.550456ms","start":"2026-02-17T23:06:36.706075Z","end":"2026-02-17T23:06:36.817626Z","steps":["trace[209532201] 'agreement among raft nodes before linearized reading' (duration: 111.277244ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:36.817756Z","caller":"traceutil/trace.go:171","msg":"trace[1699496551] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"104.588356ms","start":"2026-02-17T23:06:36.71316Z","end":"2026-02-17T23:06:36.817749Z","steps":["trace[1699496551] 'process raft request' (duration: 103.954111ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:59.354831Z","caller":"traceutil/trace.go:171","msg":"trace[1907200752] linearizableReadLoop","detail":"{readStateIndex:522; appliedIndex:521; }","duration":"171.212796ms","start":"2026-02-17T23:06:59.183598Z","end":"2026-02-17T23:06:59.354811Z","steps":["trace[1907200752] 'read index received' (duration: 171.017023ms)","trace[1907200752] 'applied index is now lower than readState.Index' (duration: 194.893µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:59.354998Z","caller":"traceutil/trace.go:171","msg":"trace[1819989210] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"218.584462ms","start":"2026-02-17T23:06:59.136404Z","end":"2026-02-17T23:06:59.354988Z","steps":["trace[1819989210] 'process raft request' (duration: 218.265697ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:59.3555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.805607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-17T23:06:59.355554Z","caller":"traceutil/trace.go:171","msg":"trace[1120661169] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:511; }","duration":"171.97038ms","start":"2026-02-17T23:06:59.183566Z","end":"2026-02-17T23:06:59.355537Z","steps":["trace[1120661169] 'agreement among raft nodes before linearized reading' (duration: 171.794577ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:07.322213Z","caller":"traceutil/trace.go:171","msg":"trace[123243440] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"418.458778ms","start":"2026-02-17T23:07:06.903737Z","end":"2026-02-17T23:07:07.322196Z","steps":["trace[123243440] 'process raft request' (duration: 418.357886ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:07:07.322338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:07:06.903721Z","time spent":"418.554ms","remote":"127.0.0.1:60692","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-17T23:07:08.143428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.116437ms","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-17T23:07:08.143476Z","caller":"traceutil/trace.go:171","msg":"trace[973186019] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:555; }","duration":"762.198189ms","start":"2026-02-17T23:07:07.381266Z","end":"2026-02-17T23:07:08.143464Z","steps":["trace[973186019] 'range keys from in-memory index tree' (duration: 761.993725ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:07:08.143497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:07:07.381239Z","time spent":"762.25393ms","remote":"127.0.0.1:60692","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-17T23:07:08.143609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.871997ms","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-17T23:07:08.143623Z","caller":"traceutil/trace.go:171","msg":"trace[819296111] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:555; }","duration":"734.926458ms","start":"2026-02-17T23:07:07.408691Z","end":"2026-02-17T23:07:08.143618Z","steps":["trace[819296111] 'range keys from in-memory index tree' (duration: 734.767446ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:07:08.143636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:07:07.408663Z","time spent":"734.96988ms","remote":"127.0.0.1:60692","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-17T23:07:08.143718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"668.194785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:07:08.143731Z","caller":"traceutil/trace.go:171","msg":"trace[1949025937] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:555; }","duration":"668.229905ms","start":"2026-02-17T23:07:07.475497Z","end":"2026-02-17T23:07:08.143727Z","steps":["trace[1949025937] 'range keys from in-memory index tree' (duration: 668.151384ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:07:08.143744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:07:07.475485Z","time spent":"668.254757ms","remote":"127.0.0.1:60422","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-17T23:07:08.143823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"668.188435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rrjtl\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-17T23:07:08.143835Z","caller":"traceutil/trace.go:171","msg":"trace[450047719] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rrjtl; range_end:; response_count:1; response_revision:555; }","duration":"668.207976ms","start":"2026-02-17T23:07:07.475622Z","end":"2026-02-17T23:07:08.14383Z","steps":["trace[450047719] 'range keys from in-memory index tree' (duration: 668.149364ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:07:08.143848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:07:07.47562Z","time spent":"668.226106ms","remote":"127.0.0.1:60616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16679,"request content":"key:\"/registry/pods/kube-system/cilium-rrjtl\" "} {"level":"warn","ts":"2026-02-17T23:07:08.143955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.367288ms","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-17T23:07:08.143967Z","caller":"traceutil/trace.go:171","msg":"trace[1959099930] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:555; }","duration":"390.413128ms","start":"2026-02-17T23:07:07.75355Z","end":"2026-02-17T23:07:08.143963Z","steps":["trace[1959099930] 'range keys from in-memory index tree' (duration: 390.311897ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:07:08.143978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:07:07.753538Z","time spent":"390.437318ms","remote":"127.0.0.1:60692","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-17T23:07:08.144098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.169804ms","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-17T23:07:08.14411Z","caller":"traceutil/trace.go:171","msg":"trace[578732619] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:555; }","duration":"212.210305ms","start":"2026-02-17T23:07:07.931896Z","end":"2026-02-17T23:07:08.144107Z","steps":["trace[578732619] 'range keys from in-memory index tree' (duration: 212.104533ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:08.274079Z","caller":"traceutil/trace.go:171","msg":"trace[1725696947] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"115.38009ms","start":"2026-02-17T23:07:08.158682Z","end":"2026-02-17T23:07:08.274062Z","steps":["trace[1725696947] 'process raft request' (duration: 115.343769ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:08.274906Z","caller":"traceutil/trace.go:171","msg":"trace[1276246989] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"123.220747ms","start":"2026-02-17T23:07:08.151675Z","end":"2026-02-17T23:07:08.274896Z","steps":["trace[1276246989] 'process raft request' (duration: 122.185826ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:08.275131Z","caller":"traceutil/trace.go:171","msg":"trace[1376971131] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"120.537263ms","start":"2026-02-17T23:07:08.154586Z","end":"2026-02-17T23:07:08.275123Z","steps":["trace[1376971131] 'process raft request' (duration: 119.363729ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:08.275214Z","caller":"traceutil/trace.go:171","msg":"trace[1872488225] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"116.844139ms","start":"2026-02-17T23:07:08.158351Z","end":"2026-02-17T23:07:08.275195Z","steps":["trace[1872488225] 'process raft request' (duration: 115.642175ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:07:09.77069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.293675063s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:07:09.770749Z","caller":"traceutil/trace.go:171","msg":"trace[741480026] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:560; }","duration":"1.293771055s","start":"2026-02-17T23:07:08.476959Z","end":"2026-02-17T23:07:09.77073Z","steps":["trace[741480026] 'range keys from in-memory index tree' (duration: 1.293592162s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:07:09.770772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:07:08.476932Z","time spent":"1.293835017s","remote":"127.0.0.1:60430","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-17T23:07:10.347456Z","caller":"traceutil/trace.go:171","msg":"trace[1790141506] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"109.779596ms","start":"2026-02-17T23:07:10.237656Z","end":"2026-02-17T23:07:10.347436Z","steps":["trace[1790141506] 'process raft request' (duration: 109.316687ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:12.011356Z","caller":"traceutil/trace.go:171","msg":"trace[1483470688] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"157.814562ms","start":"2026-02-17T23:07:11.853521Z","end":"2026-02-17T23:07:12.011335Z","steps":["trace[1483470688] 'process raft request' (duration: 151.329164ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:12.010895Z","caller":"traceutil/trace.go:171","msg":"trace[777928781] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"149.232012ms","start":"2026-02-17T23:07:11.86164Z","end":"2026-02-17T23:07:12.010872Z","steps":["trace[777928781] 'read index received' (duration: 143.177574ms)","trace[777928781] 'applied index is now lower than readState.Index' (duration: 6.051268ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:07:12.011954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.288924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:07:12.012001Z","caller":"traceutil/trace.go:171","msg":"trace[2057294445] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:596; }","duration":"150.377296ms","start":"2026-02-17T23:07:11.861608Z","end":"2026-02-17T23:07:12.011985Z","steps":["trace[2057294445] 'agreement among raft nodes before linearized reading' (duration: 150.281454ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:08:37.386293Z","caller":"traceutil/trace.go:171","msg":"trace[1882623314] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"432.655856ms","start":"2026-02-17T23:08:36.953622Z","end":"2026-02-17T23:08:37.386278Z","steps":["trace[1882623314] 'process raft request' (duration: 432.259753ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:08:37.386464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:08:36.953596Z","time spent":"432.786251ms","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:08:37.38722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.812659ms","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-17T23:08:37.387252Z","caller":"traceutil/trace.go:171","msg":"trace[949030206] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:993; }","duration":"397.879181ms","start":"2026-02-17T23:08:36.989364Z","end":"2026-02-17T23:08:37.387243Z","steps":["trace[949030206] 'agreement among raft nodes before linearized reading' (duration: 397.777028ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:08:37.387275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:08:36.989347Z","time spent":"397.920892ms","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-17T23:08:37.388324Z","caller":"traceutil/trace.go:171","msg":"trace[1428763688] linearizableReadLoop","detail":"{readStateIndex:1030; appliedIndex:1029; }","duration":"396.622669ms","start":"2026-02-17T23:08:36.989401Z","end":"2026-02-17T23:08:37.386023Z","steps":["trace[1428763688] 'read index received' (duration: 396.428762ms)","trace[1428763688] 'applied index is now lower than readState.Index' (duration: 193.037µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:08:37.389341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.491379ms","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-17T23:08:37.389486Z","caller":"traceutil/trace.go:171","msg":"trace[1695447368] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:993; }","duration":"391.627424ms","start":"2026-02-17T23:08:36.997819Z","end":"2026-02-17T23:08:37.389447Z","steps":["trace[1695447368] 'agreement among raft nodes before linearized reading' (duration: 391.459648ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:08:37.389574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:08:36.997808Z","time spent":"391.756548ms","remote":"127.0.0.1:60692","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-17T23:08:37.389823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.239137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-17T23:08:37.389985Z","caller":"traceutil/trace.go:171","msg":"trace[956585546] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:993; }","duration":"365.430403ms","start":"2026-02-17T23:08:37.024546Z","end":"2026-02-17T23:08:37.389977Z","steps":["trace[956585546] 'agreement among raft nodes before linearized reading' (duration: 365.223076ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:08:37.390074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:08:37.024535Z","time spent":"365.527796ms","remote":"127.0.0.1:60692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-17T23:08:37.569348Z","caller":"traceutil/trace.go:171","msg":"trace[1311567857] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"175.712953ms","start":"2026-02-17T23:08:37.393623Z","end":"2026-02-17T23:08:37.569336Z","steps":["trace[1311567857] 'process raft request' (duration: 175.510416ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:08:37.570797Z","caller":"traceutil/trace.go:171","msg":"trace[1169913845] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"177.084088ms","start":"2026-02-17T23:08:37.391726Z","end":"2026-02-17T23:08:37.56881Z","steps":["trace[1169913845] 'process raft request' (duration: 176.808889ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:08:37.570896Z","caller":"traceutil/trace.go:171","msg":"trace[1926321421] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"175.31351ms","start":"2026-02-17T23:08:37.395569Z","end":"2026-02-17T23:08:37.570882Z","steps":["trace[1926321421] 'process raft request' (duration: 173.610193ms)"],"step_count":1}