{"level":"warn","ts":"2026-04-26T14:45:29.183179Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-26T14:45:29.183249Z","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-04-26T14:45:29.183312Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-26T14:45:29.18332Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-04-26T14:45:29.183338Z","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-04-26T14:45:29.183939Z","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-04-26T14:45:29.184036Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.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-04-26T14:45:29.188226Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.990659ms"} {"level":"info","ts":"2026-04-26T14:45:29.194854Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a31e123290fcf0df","cluster-id":"37661d6ee45ed9e8"} {"level":"info","ts":"2026-04-26T14:45:29.194906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=()"} {"level":"info","ts":"2026-04-26T14:45:29.194923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 0"} {"level":"info","ts":"2026-04-26T14:45:29.19493Z","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-04-26T14:45:29.19494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 1"} {"level":"info","ts":"2026-04-26T14:45:29.194981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"warn","ts":"2026-04-26T14:45:29.203198Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-26T14:45:29.205342Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-26T14:45:29.206171Z","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-04-26T14:45:29.208002Z","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-04-26T14:45:29.208709Z","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-04-26T14:45:29.210218Z","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-04-26T14:45:29.210227Z","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-04-26T14:45:29.211036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"info","ts":"2026-04-26T14:45:29.211073Z","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-04-26T14:45:29.211249Z","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-04-26T14:45:29.214104Z","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-04-26T14:45:29.214324Z","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-04-26T14:45:29.214352Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-26T14:45:29.214456Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-04-26T14:45:29.214469Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-04-26T14:45:29.595415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df is starting a new election at term 1"} {"level":"info","ts":"2026-04-26T14:45:29.595506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became pre-candidate at term 1"} {"level":"info","ts":"2026-04-26T14:45:29.595538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgPreVoteResp from a31e123290fcf0df at term 1"} {"level":"info","ts":"2026-04-26T14:45:29.595559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became candidate at term 2"} {"level":"info","ts":"2026-04-26T14:45:29.595576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgVoteResp from a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-04-26T14:45:29.595597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became leader at term 2"} {"level":"info","ts":"2026-04-26T14:45:29.595615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a31e123290fcf0df elected leader a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-04-26T14:45:29.597873Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T14:45:29.598769Z","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-04-26T14:45:29.598924Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-26T14:45:29.599001Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-26T14:45:29.599386Z","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-04-26T14:45:29.599476Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T14:45:29.599501Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T14:45:29.599712Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-26T14:45:29.59983Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-26T14:45:29.602191Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.113:2379"} {"level":"info","ts":"2026-04-26T14:45:29.603299Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-26T14:45:35.364702Z","caller":"traceutil/trace.go:171","msg":"trace[1923744937] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"147.961627ms","start":"2026-04-26T14:45:35.216703Z","end":"2026-04-26T14:45:35.364664Z","steps":["trace[1923744937] 'process raft request' (duration: 114.035018ms)","trace[1923744937] 'compare' (duration: 33.727206ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:45:57.675414Z","caller":"traceutil/trace.go:171","msg":"trace[1478339319] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"102.547682ms","start":"2026-04-26T14:45:57.572841Z","end":"2026-04-26T14:45:57.675389Z","steps":["trace[1478339319] 'process raft request' (duration: 101.807785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:46:19.247367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.591593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T14:46:19.247454Z","caller":"traceutil/trace.go:171","msg":"trace[2035294708] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:775; }","duration":"365.774269ms","start":"2026-04-26T14:46:18.881665Z","end":"2026-04-26T14:46:19.247439Z","steps":["trace[2035294708] 'range keys from in-memory index tree' (duration: 365.498345ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:46:19.247483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:46:18.881646Z","time spent":"365.829794ms","remote":"127.0.0.1:53764","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-04-26T14:46:19.247589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.275436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-26T14:46:19.24765Z","caller":"traceutil/trace.go:171","msg":"trace[570844596] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:775; }","duration":"284.374845ms","start":"2026-04-26T14:46:18.963258Z","end":"2026-04-26T14:46:19.247633Z","steps":["trace[570844596] 'range keys from in-memory index tree' (duration: 284.070859ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:49:39.268365Z","caller":"traceutil/trace.go:171","msg":"trace[468009224] transaction","detail":"{read_only:false; response_revision:1535; number_of_response:1; }","duration":"262.881817ms","start":"2026-04-26T14:49:39.005443Z","end":"2026-04-26T14:49:39.268325Z","steps":["trace[468009224] 'process raft request' (duration: 262.672898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:49:39.481201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.375011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T14:49:39.481391Z","caller":"traceutil/trace.go:171","msg":"trace[1631645342] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1535; }","duration":"101.61476ms","start":"2026-04-26T14:49:39.379757Z","end":"2026-04-26T14:49:39.481372Z","steps":["trace[1631645342] 'count revisions from in-memory index tree' (duration: 101.304088ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:03.199427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.106303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T14:50:03.199499Z","caller":"traceutil/trace.go:171","msg":"trace[1367748058] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1613; }","duration":"317.26154ms","start":"2026-04-26T14:50:02.882221Z","end":"2026-04-26T14:50:03.199483Z","steps":["trace[1367748058] 'range keys from in-memory index tree' (duration: 317.01779ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:03.199571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:02.882203Z","time spent":"317.354354ms","remote":"127.0.0.1:53764","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-04-26T14:50:03.362363Z","caller":"traceutil/trace.go:171","msg":"trace[1041637577] transaction","detail":"{read_only:false; response_revision:1614; number_of_response:1; }","duration":"158.624074ms","start":"2026-04-26T14:50:03.203715Z","end":"2026-04-26T14:50:03.362339Z","steps":["trace[1041637577] 'process raft request' (duration: 158.419476ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:18.812424Z","caller":"traceutil/trace.go:171","msg":"trace[1427642348] linearizableReadLoop","detail":"{readStateIndex:1789; appliedIndex:1788; }","duration":"135.60445ms","start":"2026-04-26T14:50:18.676795Z","end":"2026-04-26T14:50:18.812399Z","steps":["trace[1427642348] 'read index received' (duration: 135.523867ms)","trace[1427642348] 'applied index is now lower than readState.Index' (duration: 79.253µs)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:50:18.812482Z","caller":"traceutil/trace.go:171","msg":"trace[234396174] transaction","detail":"{read_only:false; response_revision:1713; number_of_response:1; }","duration":"249.306097ms","start":"2026-04-26T14:50:18.563148Z","end":"2026-04-26T14:50:18.812454Z","steps":["trace[234396174] 'process raft request' (duration: 249.080919ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:18.812646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.839237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-26T14:50:18.812694Z","caller":"traceutil/trace.go:171","msg":"trace[1498895627] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1713; }","duration":"135.93301ms","start":"2026-04-26T14:50:18.676748Z","end":"2026-04-26T14:50:18.812681Z","steps":["trace[1498895627] 'agreement among raft nodes before linearized reading' (duration: 135.760295ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:18.964224Z","caller":"traceutil/trace.go:171","msg":"trace[1183678442] transaction","detail":"{read_only:false; response_revision:1714; number_of_response:1; }","duration":"189.136045ms","start":"2026-04-26T14:50:18.775061Z","end":"2026-04-26T14:50:18.964197Z","steps":["trace[1183678442] 'process raft request' (duration: 96.913003ms)","trace[1183678442] 'compare' (duration: 92.099427ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:50:18.974698Z","caller":"traceutil/trace.go:171","msg":"trace[371015616] linearizableReadLoop","detail":"{readStateIndex:1791; appliedIndex:1789; }","duration":"143.80163ms","start":"2026-04-26T14:50:18.83088Z","end":"2026-04-26T14:50:18.974681Z","steps":["trace[371015616] 'read index received' (duration: 41.11864ms)","trace[371015616] 'applied index is now lower than readState.Index' (duration: 102.68208ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:50:18.974719Z","caller":"traceutil/trace.go:171","msg":"trace[690074059] transaction","detail":"{read_only:false; response_revision:1715; number_of_response:1; }","duration":"158.697971ms","start":"2026-04-26T14:50:18.816004Z","end":"2026-04-26T14:50:18.974702Z","steps":["trace[690074059] 'process raft request' (duration: 158.594227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:18.974922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.027658ms","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-04-26T14:50:18.97498Z","caller":"traceutil/trace.go:171","msg":"trace[1630320280] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1715; }","duration":"144.140372ms","start":"2026-04-26T14:50:18.830825Z","end":"2026-04-26T14:50:18.974966Z","steps":["trace[1630320280] 'agreement among raft nodes before linearized reading' (duration: 143.956136ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:31.725504Z","caller":"traceutil/trace.go:171","msg":"trace[1158113019] transaction","detail":"{read_only:false; response_revision:1759; number_of_response:1; }","duration":"225.77911ms","start":"2026-04-26T14:50:31.499701Z","end":"2026-04-26T14:50:31.72548Z","steps":["trace[1158113019] 'process raft request' (duration: 225.303353ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:33.082652Z","caller":"traceutil/trace.go:171","msg":"trace[545129714] transaction","detail":"{read_only:false; response_revision:1761; number_of_response:1; }","duration":"194.946314ms","start":"2026-04-26T14:50:32.887679Z","end":"2026-04-26T14:50:33.082626Z","steps":["trace[545129714] 'process raft request' (duration: 194.662224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:33.406509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.500688ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-26T14:50:33.406844Z","caller":"traceutil/trace.go:171","msg":"trace[515090799] transaction","detail":"{read_only:false; response_revision:1762; number_of_response:1; }","duration":"383.727765ms","start":"2026-04-26T14:50:33.023093Z","end":"2026-04-26T14:50:33.406821Z","steps":["trace[515090799] 'process raft request' (duration: 265.288255ms)","trace[515090799] 'compare' (duration: 117.26254ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:50:33.406986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.493946ms","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-04-26T14:50:33.406965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:33.023072Z","time spent":"383.821838ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-26T14:50:33.407043Z","caller":"traceutil/trace.go:171","msg":"trace[779690906] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1762; }","duration":"343.598489ms","start":"2026-04-26T14:50:33.063433Z","end":"2026-04-26T14:50:33.407032Z","steps":["trace[779690906] 'agreement among raft nodes before linearized reading' (duration: 343.458444ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:33.407067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:33.063413Z","time spent":"343.648751ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-26T14:50:33.407214Z","caller":"traceutil/trace.go:171","msg":"trace[1253143212] linearizableReadLoop","detail":"{readStateIndex:1841; appliedIndex:1839; }","duration":"343.116602ms","start":"2026-04-26T14:50:33.06349Z","end":"2026-04-26T14:50:33.406606Z","steps":["trace[1253143212] 'read index received' (duration: 18.865057ms)","trace[1253143212] 'applied index is now lower than readState.Index' (duration: 324.250295ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:50:33.40751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.964678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-26T14:50:33.407576Z","caller":"traceutil/trace.go:171","msg":"trace[1368464462] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1762; }","duration":"343.044711ms","start":"2026-04-26T14:50:33.064491Z","end":"2026-04-26T14:50:33.407536Z","steps":["trace[1368464462] 'agreement among raft nodes before linearized reading' (duration: 342.905626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:33.407581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.910053ms","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-04-26T14:50:33.407664Z","caller":"traceutil/trace.go:171","msg":"trace[1253752386] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1762; }","duration":"340.003267ms","start":"2026-04-26T14:50:33.067629Z","end":"2026-04-26T14:50:33.407633Z","steps":["trace[1253752386] 'agreement among raft nodes before linearized reading' (duration: 339.829401ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:33.407704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:33.067621Z","time spent":"340.074639ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-26T14:50:33.407884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:33.06447Z","time spent":"343.343981ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-26T14:50:38.614147Z","caller":"traceutil/trace.go:171","msg":"trace[412625091] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"165.173362ms","start":"2026-04-26T14:50:38.44895Z","end":"2026-04-26T14:50:38.614124Z","steps":["trace[412625091] 'process raft request' (duration: 164.937424ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:38.895315Z","caller":"traceutil/trace.go:171","msg":"trace[1035193064] linearizableReadLoop","detail":"{readStateIndex:1909; appliedIndex:1908; }","duration":"277.524774ms","start":"2026-04-26T14:50:38.617763Z","end":"2026-04-26T14:50:38.895287Z","steps":["trace[1035193064] 'read index received' (duration: 259.241557ms)","trace[1035193064] 'applied index is now lower than readState.Index' (duration: 18.282157ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:50:38.895564Z","caller":"traceutil/trace.go:171","msg":"trace[164420604] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"319.42392ms","start":"2026-04-26T14:50:38.576075Z","end":"2026-04-26T14:50:38.895499Z","steps":["trace[164420604] 'process raft request' (duration: 300.955056ms)","trace[164420604] 'compare' (duration: 18.167044ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:50:38.895729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:38.576041Z","time spent":"319.606887ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1768,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-26T14:50:38.895967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.170636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-04-26T14:50:38.896086Z","caller":"traceutil/trace.go:171","msg":"trace[315391791] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1829; }","duration":"278.335701ms","start":"2026-04-26T14:50:38.617729Z","end":"2026-04-26T14:50:38.896065Z","steps":["trace[315391791] 'agreement among raft nodes before linearized reading' (duration: 278.0123ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:38.957809Z","caller":"traceutil/trace.go:171","msg":"trace[2146791138] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"336.90159ms","start":"2026-04-26T14:50:38.620878Z","end":"2026-04-26T14:50:38.95778Z","steps":["trace[2146791138] 'process raft request' (duration: 336.59886ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:38.95791Z","caller":"traceutil/trace.go:171","msg":"trace[1912999230] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"277.807633ms","start":"2026-04-26T14:50:38.680041Z","end":"2026-04-26T14:50:38.957848Z","steps":["trace[1912999230] 'process raft request' (duration: 277.650778ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:38.957978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:38.620858Z","time spent":"337.035344ms","remote":"127.0.0.1:53836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":929,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-26T14:50:39.065074Z","caller":"traceutil/trace.go:171","msg":"trace[895938732] linearizableReadLoop","detail":"{readStateIndex:1913; appliedIndex:1911; }","duration":"107.305908ms","start":"2026-04-26T14:50:38.957745Z","end":"2026-04-26T14:50:39.065051Z","steps":["trace[895938732] 'read index received' (duration: 107.120392ms)","trace[895938732] 'applied index is now lower than readState.Index' (duration: 184.416µs)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:50:39.065205Z","caller":"traceutil/trace.go:171","msg":"trace[370962864] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"164.23625ms","start":"2026-04-26T14:50:38.90095Z","end":"2026-04-26T14:50:39.065186Z","steps":["trace[370962864] 'process raft request' (duration: 164.034043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:39.065268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.08831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:1 size:212"} {"level":"info","ts":"2026-04-26T14:50:39.065338Z","caller":"traceutil/trace.go:171","msg":"trace[589258865] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:1; response_revision:1833; }","duration":"123.208424ms","start":"2026-04-26T14:50:38.942108Z","end":"2026-04-26T14:50:39.065317Z","steps":["trace[589258865] 'agreement among raft nodes before linearized reading' (duration: 123.055239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:39.065369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.143141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:1783"} {"level":"info","ts":"2026-04-26T14:50:39.065416Z","caller":"traceutil/trace.go:171","msg":"trace[491613874] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1833; }","duration":"165.263975ms","start":"2026-04-26T14:50:38.900141Z","end":"2026-04-26T14:50:39.065405Z","steps":["trace[491613874] 'agreement among raft nodes before linearized reading' (duration: 165.026027ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:39.065596Z","caller":"traceutil/trace.go:171","msg":"trace[231061817] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"164.8129ms","start":"2026-04-26T14:50:38.900321Z","end":"2026-04-26T14:50:39.065134Z","steps":["trace[231061817] 'process raft request' (duration: 164.549291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:39.074233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.879558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T14:50:39.074326Z","caller":"traceutil/trace.go:171","msg":"trace[116706195] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1834; }","duration":"115.011244ms","start":"2026-04-26T14:50:38.959299Z","end":"2026-04-26T14:50:39.074311Z","steps":["trace[116706195] 'agreement among raft nodes before linearized reading' (duration: 114.859078ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:39.074851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.490979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1243"} {"level":"info","ts":"2026-04-26T14:50:39.074896Z","caller":"traceutil/trace.go:171","msg":"trace[1644005246] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1834; }","duration":"101.566933ms","start":"2026-04-26T14:50:38.973318Z","end":"2026-04-26T14:50:39.074885Z","steps":["trace[1644005246] 'agreement among raft nodes before linearized reading' (duration: 101.418018ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:39.075149Z","caller":"traceutil/trace.go:171","msg":"trace[728886114] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"112.073682ms","start":"2026-04-26T14:50:38.962047Z","end":"2026-04-26T14:50:39.074121Z","steps":["trace[728886114] 'process raft request' (duration: 111.920617ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:39.172744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.82956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:1 size:212"} {"level":"info","ts":"2026-04-26T14:50:39.172833Z","caller":"traceutil/trace.go:171","msg":"trace[1113328276] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:1; response_revision:1835; }","duration":"103.961924ms","start":"2026-04-26T14:50:39.06885Z","end":"2026-04-26T14:50:39.172812Z","steps":["trace[1113328276] 'agreement among raft nodes before linearized reading' (duration: 103.808109ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:39.173021Z","caller":"traceutil/trace.go:171","msg":"trace[1783949779] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"101.51721ms","start":"2026-04-26T14:50:39.071472Z","end":"2026-04-26T14:50:39.172989Z","steps":["trace[1783949779] 'process raft request' (duration: 85.971007ms)","trace[1783949779] 'compare' (duration: 14.803738ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:50:39.298249Z","caller":"traceutil/trace.go:171","msg":"trace[1742425424] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"120.1989ms","start":"2026-04-26T14:50:39.178018Z","end":"2026-04-26T14:50:39.298217Z","steps":["trace[1742425424] 'process raft request' (duration: 118.574675ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:39.306703Z","caller":"traceutil/trace.go:171","msg":"trace[507484811] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"125.845333ms","start":"2026-04-26T14:50:39.180826Z","end":"2026-04-26T14:50:39.306672Z","steps":["trace[507484811] 'process raft request' (duration: 125.76535ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:40.290631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.707154ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-26T14:50:40.290733Z","caller":"traceutil/trace.go:171","msg":"trace[1651284577] linearizableReadLoop","detail":"{readStateIndex:1918; appliedIndex:1917; }","duration":"840.783384ms","start":"2026-04-26T14:50:39.449932Z","end":"2026-04-26T14:50:40.290716Z","steps":["trace[1651284577] 'read index received' (duration: 323.735028ms)","trace[1651284577] 'applied index is now lower than readState.Index' (duration: 517.046856ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:50:40.290819Z","caller":"traceutil/trace.go:171","msg":"trace[134181965] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"866.230576ms","start":"2026-04-26T14:50:39.424487Z","end":"2026-04-26T14:50:40.290718Z","steps":["trace[134181965] 'process raft request' (duration: 349.331425ms)","trace[134181965] 'compare' (duration: 516.178267ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:50:40.290934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"840.999201ms","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-04-26T14:50:40.290963Z","caller":"traceutil/trace.go:171","msg":"trace[2025186283] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1838; }","duration":"841.075813ms","start":"2026-04-26T14:50:39.449877Z","end":"2026-04-26T14:50:40.290953Z","steps":["trace[2025186283] 'agreement among raft nodes before linearized reading' (duration: 840.936568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:40.290955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:39.424469Z","time spent":"866.406853ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-26T14:50:40.290995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:39.449852Z","time spent":"841.134985ms","remote":"127.0.0.1:54010","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-04-26T14:50:40.291193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"840.68936ms","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-04-26T14:50:40.291227Z","caller":"traceutil/trace.go:171","msg":"trace[498419200] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1838; }","duration":"840.741972ms","start":"2026-04-26T14:50:39.450475Z","end":"2026-04-26T14:50:40.291217Z","steps":["trace[498419200] 'agreement among raft nodes before linearized reading' (duration: 840.628878ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:40.291259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:39.450427Z","time spent":"840.825345ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-26T14:50:40.291342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.910955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-26T14:50:40.291367Z","caller":"traceutil/trace.go:171","msg":"trace[786491525] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1838; }","duration":"295.971287ms","start":"2026-04-26T14:50:39.995387Z","end":"2026-04-26T14:50:40.291358Z","steps":["trace[786491525] 'agreement among raft nodes before linearized reading' (duration: 295.930436ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:40.291509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.425029ms","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-04-26T14:50:40.291541Z","caller":"traceutil/trace.go:171","msg":"trace[953579763] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1838; }","duration":"503.492621ms","start":"2026-04-26T14:50:39.788039Z","end":"2026-04-26T14:50:40.291532Z","steps":["trace[953579763] 'agreement among raft nodes before linearized reading' (duration: 503.403628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:40.291544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"840.08541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-26T14:50:40.291571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:39.788017Z","time spent":"503.545133ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-26T14:50:40.291571Z","caller":"traceutil/trace.go:171","msg":"trace[1000742955] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1838; }","duration":"840.130442ms","start":"2026-04-26T14:50:39.451432Z","end":"2026-04-26T14:50:40.291563Z","steps":["trace[1000742955] 'agreement among raft nodes before linearized reading' (duration: 840.053339ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:40.291724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:39.451421Z","time spent":"840.295087ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-26T14:50:40.291818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.408275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-26T14:50:40.291856Z","caller":"traceutil/trace.go:171","msg":"trace[1599641084] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1838; }","duration":"465.489717ms","start":"2026-04-26T14:50:39.826354Z","end":"2026-04-26T14:50:40.291844Z","steps":["trace[1599641084] 'agreement among raft nodes before linearized reading' (duration: 465.436946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:40.291693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.597672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-26T14:50:40.291886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:39.826333Z","time spent":"465.54497ms","remote":"127.0.0.1:54008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"info","ts":"2026-04-26T14:50:40.293219Z","caller":"traceutil/trace.go:171","msg":"trace[1947834396] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1838; }","duration":"411.125025ms","start":"2026-04-26T14:50:39.882056Z","end":"2026-04-26T14:50:40.293181Z","steps":["trace[1947834396] 'agreement among raft nodes before linearized reading' (duration: 409.615913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:40.29332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:39.882014Z","time spent":"411.275929ms","remote":"127.0.0.1:53764","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-04-26T14:50:40.505727Z","caller":"traceutil/trace.go:171","msg":"trace[1151356402] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"209.355187ms","start":"2026-04-26T14:50:40.296329Z","end":"2026-04-26T14:50:40.505684Z","steps":["trace[1151356402] 'process raft request' (duration: 110.533769ms)","trace[1151356402] 'compare' (duration: 98.442365ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:50:40.505763Z","caller":"traceutil/trace.go:171","msg":"trace[1676108317] linearizableReadLoop","detail":"{readStateIndex:1922; appliedIndex:1918; }","duration":"203.105894ms","start":"2026-04-26T14:50:40.302626Z","end":"2026-04-26T14:50:40.505732Z","steps":["trace[1676108317] 'read index received' (duration: 104.397179ms)","trace[1676108317] 'applied index is now lower than readState.Index' (duration: 98.703684ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:50:40.505907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.243898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T14:50:40.505968Z","caller":"traceutil/trace.go:171","msg":"trace[1073598221] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1842; }","duration":"203.345212ms","start":"2026-04-26T14:50:40.302608Z","end":"2026-04-26T14:50:40.505953Z","steps":["trace[1073598221] 'agreement among raft nodes before linearized reading' (duration: 203.228348ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:40.506087Z","caller":"traceutil/trace.go:171","msg":"trace[404253913] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"208.261641ms","start":"2026-04-26T14:50:40.297795Z","end":"2026-04-26T14:50:40.506056Z","steps":["trace[404253913] 'process raft request' (duration: 207.844165ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:40.506134Z","caller":"traceutil/trace.go:171","msg":"trace[624829466] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"209.295736ms","start":"2026-04-26T14:50:40.296824Z","end":"2026-04-26T14:50:40.50612Z","steps":["trace[624829466] 'process raft request' (duration: 208.700905ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:40.506261Z","caller":"traceutil/trace.go:171","msg":"trace[413878118] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"208.389435ms","start":"2026-04-26T14:50:40.297854Z","end":"2026-04-26T14:50:40.506244Z","steps":["trace[413878118] 'process raft request' (duration: 207.829445ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:40.730715Z","caller":"traceutil/trace.go:171","msg":"trace[1529243443] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"310.728592ms","start":"2026-04-26T14:50:40.419957Z","end":"2026-04-26T14:50:40.730685Z","steps":["trace[1529243443] 'process raft request' (duration: 214.157171ms)","trace[1529243443] 'compare' (duration: 96.425986ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:50:40.731074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:40.419926Z","time spent":"310.947909ms","remote":"127.0.0.1:53918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5798,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-26T14:50:41.575311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.594825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-26T14:50:41.575418Z","caller":"traceutil/trace.go:171","msg":"trace[2093007051] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1845; }","duration":"272.75657ms","start":"2026-04-26T14:50:41.302639Z","end":"2026-04-26T14:50:41.575396Z","steps":["trace[2093007051] 'range keys from in-memory index tree' (duration: 272.402808ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:41.704671Z","caller":"traceutil/trace.go:171","msg":"trace[892683747] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"124.780398ms","start":"2026-04-26T14:50:41.579858Z","end":"2026-04-26T14:50:41.704638Z","steps":["trace[892683747] 'process raft request' (duration: 124.616332ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:46.659274Z","caller":"traceutil/trace.go:171","msg":"trace[1058394783] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"114.011329ms","start":"2026-04-26T14:50:46.545232Z","end":"2026-04-26T14:50:46.659243Z","steps":["trace[1058394783] 'process raft request' (duration: 113.910956ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:46.659304Z","caller":"traceutil/trace.go:171","msg":"trace[1344632344] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"116.637719ms","start":"2026-04-26T14:50:46.54264Z","end":"2026-04-26T14:50:46.659278Z","steps":["trace[1344632344] 'process raft request' (duration: 116.36519ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:46.659477Z","caller":"traceutil/trace.go:171","msg":"trace[1071973783] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"114.155084ms","start":"2026-04-26T14:50:46.545292Z","end":"2026-04-26T14:50:46.659448Z","steps":["trace[1071973783] 'process raft request' (duration: 113.905726ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T14:50:53.183785Z","caller":"traceutil/trace.go:171","msg":"trace[320192920] transaction","detail":"{read_only:false; response_revision:1926; number_of_response:1; }","duration":"495.094683ms","start":"2026-04-26T14:50:52.688656Z","end":"2026-04-26T14:50:53.183751Z","steps":["trace[320192920] 'process raft request' (duration: 438.164752ms)","trace[320192920] 'compare' (duration: 56.624781ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T14:50:53.184039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:52.688638Z","time spent":"495.224168ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-26T14:50:53.206181Z","caller":"traceutil/trace.go:171","msg":"trace[1711758270] linearizableReadLoop","detail":"{readStateIndex:2011; appliedIndex:2008; }","duration":"326.636857ms","start":"2026-04-26T14:50:52.879516Z","end":"2026-04-26T14:50:53.206153Z","steps":["trace[1711758270] 'read index received' (duration: 247.38434ms)","trace[1711758270] 'applied index is now lower than readState.Index' (duration: 79.251547ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T14:50:53.206201Z","caller":"traceutil/trace.go:171","msg":"trace[2116739315] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"517.449549ms","start":"2026-04-26T14:50:52.688724Z","end":"2026-04-26T14:50:53.206173Z","steps":["trace[2116739315] 'process raft request' (duration: 517.260343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:53.206518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.995219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-26T14:50:53.206525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:52.688699Z","time spent":"517.729839ms","remote":"127.0.0.1:54010","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-04-26T14:50:53.20657Z","caller":"traceutil/trace.go:171","msg":"trace[826138972] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1928; }","duration":"327.049871ms","start":"2026-04-26T14:50:52.879506Z","end":"2026-04-26T14:50:53.206556Z","steps":["trace[826138972] 'agreement among raft nodes before linearized reading' (duration: 326.974929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:53.206646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:52.879469Z","time spent":"327.168406ms","remote":"127.0.0.1:53764","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-04-26T14:50:53.20697Z","caller":"traceutil/trace.go:171","msg":"trace[672428797] transaction","detail":"{read_only:false; response_revision:1928; number_of_response:1; }","duration":"517.178329ms","start":"2026-04-26T14:50:52.68914Z","end":"2026-04-26T14:50:53.206319Z","steps":["trace[672428797] 'process raft request' (duration: 516.959822ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T14:50:53.207109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T14:50:52.689122Z","time spent":"517.911934ms","remote":"127.0.0.1:54010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}