{"level":"warn","ts":"2026-04-13T21:04:45.614566Z","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-13T21:04:45.614646Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.156: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.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.156: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-13T21:04:45.614704Z","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-13T21:04:45.614712Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-04-13T21:04:45.614729Z","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-13T21:04:45.615341Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]} {"level":"info","ts":"2026-04-13T21:04:45.615406Z","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.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.156: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-13T21:04:45.62042Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.785244ms"} {"level":"info","ts":"2026-04-13T21:04:45.631853Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"} {"level":"info","ts":"2026-04-13T21:04:45.631956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"} {"level":"info","ts":"2026-04-13T21:04:45.631983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"} {"level":"info","ts":"2026-04-13T21:04:45.631997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-13T21:04:45.632007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"} {"level":"info","ts":"2026-04-13T21:04:45.632088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"warn","ts":"2026-04-13T21:04:45.651042Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-13T21:04:45.653842Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-13T21:04:45.656388Z","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-13T21:04:45.659934Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-13T21:04:45.660212Z","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-13T21:04:45.66076Z","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-13T21:04:45.66093Z","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-13T21:04:45.661106Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-13T21:04:45.661283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"info","ts":"2026-04-13T21:04:45.661525Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-04-13T21:04:45.664256Z","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-13T21:04:45.664314Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-04-13T21:04:45.664354Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-04-13T21:04:45.664555Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-13T21:04:45.664626Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-13T21:04:46.233308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"} {"level":"info","ts":"2026-04-13T21:04:46.233356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-13T21:04:46.233383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"} {"level":"info","ts":"2026-04-13T21:04:46.233397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"} {"level":"info","ts":"2026-04-13T21:04:46.233405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-04-13T21:04:46.233415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"} {"level":"info","ts":"2026-04-13T21:04:46.233425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-04-13T21:04:46.234889Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"} {"level":"info","ts":"2026-04-13T21:04:46.235075Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T21:04:46.235189Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-13T21:04:46.23522Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-13T21:04:46.235301Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:04:46.236401Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:04:46.236481Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:04:46.236508Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:04:46.236933Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"} {"level":"info","ts":"2026-04-13T21:04:46.235019Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T21:04:46.23822Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-13T21:04:48.018065Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398340011855200372,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-13T21:04:48.043168Z","caller":"traceutil/trace.go:171","msg":"trace[864635377] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"525.810342ms","start":"2026-04-13T21:04:47.517334Z","end":"2026-04-13T21:04:48.043144Z","steps":["trace[864635377] 'process raft request' (duration: 525.636168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:48.043784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:47.517325Z","time spent":"525.906794ms","remote":"127.0.0.1:39590","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:04:48.764931Z","caller":"traceutil/trace.go:171","msg":"trace[1161294262] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"1.243553779s","start":"2026-04-13T21:04:47.521332Z","end":"2026-04-13T21:04:48.764885Z","steps":["trace[1161294262] 'process raft request' (duration: 1.243328074s)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:04:48.765102Z","caller":"traceutil/trace.go:171","msg":"trace[1140721096] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:4; }","duration":"1.247552844s","start":"2026-04-13T21:04:47.51751Z","end":"2026-04-13T21:04:48.765063Z","steps":["trace[1140721096] 'read index received' (duration: 525.518235ms)","trace[1140721096] 'applied index is now lower than readState.Index' (duration: 722.033789ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:04:48.765124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:47.521298Z","time spent":"1.243746554s","remote":"127.0.0.1:39808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T21:04:48.765219Z","caller":"traceutil/trace.go:171","msg":"trace[239285589] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"1.172231013s","start":"2026-04-13T21:04:47.59296Z","end":"2026-04-13T21:04:48.765191Z","steps":["trace[239285589] 'process raft request' (duration: 1.172035338s)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:04:48.765292Z","caller":"traceutil/trace.go:171","msg":"trace[863103748] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"1.173570055s","start":"2026-04-13T21:04:47.591684Z","end":"2026-04-13T21:04:48.765254Z","steps":["trace[863103748] 'process raft request' (duration: 1.173138405s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:48.765349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:47.592912Z","time spent":"1.172373277s","remote":"127.0.0.1:40086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T21:04:48.765418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:47.591659Z","time spent":"1.173692457s","remote":"127.0.0.1:40086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T21:04:48.765478Z","caller":"traceutil/trace.go:171","msg":"trace[713880586] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.150969557s","start":"2026-04-13T21:04:47.614494Z","end":"2026-04-13T21:04:48.765464Z","steps":["trace[713880586] 'process raft request' (duration: 1.150539347s)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:04:48.765532Z","caller":"traceutil/trace.go:171","msg":"trace[805345119] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"1.172841117s","start":"2026-04-13T21:04:47.592676Z","end":"2026-04-13T21:04:48.765518Z","steps":["trace[805345119] 'process raft request' (duration: 1.172257223s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:48.765581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:47.592625Z","time spent":"1.172932699s","remote":"127.0.0.1:40086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T21:04:48.765549Z","caller":"traceutil/trace.go:171","msg":"trace[480167673] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"1.172676594s","start":"2026-04-13T21:04:47.592809Z","end":"2026-04-13T21:04:48.765486Z","steps":["trace[480167673] 'process raft request' (duration: 1.172085569s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:48.76558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:47.61448Z","time spent":"1.15104794s","remote":"127.0.0.1:39724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T21:04:48.765646Z","caller":"traceutil/trace.go:171","msg":"trace[1140725834] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"1.172663973s","start":"2026-04-13T21:04:47.592969Z","end":"2026-04-13T21:04:48.765633Z","steps":["trace[1140725834] 'process raft request' (duration: 1.171996367s)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:04:48.765649Z","caller":"traceutil/trace.go:171","msg":"trace[2097340748] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"1.173054373s","start":"2026-04-13T21:04:47.592577Z","end":"2026-04-13T21:04:48.765631Z","steps":["trace[2097340748] 'process raft request' (duration: 1.172289155s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:48.765698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:47.592957Z","time spent":"1.172717074s","remote":"127.0.0.1:40004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T21:04:48.765688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:47.592801Z","time spent":"1.172824057s","remote":"127.0.0.1:40086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T21:04:48.76572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:47.592563Z","time spent":"1.173125944s","remote":"127.0.0.1:40086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T21:04:48.766009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.174141028s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T21:04:48.766135Z","caller":"traceutil/trace.go:171","msg":"trace[513605875] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.174323812s","start":"2026-04-13T21:04:47.591785Z","end":"2026-04-13T21:04:48.766109Z","steps":["trace[513605875] 'agreement among raft nodes before linearized reading' (duration: 1.174050566s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:48.766168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:47.591778Z","time spent":"1.174381474s","remote":"127.0.0.1:39640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-13T21:04:48.766166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.585393ms","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-04-13T21:04:48.766247Z","caller":"traceutil/trace.go:171","msg":"trace[1199544085] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:10; }","duration":"275.702986ms","start":"2026-04-13T21:04:48.490504Z","end":"2026-04-13T21:04:48.766207Z","steps":["trace[1199544085] 'agreement among raft nodes before linearized reading' (duration: 275.584113ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:48.766277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.122844159s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-13T21:04:48.766274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.933447ms","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-04-13T21:04:48.766365Z","caller":"traceutil/trace.go:171","msg":"trace[2134036360] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:10; }","duration":"275.070931ms","start":"2026-04-13T21:04:48.491258Z","end":"2026-04-13T21:04:48.766329Z","steps":["trace[2134036360] 'agreement among raft nodes before linearized reading' (duration: 274.889336ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:04:48.766337Z","caller":"traceutil/trace.go:171","msg":"trace[295036260] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.12290394s","start":"2026-04-13T21:04:47.643413Z","end":"2026-04-13T21:04:48.766317Z","steps":["trace[295036260] 'agreement among raft nodes before linearized reading' (duration: 1.122750417s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:48.766371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.174721822s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.156\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-13T21:04:48.766374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.173832991s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-13T21:04:48.766405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:47.643393Z","time spent":"1.123004512s","remote":"127.0.0.1:39640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-13T21:04:48.766416Z","caller":"traceutil/trace.go:171","msg":"trace[1490375316] range","detail":"{range_begin:/registry/masterleases/199.204.45.156; range_end:; response_count:0; response_revision:10; }","duration":"1.174795604s","start":"2026-04-13T21:04:47.591608Z","end":"2026-04-13T21:04:48.766404Z","steps":["trace[1490375316] 'agreement among raft nodes before linearized reading' (duration: 1.174725183s)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:04:48.766435Z","caller":"traceutil/trace.go:171","msg":"trace[787739423] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"1.173929984s","start":"2026-04-13T21:04:47.592487Z","end":"2026-04-13T21:04:48.766417Z","steps":["trace[787739423] 'agreement among raft nodes before linearized reading' (duration: 1.173830361s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:48.766448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:47.591589Z","time spent":"1.174851935s","remote":"127.0.0.1:39548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":26,"request content":"key:\"/registry/masterleases/199.204.45.156\" "} {"level":"warn","ts":"2026-04-13T21:04:48.766468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:47.592456Z","time spent":"1.174003735s","remote":"127.0.0.1:39608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-04-13T21:04:48.76672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.195107527s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-13T21:04:48.766744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.240704921s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-13T21:04:48.766744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.245361232s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T21:04:48.767534Z","caller":"traceutil/trace.go:171","msg":"trace[1116930550] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:10; }","duration":"1.246165111s","start":"2026-04-13T21:04:47.521354Z","end":"2026-04-13T21:04:48.767519Z","steps":["trace[1116930550] 'agreement among raft nodes before linearized reading' (duration: 1.245364052s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:48.767625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:47.521343Z","time spent":"1.246264753s","remote":"127.0.0.1:39580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-04-13T21:04:48.767359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.248415075s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-04-13T21:04:48.767695Z","caller":"traceutil/trace.go:171","msg":"trace[400652378] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"1.250152786s","start":"2026-04-13T21:04:47.517527Z","end":"2026-04-13T21:04:48.76768Z","steps":["trace[400652378] 'agreement among raft nodes before linearized reading' (duration: 1.248310682s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:48.767935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:47.517525Z","time spent":"1.250201337s","remote":"127.0.0.1:39724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-13T21:04:48.766763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.240711502s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-13T21:04:48.768097Z","caller":"traceutil/trace.go:171","msg":"trace[661766683] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:10; }","duration":"1.242055293s","start":"2026-04-13T21:04:47.526027Z","end":"2026-04-13T21:04:48.768082Z","steps":["trace[661766683] 'agreement among raft nodes before linearized reading' (duration: 1.240110237s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:48.76814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:47.526015Z","time spent":"1.242112345s","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T21:04:48.766781Z","caller":"traceutil/trace.go:171","msg":"trace[2125469017] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:10; }","duration":"1.240751852s","start":"2026-04-13T21:04:47.52602Z","end":"2026-04-13T21:04:48.766772Z","steps":["trace[2125469017] 'agreement among raft nodes before linearized reading' (duration: 1.240689411s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:48.768642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:47.526013Z","time spent":"1.242615726s","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-13T21:04:48.766787Z","caller":"traceutil/trace.go:171","msg":"trace[2083620266] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"1.195170448s","start":"2026-04-13T21:04:47.571599Z","end":"2026-04-13T21:04:48.76677Z","steps":["trace[2083620266] 'agreement among raft nodes before linearized reading' (duration: 1.195087936s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:48.768721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:47.571585Z","time spent":"1.197131074s","remote":"127.0.0.1:39640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-13T21:04:48.768512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.248434945s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-04-13T21:04:48.768807Z","caller":"traceutil/trace.go:171","msg":"trace[695478156] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"1.251284083s","start":"2026-04-13T21:04:47.517502Z","end":"2026-04-13T21:04:48.768786Z","steps":["trace[695478156] 'agreement among raft nodes before linearized reading' (duration: 1.248279452s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:04:48.768868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:04:47.517498Z","time spent":"1.251349095s","remote":"127.0.0.1:39724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-13T21:05:16.995417Z","caller":"traceutil/trace.go:171","msg":"trace[7460626] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"122.98688ms","start":"2026-04-13T21:05:16.87239Z","end":"2026-04-13T21:05:16.995377Z","steps":["trace[7460626] 'process raft request' (duration: 122.824277ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:05:17.002354Z","caller":"traceutil/trace.go:171","msg":"trace[26524042] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"128.383548ms","start":"2026-04-13T21:05:16.873931Z","end":"2026-04-13T21:05:17.002314Z","steps":["trace[26524042] 'process raft request' (duration: 128.250465ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:05:17.002539Z","caller":"traceutil/trace.go:171","msg":"trace[1120610782] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"100.758155ms","start":"2026-04-13T21:05:16.90176Z","end":"2026-04-13T21:05:17.002518Z","steps":["trace[1120610782] 'process raft request' (duration: 100.614081ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:05:17.002612Z","caller":"traceutil/trace.go:171","msg":"trace[1218683279] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"102.005314ms","start":"2026-04-13T21:05:16.9006Z","end":"2026-04-13T21:05:17.002606Z","steps":["trace[1218683279] 'process raft request' (duration: 101.727837ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:05:17.002537Z","caller":"traceutil/trace.go:171","msg":"trace[1833196356] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"101.996834ms","start":"2026-04-13T21:05:16.900506Z","end":"2026-04-13T21:05:17.002503Z","steps":["trace[1833196356] 'process raft request' (duration: 101.79592ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:05:17.00272Z","caller":"traceutil/trace.go:171","msg":"trace[487619815] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"122.431997ms","start":"2026-04-13T21:05:16.880282Z","end":"2026-04-13T21:05:17.002714Z","steps":["trace[487619815] 'process raft request' (duration: 121.971216ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:05:17.002822Z","caller":"traceutil/trace.go:171","msg":"trace[617826088] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"107.500895ms","start":"2026-04-13T21:05:16.895271Z","end":"2026-04-13T21:05:17.002772Z","steps":["trace[617826088] 'process raft request' (duration: 107.005863ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:05:17.255019Z","caller":"traceutil/trace.go:171","msg":"trace[1167979237] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"125.885209ms","start":"2026-04-13T21:05:17.129105Z","end":"2026-04-13T21:05:17.25499Z","steps":["trace[1167979237] 'process raft request' (duration: 90.00654ms)","trace[1167979237] 'compare' (duration: 35.767396ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:05:17.310741Z","caller":"traceutil/trace.go:171","msg":"trace[1491186941] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"177.534571ms","start":"2026-04-13T21:05:17.133175Z","end":"2026-04-13T21:05:17.31071Z","steps":["trace[1491186941] 'process raft request' (duration: 177.106471ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:05:17.311121Z","caller":"traceutil/trace.go:171","msg":"trace[1161292038] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"146.849905ms","start":"2026-04-13T21:05:17.164237Z","end":"2026-04-13T21:05:17.311087Z","steps":["trace[1161292038] 'process raft request' (duration: 146.406755ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:05:17.311294Z","caller":"traceutil/trace.go:171","msg":"trace[2051175309] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"143.938827ms","start":"2026-04-13T21:05:17.167345Z","end":"2026-04-13T21:05:17.311284Z","steps":["trace[2051175309] 'process raft request' (duration: 143.65883ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:05:17.410798Z","caller":"traceutil/trace.go:171","msg":"trace[834893425] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"141.158671ms","start":"2026-04-13T21:05:17.26962Z","end":"2026-04-13T21:05:17.410779Z","steps":["trace[834893425] 'process raft request' (duration: 137.530005ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:05:22.939769Z","caller":"traceutil/trace.go:171","msg":"trace[2001601641] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"361.890775ms","start":"2026-04-13T21:05:22.577817Z","end":"2026-04-13T21:05:22.939708Z","steps":["trace[2001601641] 'process raft request' (duration: 357.87665ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:05:22.939924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:05:22.577794Z","time spent":"362.053689ms","remote":"127.0.0.1:39620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:05:23.735526Z","caller":"traceutil/trace.go:171","msg":"trace[780564271] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:601; }","duration":"287.472682ms","start":"2026-04-13T21:05:23.448006Z","end":"2026-04-13T21:05:23.735479Z","steps":["trace[780564271] 'read index received' (duration: 42.125306ms)","trace[780564271] 'applied index is now lower than readState.Index' (duration: 245.346316ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:05:23.735556Z","caller":"traceutil/trace.go:171","msg":"trace[589243820] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"295.050532ms","start":"2026-04-13T21:05:23.44047Z","end":"2026-04-13T21:05:23.735521Z","steps":["trace[589243820] 'process raft request' (duration: 294.318525ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:05:23.735685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.652877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-13T21:05:23.735959Z","caller":"traceutil/trace.go:171","msg":"trace[1676786288] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:579; }","duration":"287.896762ms","start":"2026-04-13T21:05:23.447964Z","end":"2026-04-13T21:05:23.73586Z","steps":["trace[1676786288] 'agreement among raft nodes before linearized reading' (duration: 287.625946ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:05:24.556834Z","caller":"traceutil/trace.go:171","msg":"trace[1932297531] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:604; }","duration":"305.49981ms","start":"2026-04-13T21:05:24.251311Z","end":"2026-04-13T21:05:24.556811Z","steps":["trace[1932297531] 'read index received' (duration: 305.313345ms)","trace[1932297531] 'applied index is now lower than readState.Index' (duration: 185.515µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:05:24.556886Z","caller":"traceutil/trace.go:171","msg":"trace[410702489] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"759.873692ms","start":"2026-04-13T21:05:23.796983Z","end":"2026-04-13T21:05:24.556856Z","steps":["trace[410702489] 'process raft request' (duration: 759.706488ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:05:24.557007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:05:23.796956Z","time spent":"759.993265ms","remote":"127.0.0.1:40074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T21:05:24.557082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.760576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-13T21:05:24.557117Z","caller":"traceutil/trace.go:171","msg":"trace[1906983712] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:581; }","duration":"305.856499ms","start":"2026-04-13T21:05:24.251249Z","end":"2026-04-13T21:05:24.557106Z","steps":["trace[1906983712] 'agreement among raft nodes before linearized reading' (duration: 305.692785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:05:24.55715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:05:24.251227Z","time spent":"305.914989ms","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-13T21:05:24.55715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.815616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:05:24.557236Z","caller":"traceutil/trace.go:171","msg":"trace[2068931919] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"152.949259ms","start":"2026-04-13T21:05:24.404265Z","end":"2026-04-13T21:05:24.557215Z","steps":["trace[2068931919] 'agreement among raft nodes before linearized reading' (duration: 152.783285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:05:24.663744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.145319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:05:24.663813Z","caller":"traceutil/trace.go:171","msg":"trace[458924339] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"105.252121ms","start":"2026-04-13T21:05:24.558546Z","end":"2026-04-13T21:05:24.663799Z","steps":["trace[458924339] 'range keys from in-memory index tree' (duration: 105.067396ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:05:24.664557Z","caller":"traceutil/trace.go:171","msg":"trace[700059174] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"103.735596ms","start":"2026-04-13T21:05:24.560784Z","end":"2026-04-13T21:05:24.664519Z","steps":["trace[700059174] 'process raft request' (duration: 21.923949ms)","trace[700059174] 'compare' (duration: 81.086559ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:05:41.494782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.84959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-13T21:05:41.494789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.811888ms","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-04-13T21:05:41.494898Z","caller":"traceutil/trace.go:171","msg":"trace[1604396603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:747; }","duration":"331.042175ms","start":"2026-04-13T21:05:41.163815Z","end":"2026-04-13T21:05:41.494857Z","steps":["trace[1604396603] 'range keys from in-memory index tree' (duration: 330.45224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:05:41.494941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:05:41.163794Z","time spent":"331.135747ms","remote":"127.0.0.1:39820","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-04-13T21:05:41.494916Z","caller":"traceutil/trace.go:171","msg":"trace[134859454] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:747; }","duration":"335.94483ms","start":"2026-04-13T21:05:41.158922Z","end":"2026-04-13T21:05:41.494867Z","steps":["trace[134859454] 'range keys from in-memory index tree' (duration: 335.620143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:05:41.49517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:05:41.158906Z","time spent":"336.246528ms","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T21:06:08.78673Z","caller":"traceutil/trace.go:171","msg":"trace[1282228530] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"100.591733ms","start":"2026-04-13T21:06:08.686094Z","end":"2026-04-13T21:06:08.786686Z","steps":["trace[1282228530] 'process raft request' (duration: 100.140533ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:06:16.467917Z","caller":"traceutil/trace.go:171","msg":"trace[1051134994] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"159.218292ms","start":"2026-04-13T21:06:16.308676Z","end":"2026-04-13T21:06:16.467894Z","steps":["trace[1051134994] 'process raft request' (duration: 159.080268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:06:17.223195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.259258ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:06:17.223289Z","caller":"traceutil/trace.go:171","msg":"trace[396313107] linearizableReadLoop","detail":"{readStateIndex:1005; appliedIndex:1004; }","duration":"153.65971ms","start":"2026-04-13T21:06:17.069614Z","end":"2026-04-13T21:06:17.223274Z","steps":["trace[396313107] 'read index received' (duration: 44.101µs)","trace[396313107] 'applied index is now lower than readState.Index' (duration: 153.614159ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:06:17.223312Z","caller":"traceutil/trace.go:171","msg":"trace[604670124] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"403.626662ms","start":"2026-04-13T21:06:16.819651Z","end":"2026-04-13T21:06:17.223277Z","steps":["trace[604670124] 'process raft request' (duration: 194.094798ms)","trace[604670124] 'compare' (duration: 209.023612ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:06:17.223484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.879145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-04-13T21:06:17.223492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:06:16.819631Z","time spent":"403.767485ms","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:06:17.223516Z","caller":"traceutil/trace.go:171","msg":"trace[27075939] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:965; }","duration":"153.911776ms","start":"2026-04-13T21:06:17.069595Z","end":"2026-04-13T21:06:17.223507Z","steps":["trace[27075939] 'agreement among raft nodes before linearized reading' (duration: 153.776012ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:06:38.0628Z","caller":"traceutil/trace.go:171","msg":"trace[1821609846] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"184.083511ms","start":"2026-04-13T21:06:37.87866Z","end":"2026-04-13T21:06:38.062744Z","steps":["trace[1821609846] 'process raft request' (duration: 183.941688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:06:38.554575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.671238ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:06:38.554671Z","caller":"traceutil/trace.go:171","msg":"trace[602809062] linearizableReadLoop","detail":"{readStateIndex:1078; appliedIndex:1076; }","duration":"663.784486ms","start":"2026-04-13T21:06:37.890871Z","end":"2026-04-13T21:06:38.554655Z","steps":["trace[602809062] 'read index received' (duration: 171.76678ms)","trace[602809062] 'applied index is now lower than readState.Index' (duration: 492.016426ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:06:38.554877Z","caller":"traceutil/trace.go:171","msg":"trace[557182783] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"674.565391ms","start":"2026-04-13T21:06:37.880305Z","end":"2026-04-13T21:06:38.55487Z","steps":["trace[557182783] 'process raft request' (duration: 377.525214ms)","trace[557182783] 'compare' (duration: 296.554575ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:06:38.554917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:06:37.880289Z","time spent":"674.605832ms","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:06:38.555077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.207036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:06:38.555129Z","caller":"traceutil/trace.go:171","msg":"trace[180321778] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1034; }","duration":"664.296278ms","start":"2026-04-13T21:06:37.890824Z","end":"2026-04-13T21:06:38.555121Z","steps":["trace[180321778] 'agreement among raft nodes before linearized reading' (duration: 664.223766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:06:38.555151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:06:37.890805Z","time spent":"664.338918ms","remote":"127.0.0.1:39668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-04-13T21:06:38.5553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.030919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:06:38.555364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.60538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T21:06:38.5554Z","caller":"traceutil/trace.go:171","msg":"trace[446911221] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1034; }","duration":"154.158982ms","start":"2026-04-13T21:06:38.401219Z","end":"2026-04-13T21:06:38.555378Z","steps":["trace[446911221] 'agreement among raft nodes before linearized reading' (duration: 153.984498ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:06:38.555367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.441261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-13T21:06:38.555416Z","caller":"traceutil/trace.go:171","msg":"trace[1491289097] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1034; }","duration":"397.700292ms","start":"2026-04-13T21:06:38.157702Z","end":"2026-04-13T21:06:38.555402Z","steps":["trace[1491289097] 'agreement among raft nodes before linearized reading' (duration: 397.606099ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:06:38.555451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:06:38.157686Z","time spent":"397.759844ms","remote":"127.0.0.1:40074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":29,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-04-13T21:06:38.55546Z","caller":"traceutil/trace.go:171","msg":"trace[1552957813] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1034; }","duration":"401.573033ms","start":"2026-04-13T21:06:38.153865Z","end":"2026-04-13T21:06:38.555438Z","steps":["trace[1552957813] 'agreement among raft nodes before linearized reading' (duration: 401.326488ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:06:38.555503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:06:38.153847Z","time spent":"401.648016ms","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-13T21:06:39.735021Z","caller":"traceutil/trace.go:171","msg":"trace[653024509] linearizableReadLoop","detail":"{readStateIndex:1081; appliedIndex:1080; }","duration":"330.08679ms","start":"2026-04-13T21:06:39.404912Z","end":"2026-04-13T21:06:39.734999Z","steps":["trace[653024509] 'read index received' (duration: 329.929036ms)","trace[653024509] 'applied index is now lower than readState.Index' (duration: 156.454µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:06:39.735076Z","caller":"traceutil/trace.go:171","msg":"trace[1777936219] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"409.86517ms","start":"2026-04-13T21:06:39.325178Z","end":"2026-04-13T21:06:39.735043Z","steps":["trace[1777936219] 'process raft request' (duration: 409.693896ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:06:39.735157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.234913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:06:39.735182Z","caller":"traceutil/trace.go:171","msg":"trace[1068851941] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1037; }","duration":"330.311235ms","start":"2026-04-13T21:06:39.404862Z","end":"2026-04-13T21:06:39.735174Z","steps":["trace[1068851941] 'agreement among raft nodes before linearized reading' (duration: 330.250193ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:06:39.735204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:06:39.404842Z","time spent":"330.356747ms","remote":"127.0.0.1:39510","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-04-13T21:06:39.735229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:06:39.325152Z","time spent":"409.991443ms","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:06:39.73532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.377307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.156\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-04-13T21:06:39.735356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.073136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-13T21:06:39.735393Z","caller":"traceutil/trace.go:171","msg":"trace[1434857690] range","detail":"{range_begin:/registry/masterleases/199.204.45.156; range_end:; response_count:1; response_revision:1037; }","duration":"151.483529ms","start":"2026-04-13T21:06:39.583889Z","end":"2026-04-13T21:06:39.735372Z","steps":["trace[1434857690] 'agreement among raft nodes before linearized reading' (duration: 151.288344ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:06:39.735409Z","caller":"traceutil/trace.go:171","msg":"trace[1189132015] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1037; }","duration":"264.166048ms","start":"2026-04-13T21:06:39.47123Z","end":"2026-04-13T21:06:39.735396Z","steps":["trace[1189132015] 'agreement among raft nodes before linearized reading' (duration: 263.922002ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:06:39.880692Z","caller":"traceutil/trace.go:171","msg":"trace[67420993] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"102.12944ms","start":"2026-04-13T21:06:39.778539Z","end":"2026-04-13T21:06:39.880669Z","steps":["trace[67420993] 'process raft request' (duration: 24.824258ms)","trace[67420993] 'compare' (duration: 77.213469ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:06:41.510801Z","caller":"traceutil/trace.go:171","msg":"trace[93069395] linearizableReadLoop","detail":"{readStateIndex:1089; appliedIndex:1088; }","duration":"104.353773ms","start":"2026-04-13T21:06:41.40641Z","end":"2026-04-13T21:06:41.510764Z","steps":["trace[93069395] 'read index received' (duration: 103.896642ms)","trace[93069395] 'applied index is now lower than readState.Index' (duration: 455.421µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:06:41.511014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.568258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:06:41.51106Z","caller":"traceutil/trace.go:171","msg":"trace[1908804633] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1044; }","duration":"104.688561ms","start":"2026-04-13T21:06:41.40636Z","end":"2026-04-13T21:06:41.511048Z","steps":["trace[1908804633] 'agreement among raft nodes before linearized reading' (duration: 104.539617ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:06:41.511673Z","caller":"traceutil/trace.go:171","msg":"trace[1721772480] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"149.038881ms","start":"2026-04-13T21:06:41.362617Z","end":"2026-04-13T21:06:41.511656Z","steps":["trace[1721772480] 'process raft request' (duration: 147.839903ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:06:54.165657Z","caller":"traceutil/trace.go:171","msg":"trace[2103493695] linearizableReadLoop","detail":"{readStateIndex:1183; appliedIndex:1182; }","duration":"320.251507ms","start":"2026-04-13T21:06:53.845351Z","end":"2026-04-13T21:06:54.165603Z","steps":["trace[2103493695] 'read index received' (duration: 320.053203ms)","trace[2103493695] 'applied index is now lower than readState.Index' (duration: 197.224µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:06:54.16573Z","caller":"traceutil/trace.go:171","msg":"trace[779487506] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"338.757856ms","start":"2026-04-13T21:06:53.82694Z","end":"2026-04-13T21:06:54.165697Z","steps":["trace[779487506] 'process raft request' (duration: 338.475439ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:06:54.165908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:06:53.826915Z","time spent":"338.873069ms","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:06:54.165966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.595595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-13T21:06:54.166004Z","caller":"traceutil/trace.go:171","msg":"trace[1978944392] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1135; }","duration":"320.682008ms","start":"2026-04-13T21:06:53.845312Z","end":"2026-04-13T21:06:54.165994Z","steps":["trace[1978944392] 'agreement among raft nodes before linearized reading' (duration: 320.473263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:06:54.166051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:06:53.845297Z","time spent":"320.744339ms","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-13T21:06:54.174783Z","caller":"traceutil/trace.go:171","msg":"trace[229778062] transaction","detail":"{read_only:false; response_revision:1136; number_of_response:1; }","duration":"303.763896ms","start":"2026-04-13T21:06:53.870991Z","end":"2026-04-13T21:06:54.174755Z","steps":["trace[229778062] 'process raft request' (duration: 303.51913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:06:54.17482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.140875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:06:54.174895Z","caller":"traceutil/trace.go:171","msg":"trace[1614510897] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1136; }","duration":"312.256868ms","start":"2026-04-13T21:06:53.862617Z","end":"2026-04-13T21:06:54.174874Z","steps":["trace[1614510897] 'agreement among raft nodes before linearized reading' (duration: 312.139715ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:06:54.17493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:06:53.862598Z","time spent":"312.321199ms","remote":"127.0.0.1:39844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-04-13T21:06:54.174926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:06:53.870975Z","time spent":"303.870289ms","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:07:10.797011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.402038ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:07:10.797141Z","caller":"traceutil/trace.go:171","msg":"trace[1051423448] linearizableReadLoop","detail":"{readStateIndex:1269; appliedIndex:1268; }","duration":"552.237123ms","start":"2026-04-13T21:07:10.244854Z","end":"2026-04-13T21:07:10.797091Z","steps":["trace[1051423448] 'read index received' (duration: 60.718062ms)","trace[1051423448] 'applied index is now lower than readState.Index' (duration: 491.517941ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:07:10.797252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.328386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:10.797231Z","caller":"traceutil/trace.go:171","msg":"trace[521480447] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"568.009996ms","start":"2026-04-13T21:07:10.229183Z","end":"2026-04-13T21:07:10.797193Z","steps":["trace[521480447] 'process raft request' (duration: 76.353201ms)","trace[521480447] 'compare' (duration: 491.180813ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:07:10.797292Z","caller":"traceutil/trace.go:171","msg":"trace[933273894] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1216; }","duration":"393.389697ms","start":"2026-04-13T21:07:10.403892Z","end":"2026-04-13T21:07:10.797282Z","steps":["trace[933273894] 'agreement among raft nodes before linearized reading' (duration: 393.337405ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:10.79732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:10.403879Z","time spent":"393.434948ms","remote":"127.0.0.1:39510","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-04-13T21:07:10.797386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:10.229166Z","time spent":"568.140118ms","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:07:10.797277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.421127ms","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-04-13T21:07:10.797535Z","caller":"traceutil/trace.go:171","msg":"trace[819171322] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1216; }","duration":"552.696693ms","start":"2026-04-13T21:07:10.24483Z","end":"2026-04-13T21:07:10.797527Z","steps":["trace[819171322] 'agreement among raft nodes before linearized reading' (duration: 552.368036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:10.797561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:10.24482Z","time spent":"552.735195ms","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T21:07:11.121277Z","caller":"traceutil/trace.go:171","msg":"trace[458565695] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"319.365112ms","start":"2026-04-13T21:07:10.801882Z","end":"2026-04-13T21:07:11.121247Z","steps":["trace[458565695] 'process raft request' (duration: 315.967761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:11.121453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:10.801863Z","time spent":"319.496074ms","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:07:11.1312Z","caller":"traceutil/trace.go:171","msg":"trace[1052001085] linearizableReadLoop","detail":"{readStateIndex:1272; appliedIndex:1269; }","duration":"307.679885ms","start":"2026-04-13T21:07:10.823495Z","end":"2026-04-13T21:07:11.131175Z","steps":["trace[1052001085] 'read index received' (duration: 294.320981ms)","trace[1052001085] 'applied index is now lower than readState.Index' (duration: 13.358054ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:07:11.131701Z","caller":"traceutil/trace.go:171","msg":"trace[23824298] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"329.758587ms","start":"2026-04-13T21:07:10.801933Z","end":"2026-04-13T21:07:11.131691Z","steps":["trace[23824298] 'process raft request' (duration: 329.032819ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:11.131914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:10.801916Z","time spent":"329.92005ms","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:07:11.132207Z","caller":"traceutil/trace.go:171","msg":"trace[1352635372] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"329.92944ms","start":"2026-04-13T21:07:10.802255Z","end":"2026-04-13T21:07:11.132184Z","steps":["trace[1352635372] 'process raft request' (duration: 328.867165ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:11.132302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:10.802197Z","time spent":"330.060204ms","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:07:11.1323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.173415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:11.132387Z","caller":"traceutil/trace.go:171","msg":"trace[545464385] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1219; }","duration":"109.316547ms","start":"2026-04-13T21:07:11.023046Z","end":"2026-04-13T21:07:11.132363Z","steps":["trace[545464385] 'agreement among raft nodes before linearized reading' (duration: 109.130723ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:11.13255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.027697ms","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-13T21:07:11.132625Z","caller":"traceutil/trace.go:171","msg":"trace[978335004] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1219; }","duration":"309.16177ms","start":"2026-04-13T21:07:10.823445Z","end":"2026-04-13T21:07:11.132607Z","steps":["trace[978335004] 'agreement among raft nodes before linearized reading' (duration: 308.915304ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:11.132718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:10.823429Z","time spent":"309.277334ms","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-13T21:07:11.896319Z","caller":"traceutil/trace.go:171","msg":"trace[574006498] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"251.118962ms","start":"2026-04-13T21:07:11.645179Z","end":"2026-04-13T21:07:11.896298Z","steps":["trace[574006498] 'process raft request' (duration: 251.073211ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:11.896341Z","caller":"traceutil/trace.go:171","msg":"trace[1412735559] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"251.702325ms","start":"2026-04-13T21:07:11.644622Z","end":"2026-04-13T21:07:11.896324Z","steps":["trace[1412735559] 'process raft request' (duration: 225.805095ms)","trace[1412735559] 'compare' (duration: 25.710736ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:07:12.473416Z","caller":"traceutil/trace.go:171","msg":"trace[1369076141] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"571.816855ms","start":"2026-04-13T21:07:11.901574Z","end":"2026-04-13T21:07:12.47339Z","steps":["trace[1369076141] 'process raft request' (duration: 534.600407ms)","trace[1369076141] 'compare' (duration: 37.120556ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:07:12.473552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:11.901556Z","time spent":"571.938877ms","remote":"127.0.0.1:39594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":869,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T21:07:12.474383Z","caller":"traceutil/trace.go:171","msg":"trace[549600753] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"569.974681ms","start":"2026-04-13T21:07:11.904397Z","end":"2026-04-13T21:07:12.474372Z","steps":["trace[549600753] 'process raft request' (duration: 569.529081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:12.474438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:11.90439Z","time spent":"570.018832ms","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:07:12.474489Z","caller":"traceutil/trace.go:171","msg":"trace[651041371] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"450.815801ms","start":"2026-04-13T21:07:12.023668Z","end":"2026-04-13T21:07:12.474484Z","steps":["trace[651041371] 'process raft request' (duration: 450.34027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:12.474517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:12.023647Z","time spent":"450.856072ms","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:07:12.474402Z","caller":"traceutil/trace.go:171","msg":"trace[29921326] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"247.916367ms","start":"2026-04-13T21:07:12.226439Z","end":"2026-04-13T21:07:12.474355Z","steps":["trace[29921326] 'process raft request' (duration: 247.605229ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:13.347278Z","caller":"traceutil/trace.go:171","msg":"trace[642303183] linearizableReadLoop","detail":"{readStateIndex:1284; appliedIndex:1283; }","duration":"210.920444ms","start":"2026-04-13T21:07:13.136339Z","end":"2026-04-13T21:07:13.34726Z","steps":["trace[642303183] 'read index received' (duration: 210.825431ms)","trace[642303183] 'applied index is now lower than readState.Index' (duration: 94.023µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:07:13.347381Z","caller":"traceutil/trace.go:171","msg":"trace[1471850751] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"217.912228ms","start":"2026-04-13T21:07:13.129461Z","end":"2026-04-13T21:07:13.347373Z","steps":["trace[1471850751] 'process raft request' (duration: 217.658622ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:13.347568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.21289ms","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-04-13T21:07:13.347597Z","caller":"traceutil/trace.go:171","msg":"trace[1249287932] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1231; }","duration":"211.255541ms","start":"2026-04-13T21:07:13.136335Z","end":"2026-04-13T21:07:13.34759Z","steps":["trace[1249287932] 'agreement among raft nodes before linearized reading' (duration: 211.144589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:13.347718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.413643ms","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-13T21:07:13.347794Z","caller":"traceutil/trace.go:171","msg":"trace[409725536] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1231; }","duration":"174.543076ms","start":"2026-04-13T21:07:13.173234Z","end":"2026-04-13T21:07:13.347777Z","steps":["trace[409725536] 'agreement among raft nodes before linearized reading' (duration: 174.30818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:13.347845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.351444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-13T21:07:13.347982Z","caller":"traceutil/trace.go:171","msg":"trace[2014461469] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1231; }","duration":"211.60795ms","start":"2026-04-13T21:07:13.136355Z","end":"2026-04-13T21:07:13.347963Z","steps":["trace[2014461469] 'agreement among raft nodes before linearized reading' (duration: 211.145449ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:13.480865Z","caller":"traceutil/trace.go:171","msg":"trace[1294648182] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"129.247098ms","start":"2026-04-13T21:07:13.35159Z","end":"2026-04-13T21:07:13.480837Z","steps":["trace[1294648182] 'process raft request' (duration: 91.138759ms)","trace[1294648182] 'compare' (duration: 37.892074ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:07:13.481593Z","caller":"traceutil/trace.go:171","msg":"trace[1823458044] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"124.960167ms","start":"2026-04-13T21:07:13.356616Z","end":"2026-04-13T21:07:13.481576Z","steps":["trace[1823458044] 'process raft request' (duration: 124.449805ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:13.481592Z","caller":"traceutil/trace.go:171","msg":"trace[462084115] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"124.974317ms","start":"2026-04-13T21:07:13.356583Z","end":"2026-04-13T21:07:13.481558Z","steps":["trace[462084115] 'process raft request' (duration: 124.211359ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:13.62884Z","caller":"traceutil/trace.go:171","msg":"trace[1347567846] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"111.821307ms","start":"2026-04-13T21:07:13.516986Z","end":"2026-04-13T21:07:13.628807Z","steps":["trace[1347567846] 'process raft request' (duration: 89.573923ms)","trace[1347567846] 'compare' (duration: 22.113121ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:07:22.881055Z","caller":"traceutil/trace.go:171","msg":"trace[454790522] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"169.656251ms","start":"2026-04-13T21:07:22.711371Z","end":"2026-04-13T21:07:22.881027Z","steps":["trace[454790522] 'process raft request' (duration: 169.150119ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:23.553674Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398340011855203093,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-13T21:07:23.875108Z","caller":"traceutil/trace.go:171","msg":"trace[1333580859] linearizableReadLoop","detail":"{readStateIndex:1353; appliedIndex:1352; }","duration":"821.506503ms","start":"2026-04-13T21:07:23.053577Z","end":"2026-04-13T21:07:23.875084Z","steps":["trace[1333580859] 'read index received' (duration: 737.687686ms)","trace[1333580859] 'applied index is now lower than readState.Index' (duration: 83.817767ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:07:23.875131Z","caller":"traceutil/trace.go:171","msg":"trace[1328705862] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"989.936075ms","start":"2026-04-13T21:07:22.885169Z","end":"2026-04-13T21:07:23.875105Z","steps":["trace[1328705862] 'process raft request' (duration: 906.210111ms)","trace[1328705862] 'compare' (duration: 83.396917ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:07:23.875219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"821.629575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:23.875257Z","caller":"traceutil/trace.go:171","msg":"trace[263919240] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1298; }","duration":"821.716928ms","start":"2026-04-13T21:07:23.053527Z","end":"2026-04-13T21:07:23.875244Z","steps":["trace[263919240] 'agreement among raft nodes before linearized reading' (duration: 821.641586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:23.875279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:22.885141Z","time spent":"990.063528ms","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:07:23.875316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.045908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-13T21:07:23.875346Z","caller":"traceutil/trace.go:171","msg":"trace[2018563931] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1298; }","duration":"482.11391ms","start":"2026-04-13T21:07:23.393223Z","end":"2026-04-13T21:07:23.875337Z","steps":["trace[2018563931] 'agreement among raft nodes before linearized reading' (duration: 481.990347ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:23.875378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:23.393201Z","time spent":"482.170051ms","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-13T21:07:23.875295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:23.053507Z","time spent":"821.776829ms","remote":"127.0.0.1:45948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-04-13T21:07:23.875456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.704673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-04-13T21:07:23.875482Z","caller":"traceutil/trace.go:171","msg":"trace[1373611782] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1298; }","duration":"231.763545ms","start":"2026-04-13T21:07:23.643711Z","end":"2026-04-13T21:07:23.875475Z","steps":["trace[1373611782] 'agreement among raft nodes before linearized reading' (duration: 231.690563ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:23.875554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.262571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-13T21:07:23.875589Z","caller":"traceutil/trace.go:171","msg":"trace[1489909594] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1298; }","duration":"353.337602ms","start":"2026-04-13T21:07:23.522243Z","end":"2026-04-13T21:07:23.875581Z","steps":["trace[1489909594] 'agreement among raft nodes before linearized reading' (duration: 353.24801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:23.875618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:23.522025Z","time spent":"353.585518ms","remote":"127.0.0.1:39820","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-04-13T21:07:23.875377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.460941ms","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-13T21:07:23.875665Z","caller":"traceutil/trace.go:171","msg":"trace[250213254] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1298; }","duration":"352.761079ms","start":"2026-04-13T21:07:23.522891Z","end":"2026-04-13T21:07:23.875652Z","steps":["trace[250213254] 'agreement among raft nodes before linearized reading' (duration: 352.427441ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:23.875705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:23.522882Z","time spent":"352.81323ms","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-13T21:07:23.875759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.470265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-13T21:07:23.875794Z","caller":"traceutil/trace.go:171","msg":"trace[388341893] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1298; }","duration":"353.546627ms","start":"2026-04-13T21:07:23.522239Z","end":"2026-04-13T21:07:23.875786Z","steps":["trace[388341893] 'agreement among raft nodes before linearized reading' (duration: 353.463675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:23.875822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:23.522212Z","time spent":"353.603509ms","remote":"127.0.0.1:39820","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-04-13T21:09:40.863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.966598ms","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-13T21:09:40.863127Z","caller":"traceutil/trace.go:171","msg":"trace[409307114] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1929; }","duration":"112.116121ms","start":"2026-04-13T21:09:40.750963Z","end":"2026-04-13T21:09:40.863079Z","steps":["trace[409307114] 'range keys from in-memory index tree' (duration: 111.766012ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:09:41.123154Z","caller":"traceutil/trace.go:171","msg":"trace[722875160] transaction","detail":"{read_only:false; response_revision:1931; number_of_response:1; }","duration":"196.00943ms","start":"2026-04-13T21:09:40.927124Z","end":"2026-04-13T21:09:41.123133Z","steps":["trace[722875160] 'process raft request' (duration: 154.731032ms)","trace[722875160] 'compare' (duration: 41.194046ms)"],"step_count":2}