{"level":"warn","ts":"2026-04-21T19:17:19.027325Z","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-21T19:17:19.027468Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.141: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.141:2380","--initial-cluster=instance=https://199.204.45.141:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.141:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.141: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-21T19:17:19.027615Z","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-21T19:17:19.027634Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-04-21T19:17:19.027657Z","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-21T19:17:19.02861Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"]} {"level":"info","ts":"2026-04-21T19:17:19.028744Z","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":16,"max-cpu-available":16,"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.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.141: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-21T19:17:19.046717Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"17.638358ms"} {"level":"info","ts":"2026-04-21T19:17:19.062425Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9ef3b4f68930dc2","cluster-id":"b19a5957e6e65747"} {"level":"info","ts":"2026-04-21T19:17:19.06254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-21T19:17:19.062567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 0"} {"level":"info","ts":"2026-04-21T19:17:19.062581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9ef3b4f68930dc2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-21T19:17:19.06259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 1"} {"level":"info","ts":"2026-04-21T19:17:19.062645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"warn","ts":"2026-04-21T19:17:19.093484Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-21T19:17:19.095257Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-21T19:17:19.096783Z","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-21T19:17:19.100389Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9ef3b4f68930dc2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-21T19:17:19.100644Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9ef3b4f68930dc2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-21T19:17:19.100702Z","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-21T19:17:19.100892Z","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-21T19:17:19.100915Z","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-21T19:17:19.105487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"info","ts":"2026-04-21T19:17:19.105963Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","added-peer-id":"9ef3b4f68930dc2","added-peer-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-04-21T19:17:19.10754Z","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-21T19:17:19.107702Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-04-21T19:17:19.107746Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-04-21T19:17:19.107938Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9ef3b4f68930dc2","initial-advertise-peer-urls":["https://199.204.45.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-21T19:17:19.108002Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-21T19:17:19.864443Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-21T19:17:19.864512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-21T19:17:19.864566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgPreVoteResp from 9ef3b4f68930dc2 at term 1"} {"level":"info","ts":"2026-04-21T19:17:19.864587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became candidate at term 2"} {"level":"info","ts":"2026-04-21T19:17:19.864599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgVoteResp from 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-04-21T19:17:19.864617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became leader at term 2"} {"level":"info","ts":"2026-04-21T19:17:19.864632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9ef3b4f68930dc2 elected leader 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-04-21T19:17:19.901336Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9ef3b4f68930dc2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.141:2379]}","request-path":"/0/members/9ef3b4f68930dc2/attributes","cluster-id":"b19a5957e6e65747","publish-timeout":"7s"} {"level":"info","ts":"2026-04-21T19:17:19.901391Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T19:17:19.901662Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T19:17:19.902033Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T19:17:19.90236Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-21T19:17:19.902389Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-21T19:17:19.906454Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-21T19:17:19.906471Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.141:2379"} {"level":"info","ts":"2026-04-21T19:17:19.909279Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T19:17:19.909429Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T19:17:19.909479Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T19:17:21.502551Z","caller":"traceutil/trace.go:171","msg":"trace[1668241379] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"146.892685ms","start":"2026-04-21T19:17:21.355619Z","end":"2026-04-21T19:17:21.502511Z","steps":["trace[1668241379] 'process raft request' (duration: 146.768261ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:21.502602Z","caller":"traceutil/trace.go:171","msg":"trace[729095713] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"147.661725ms","start":"2026-04-21T19:17:21.354895Z","end":"2026-04-21T19:17:21.502557Z","steps":["trace[729095713] 'process raft request' (duration: 100.880745ms)","trace[729095713] 'compare' (duration: 46.37786ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:21.502795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.804021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-21T19:17:21.502894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.274222ms","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-21T19:17:21.502974Z","caller":"traceutil/trace.go:171","msg":"trace[1741536297] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:13; }","duration":"108.033597ms","start":"2026-04-21T19:17:21.394907Z","end":"2026-04-21T19:17:21.502941Z","steps":["trace[1741536297] 'agreement among raft nodes before linearized reading' (duration: 107.692659ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:21.502993Z","caller":"traceutil/trace.go:171","msg":"trace[823288379] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:13; }","duration":"117.451246ms","start":"2026-04-21T19:17:21.385512Z","end":"2026-04-21T19:17:21.502964Z","steps":["trace[823288379] 'agreement among raft nodes before linearized reading' (duration: 117.254421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:21.503012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.98074ms","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-21T19:17:21.503168Z","caller":"traceutil/trace.go:171","msg":"trace[364637208] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:13; }","duration":"107.197455ms","start":"2026-04-21T19:17:21.395922Z","end":"2026-04-21T19:17:21.503119Z","steps":["trace[364637208] 'agreement among raft nodes before linearized reading' (duration: 106.842966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:21.720283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.478555ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-21T19:17:21.720457Z","caller":"traceutil/trace.go:171","msg":"trace[2002980496] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"134.945381ms","start":"2026-04-21T19:17:21.585468Z","end":"2026-04-21T19:17:21.720414Z","steps":["trace[2002980496] 'process raft request' (duration: 33.708687ms)","trace[2002980496] 'compare' (duration: 100.32648ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:21.72051Z","caller":"traceutil/trace.go:171","msg":"trace[1106659953] linearizableReadLoop","detail":"{readStateIndex:41; appliedIndex:40; }","duration":"134.869939ms","start":"2026-04-21T19:17:21.585589Z","end":"2026-04-21T19:17:21.720459Z","steps":["trace[1106659953] 'read index received' (duration: 33.605334ms)","trace[1106659953] 'applied index is now lower than readState.Index' (duration: 101.263035ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:21.72062Z","caller":"traceutil/trace.go:171","msg":"trace[611722976] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"134.254403ms","start":"2026-04-21T19:17:21.586304Z","end":"2026-04-21T19:17:21.720558Z","steps":["trace[611722976] 'process raft request' (duration: 134.104709ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:21.720723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.070234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3495"} {"level":"info","ts":"2026-04-21T19:17:21.720864Z","caller":"traceutil/trace.go:171","msg":"trace[1364640571] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:38; }","duration":"135.270749ms","start":"2026-04-21T19:17:21.585562Z","end":"2026-04-21T19:17:21.720832Z","steps":["trace[1364640571] 'agreement among raft nodes before linearized reading' (duration: 134.993213ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:21.8708Z","caller":"traceutil/trace.go:171","msg":"trace[1489114075] transaction","detail":"{read_only:false; response_revision:40; number_of_response:1; }","duration":"144.904144ms","start":"2026-04-21T19:17:21.725854Z","end":"2026-04-21T19:17:21.870758Z","steps":["trace[1489114075] 'process raft request' (duration: 140.941764ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:21.870903Z","caller":"traceutil/trace.go:171","msg":"trace[1739735931] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"144.973876ms","start":"2026-04-21T19:17:21.725888Z","end":"2026-04-21T19:17:21.870862Z","steps":["trace[1739735931] 'process raft request' (duration: 144.663218ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:22.231359Z","caller":"traceutil/trace.go:171","msg":"trace[2032730775] transaction","detail":"{read_only:false; response_revision:61; number_of_response:1; }","duration":"187.490336ms","start":"2026-04-21T19:17:22.04385Z","end":"2026-04-21T19:17:22.231341Z","steps":["trace[2032730775] 'process raft request' (duration: 127.669176ms)","trace[2032730775] 'compare' (duration: 59.40258ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:22.231357Z","caller":"traceutil/trace.go:171","msg":"trace[105239481] transaction","detail":"{read_only:false; response_revision:62; number_of_response:1; }","duration":"183.969097ms","start":"2026-04-21T19:17:22.047361Z","end":"2026-04-21T19:17:22.23133Z","steps":["trace[105239481] 'process raft request' (duration: 183.802893ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:22.231572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.45109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18a8754fb6cec326\" ","response":"range_response_count:1 size:654"} {"level":"info","ts":"2026-04-21T19:17:22.231472Z","caller":"traceutil/trace.go:171","msg":"trace[1106596271] linearizableReadLoop","detail":"{readStateIndex:66; appliedIndex:65; }","duration":"186.277596ms","start":"2026-04-21T19:17:22.045103Z","end":"2026-04-21T19:17:22.231381Z","steps":["trace[1106596271] 'read index received' (duration: 126.393074ms)","trace[1106596271] 'applied index is now lower than readState.Index' (duration: 59.881752ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:22.231664Z","caller":"traceutil/trace.go:171","msg":"trace[1261178716] range","detail":"{range_begin:/registry/events/default/instance.18a8754fb6cec326; range_end:; response_count:1; response_revision:62; }","duration":"186.561033ms","start":"2026-04-21T19:17:22.045055Z","end":"2026-04-21T19:17:22.231616Z","steps":["trace[1261178716] 'agreement among raft nodes before linearized reading' (duration: 186.43277ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:28.202395Z","caller":"traceutil/trace.go:171","msg":"trace[143884833] linearizableReadLoop","detail":"{readStateIndex:353; appliedIndex:352; }","duration":"117.182198ms","start":"2026-04-21T19:17:28.085189Z","end":"2026-04-21T19:17:28.202371Z","steps":["trace[143884833] 'read index received' (duration: 116.915511ms)","trace[143884833] 'applied index is now lower than readState.Index' (duration: 265.337µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:28.202585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.377103ms","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-21T19:17:28.202576Z","caller":"traceutil/trace.go:171","msg":"trace[1658700930] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"137.079665ms","start":"2026-04-21T19:17:28.065437Z","end":"2026-04-21T19:17:28.202517Z","steps":["trace[1658700930] 'process raft request' (duration: 136.782778ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:28.202631Z","caller":"traceutil/trace.go:171","msg":"trace[1154308888] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:340; }","duration":"117.487466ms","start":"2026-04-21T19:17:28.085129Z","end":"2026-04-21T19:17:28.202617Z","steps":["trace[1154308888] 'agreement among raft nodes before linearized reading' (duration: 117.381443ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:28.316611Z","caller":"traceutil/trace.go:171","msg":"trace[1804941550] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"107.588234ms","start":"2026-04-21T19:17:28.208989Z","end":"2026-04-21T19:17:28.316577Z","steps":["trace[1804941550] 'process raft request' (duration: 107.139913ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:28.587709Z","caller":"traceutil/trace.go:171","msg":"trace[1550792895] linearizableReadLoop","detail":"{readStateIndex:358; appliedIndex:356; }","duration":"130.767535ms","start":"2026-04-21T19:17:28.456915Z","end":"2026-04-21T19:17:28.587682Z","steps":["trace[1550792895] 'read index received' (duration: 30.145237ms)","trace[1550792895] 'applied index is now lower than readState.Index' (duration: 100.619588ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:28.587783Z","caller":"traceutil/trace.go:171","msg":"trace[2119236689] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"167.405216ms","start":"2026-04-21T19:17:28.420339Z","end":"2026-04-21T19:17:28.587744Z","steps":["trace[2119236689] 'process raft request' (duration: 101.056449ms)","trace[2119236689] 'compare' (duration: 65.997739ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:28.587903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.96901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-04-21T19:17:28.58808Z","caller":"traceutil/trace.go:171","msg":"trace[84203647] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:346; }","duration":"131.081342ms","start":"2026-04-21T19:17:28.456906Z","end":"2026-04-21T19:17:28.587987Z","steps":["trace[84203647] 'agreement among raft nodes before linearized reading' (duration: 130.920578ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:28.863961Z","caller":"traceutil/trace.go:171","msg":"trace[1708628777] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"182.065839ms","start":"2026-04-21T19:17:28.681858Z","end":"2026-04-21T19:17:28.863924Z","steps":["trace[1708628777] 'process raft request' (duration: 108.733334ms)","trace[1708628777] 'compare' (duration: 73.145699ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:28.890425Z","caller":"traceutil/trace.go:171","msg":"trace[684303315] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"206.347566ms","start":"2026-04-21T19:17:28.684044Z","end":"2026-04-21T19:17:28.890391Z","steps":["trace[684303315] 'process raft request' (duration: 206.073429ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:28.89068Z","caller":"traceutil/trace.go:171","msg":"trace[411766263] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"205.398852ms","start":"2026-04-21T19:17:28.685246Z","end":"2026-04-21T19:17:28.890645Z","steps":["trace[411766263] 'process raft request' (duration: 205.071823ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:28.89076Z","caller":"traceutil/trace.go:171","msg":"trace[403816176] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"204.766756ms","start":"2026-04-21T19:17:28.685971Z","end":"2026-04-21T19:17:28.890738Z","steps":["trace[403816176] 'process raft request' (duration: 204.653213ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:28.890794Z","caller":"traceutil/trace.go:171","msg":"trace[2083009199] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"204.744835ms","start":"2026-04-21T19:17:28.685964Z","end":"2026-04-21T19:17:28.890709Z","steps":["trace[2083009199] 'process raft request' (duration: 204.594111ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:28.89089Z","caller":"traceutil/trace.go:171","msg":"trace[1402080510] linearizableReadLoop","detail":"{readStateIndex:372; appliedIndex:366; }","duration":"184.387827ms","start":"2026-04-21T19:17:28.706478Z","end":"2026-04-21T19:17:28.890866Z","steps":["trace[1402080510] 'read index received' (duration: 84.181549ms)","trace[1402080510] 'applied index is now lower than readState.Index' (duration: 100.204958ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:28.89091Z","caller":"traceutil/trace.go:171","msg":"trace[1019053336] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"203.410561ms","start":"2026-04-21T19:17:28.687486Z","end":"2026-04-21T19:17:28.890896Z","steps":["trace[1019053336] 'process raft request' (duration: 203.209516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:28.891038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.538382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-04-21T19:17:28.891088Z","caller":"traceutil/trace.go:171","msg":"trace[1493605575] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:359; }","duration":"184.655024ms","start":"2026-04-21T19:17:28.706417Z","end":"2026-04-21T19:17:28.891072Z","steps":["trace[1493605575] 'agreement among raft nodes before linearized reading' (duration: 184.541181ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:28.891085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.229112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-21T19:17:28.891141Z","caller":"traceutil/trace.go:171","msg":"trace[135766139] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:359; }","duration":"134.337846ms","start":"2026-04-21T19:17:28.756787Z","end":"2026-04-21T19:17:28.891125Z","steps":["trace[135766139] 'agreement among raft nodes before linearized reading' (duration: 134.241743ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:29.012914Z","caller":"traceutil/trace.go:171","msg":"trace[628570698] linearizableReadLoop","detail":"{readStateIndex:373; appliedIndex:372; }","duration":"112.162531ms","start":"2026-04-21T19:17:28.900719Z","end":"2026-04-21T19:17:29.012881Z","steps":["trace[628570698] 'read index received' (duration: 95.18331ms)","trace[628570698] 'applied index is now lower than readState.Index' (duration: 16.978171ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:29.013085Z","caller":"traceutil/trace.go:171","msg":"trace[1100578306] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"112.891221ms","start":"2026-04-21T19:17:28.900171Z","end":"2026-04-21T19:17:29.013062Z","steps":["trace[1100578306] 'process raft request' (duration: 95.628322ms)","trace[1100578306] 'compare' (duration: 16.92099ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:29.013104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.356656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3706"} {"level":"info","ts":"2026-04-21T19:17:29.013147Z","caller":"traceutil/trace.go:171","msg":"trace[490549525] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:360; }","duration":"112.423918ms","start":"2026-04-21T19:17:28.900712Z","end":"2026-04-21T19:17:29.013136Z","steps":["trace[490549525] 'agreement among raft nodes before linearized reading' (duration: 112.278994ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:29.260645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.485078ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:17:29.260988Z","caller":"traceutil/trace.go:171","msg":"trace[609282379] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"358.400862ms","start":"2026-04-21T19:17:28.90253Z","end":"2026-04-21T19:17:29.260931Z","steps":["trace[609282379] 'process raft request' (duration: 247.551874ms)","trace[609282379] 'compare' (duration: 110.303334ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:29.261093Z","caller":"traceutil/trace.go:171","msg":"trace[1319885395] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"358.361091ms","start":"2026-04-21T19:17:28.902681Z","end":"2026-04-21T19:17:29.261042Z","steps":["trace[1319885395] 'process raft request' (duration: 358.153885ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:29.261224Z","caller":"traceutil/trace.go:171","msg":"trace[1827750178] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"355.749504ms","start":"2026-04-21T19:17:28.905433Z","end":"2026-04-21T19:17:29.261182Z","steps":["trace[1827750178] 'process raft request' (duration: 355.481257ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:29.261219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:28.902515Z","time spent":"358.595286ms","remote":"127.0.0.1:47502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T19:17:29.261072Z","caller":"traceutil/trace.go:171","msg":"trace[2069891651] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"243.358957ms","start":"2026-04-21T19:17:29.017692Z","end":"2026-04-21T19:17:29.261051Z","steps":["trace[2069891651] 'process raft request' (duration: 243.274695ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:29.261423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:28.905412Z","time spent":"355.915738ms","remote":"127.0.0.1:47404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T19:17:29.261551Z","caller":"traceutil/trace.go:171","msg":"trace[677558179] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"242.644238ms","start":"2026-04-21T19:17:29.018832Z","end":"2026-04-21T19:17:29.261476Z","steps":["trace[677558179] 'process raft request' (duration: 242.180607ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:29.261609Z","caller":"traceutil/trace.go:171","msg":"trace[908060208] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"242.185327ms","start":"2026-04-21T19:17:29.019391Z","end":"2026-04-21T19:17:29.261577Z","steps":["trace[908060208] 'process raft request' (duration: 241.982102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:29.26162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:28.902653Z","time spent":"358.557116ms","remote":"127.0.0.1:47594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:17:29.261989Z","caller":"traceutil/trace.go:171","msg":"trace[1620361224] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"239.871618ms","start":"2026-04-21T19:17:29.021925Z","end":"2026-04-21T19:17:29.261796Z","steps":["trace[1620361224] 'process raft request' (duration: 239.553679ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:33.775811Z","caller":"traceutil/trace.go:171","msg":"trace[324057832] linearizableReadLoop","detail":"{readStateIndex:412; appliedIndex:411; }","duration":"262.821711ms","start":"2026-04-21T19:17:33.512946Z","end":"2026-04-21T19:17:33.775768Z","steps":["trace[324057832] 'read index received' (duration: 262.619496ms)","trace[324057832] 'applied index is now lower than readState.Index' (duration: 200.165µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:33.77583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:33.358636Z","time spent":"417.186076ms","remote":"127.0.0.1:47256","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-21T19:17:33.776003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.040687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-21T19:17:33.776025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.615227ms","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-21T19:17:33.776078Z","caller":"traceutil/trace.go:171","msg":"trace[1078113657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:397; }","duration":"240.73032ms","start":"2026-04-21T19:17:33.535331Z","end":"2026-04-21T19:17:33.776062Z","steps":["trace[1078113657] 'agreement among raft nodes before linearized reading' (duration: 240.631787ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:33.776091Z","caller":"traceutil/trace.go:171","msg":"trace[1849879310] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:397; }","duration":"263.181531ms","start":"2026-04-21T19:17:33.512877Z","end":"2026-04-21T19:17:33.776058Z","steps":["trace[1849879310] 'agreement among raft nodes before linearized reading' (duration: 263.014816ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:34.330105Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991528253552220797,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T19:17:34.830457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.785664ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:17:34.830689Z","caller":"traceutil/trace.go:171","msg":"trace[265618578] linearizableReadLoop","detail":"{readStateIndex:415; appliedIndex:412; }","duration":"1.001397177s","start":"2026-04-21T19:17:33.829274Z","end":"2026-04-21T19:17:34.830672Z","steps":["trace[265618578] 'read index received' (duration: 883.291345ms)","trace[265618578] 'applied index is now lower than readState.Index' (duration: 118.104922ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:34.830775Z","caller":"traceutil/trace.go:171","msg":"trace[1377088895] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"1.053670096s","start":"2026-04-21T19:17:33.777092Z","end":"2026-04-21T19:17:34.830762Z","steps":["trace[1377088895] 'process raft request' (duration: 935.474592ms)","trace[1377088895] 'compare' (duration: 117.579549ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:34.830838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:33.777052Z","time spent":"1.053750969s","remote":"127.0.0.1:47256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:17:34.831322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.115623ms","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-21T19:17:34.831359Z","caller":"traceutil/trace.go:171","msg":"trace[1724863172] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"1.050886395s","start":"2026-04-21T19:17:33.780452Z","end":"2026-04-21T19:17:34.831338Z","steps":["trace[1724863172] 'process raft request' (duration: 1.050128885s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:34.831349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.002078865s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T19:17:34.831389Z","caller":"traceutil/trace.go:171","msg":"trace[1966864084] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:400; }","duration":"520.234016ms","start":"2026-04-21T19:17:34.311138Z","end":"2026-04-21T19:17:34.831372Z","steps":["trace[1966864084] 'agreement among raft nodes before linearized reading' (duration: 520.088402ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:34.831423Z","caller":"traceutil/trace.go:171","msg":"trace[1508290358] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:400; }","duration":"1.002205118s","start":"2026-04-21T19:17:33.829202Z","end":"2026-04-21T19:17:34.831407Z","steps":["trace[1508290358] 'agreement among raft nodes before linearized reading' (duration: 1.001996143s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:34.831429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:34.311078Z","time spent":"520.341889ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T19:17:34.831458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:33.780426Z","time spent":"1.050978617s","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:17:34.831465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:33.829174Z","time spent":"1.00227995s","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-21T19:17:34.831513Z","caller":"traceutil/trace.go:171","msg":"trace[1385733880] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"1.050900156s","start":"2026-04-21T19:17:33.780599Z","end":"2026-04-21T19:17:34.831499Z","steps":["trace[1385733880] 'process raft request' (duration: 1.050038333s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:34.831591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:33.780585Z","time spent":"1.050957917s","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:17:41.205489Z","caller":"traceutil/trace.go:171","msg":"trace[1440487637] linearizableReadLoop","detail":"{readStateIndex:466; appliedIndex:465; }","duration":"340.281521ms","start":"2026-04-21T19:17:40.865179Z","end":"2026-04-21T19:17:41.205461Z","steps":["trace[1440487637] 'read index received' (duration: 340.222859ms)","trace[1440487637] 'applied index is now lower than readState.Index' (duration: 57.322µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:41.205607Z","caller":"traceutil/trace.go:171","msg":"trace[203320797] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"340.912228ms","start":"2026-04-21T19:17:40.864659Z","end":"2026-04-21T19:17:41.205571Z","steps":["trace[203320797] 'process raft request' (duration: 340.646271ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:41.205685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.474436ms","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-21T19:17:41.205731Z","caller":"traceutil/trace.go:171","msg":"trace[1570022387] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:449; }","duration":"340.554067ms","start":"2026-04-21T19:17:40.865166Z","end":"2026-04-21T19:17:41.20572Z","steps":["trace[1570022387] 'agreement among raft nodes before linearized reading' (duration: 340.414224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:41.205769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:40.865157Z","time spent":"340.602458ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T19:17:41.205793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:40.864642Z","time spent":"341.04239ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:17:41.273831Z","caller":"traceutil/trace.go:171","msg":"trace[1762876326] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"407.010737ms","start":"2026-04-21T19:17:40.866794Z","end":"2026-04-21T19:17:41.273805Z","steps":["trace[1762876326] 'process raft request' (duration: 406.968726ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:41.27391Z","caller":"traceutil/trace.go:171","msg":"trace[893978139] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"408.496964ms","start":"2026-04-21T19:17:40.865378Z","end":"2026-04-21T19:17:41.273875Z","steps":["trace[893978139] 'process raft request' (duration: 408.216297ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:41.274012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:40.866788Z","time spent":"407.125749ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:17:41.274087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:40.865368Z","time spent":"408.624618ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:17:47.40832Z","caller":"traceutil/trace.go:171","msg":"trace[1548942924] linearizableReadLoop","detail":"{readStateIndex:482; appliedIndex:481; }","duration":"110.334915ms","start":"2026-04-21T19:17:47.297956Z","end":"2026-04-21T19:17:47.408291Z","steps":["trace[1548942924] 'read index received' (duration: 110.066168ms)","trace[1548942924] 'applied index is now lower than readState.Index' (duration: 267.557µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:47.408455Z","caller":"traceutil/trace.go:171","msg":"trace[303380840] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"173.286817ms","start":"2026-04-21T19:17:47.235119Z","end":"2026-04-21T19:17:47.408406Z","steps":["trace[303380840] 'process raft request' (duration: 172.984529ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:47.408516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.52605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T19:17:47.408566Z","caller":"traceutil/trace.go:171","msg":"trace[1694008916] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:464; }","duration":"110.654153ms","start":"2026-04-21T19:17:47.2979Z","end":"2026-04-21T19:17:47.408554Z","steps":["trace[1694008916] 'agreement among raft nodes before linearized reading' (duration: 110.53467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:47.408677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.79464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-21T19:17:47.408652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.134394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-21T19:17:47.408734Z","caller":"traceutil/trace.go:171","msg":"trace[1560881518] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:464; }","duration":"105.887282ms","start":"2026-04-21T19:17:47.302832Z","end":"2026-04-21T19:17:47.408719Z","steps":["trace[1560881518] 'agreement among raft nodes before linearized reading' (duration: 105.732428ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:47.408758Z","caller":"traceutil/trace.go:171","msg":"trace[890990039] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:464; }","duration":"107.284738ms","start":"2026-04-21T19:17:47.301449Z","end":"2026-04-21T19:17:47.408733Z","steps":["trace[890990039] 'agreement among raft nodes before linearized reading' (duration: 107.081553ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:48.066194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.347425ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:17:48.066347Z","caller":"traceutil/trace.go:171","msg":"trace[1360187532] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"652.83567ms","start":"2026-04-21T19:17:47.413494Z","end":"2026-04-21T19:17:48.06633Z","steps":["trace[1360187532] 'process raft request' (duration: 87.263489ms)","trace[1360187532] 'compare' (duration: 565.221453ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:48.06641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:47.413465Z","time spent":"652.920172ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:17:48.066681Z","caller":"traceutil/trace.go:171","msg":"trace[1001107905] linearizableReadLoop","detail":"{readStateIndex:485; appliedIndex:482; }","duration":"410.58495ms","start":"2026-04-21T19:17:47.656084Z","end":"2026-04-21T19:17:48.066668Z","steps":["trace[1001107905] 'read index received' (duration: 40.011µs)","trace[1001107905] 'applied index is now lower than readState.Index' (duration: 410.543539ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:48.066669Z","caller":"traceutil/trace.go:171","msg":"trace[602731697] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"653.092687ms","start":"2026-04-21T19:17:47.413558Z","end":"2026-04-21T19:17:48.066651Z","steps":["trace[602731697] 'process raft request' (duration: 652.727177ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:48.066679Z","caller":"traceutil/trace.go:171","msg":"trace[1589506786] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"653.036486ms","start":"2026-04-21T19:17:47.413621Z","end":"2026-04-21T19:17:48.066657Z","steps":["trace[1589506786] 'process raft request' (duration: 652.918833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:48.066756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:47.413526Z","time spent":"653.188409ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:17:48.066788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:47.413465Z","time spent":"653.266151ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:17:48.066828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.706553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:48.066909Z","caller":"traceutil/trace.go:171","msg":"trace[2142128941] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:467; }","duration":"410.855747ms","start":"2026-04-21T19:17:47.656036Z","end":"2026-04-21T19:17:48.066892Z","steps":["trace[2142128941] 'agreement among raft nodes before linearized reading' (duration: 410.669692ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:48.066956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:47.656012Z","time spent":"410.935939ms","remote":"127.0.0.1:47204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-21T19:17:51.837087Z","caller":"traceutil/trace.go:171","msg":"trace[1333772940] linearizableReadLoop","detail":"{readStateIndex:491; appliedIndex:490; }","duration":"180.596511ms","start":"2026-04-21T19:17:51.656462Z","end":"2026-04-21T19:17:51.837058Z","steps":["trace[1333772940] 'read index received' (duration: 180.373966ms)","trace[1333772940] 'applied index is now lower than readState.Index' (duration: 220.925µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:51.837119Z","caller":"traceutil/trace.go:171","msg":"trace[1293901018] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"410.325933ms","start":"2026-04-21T19:17:51.426761Z","end":"2026-04-21T19:17:51.837086Z","steps":["trace[1293901018] 'process raft request' (duration: 410.099637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:51.837228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.749026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:17:51.837263Z","caller":"traceutil/trace.go:171","msg":"trace[1998643374] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:472; }","duration":"180.863358ms","start":"2026-04-21T19:17:51.656389Z","end":"2026-04-21T19:17:51.837253Z","steps":["trace[1998643374] 'agreement among raft nodes before linearized reading' (duration: 180.776956ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:51.837298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:51.426736Z","time spent":"410.454376ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:17:53.291064Z","caller":"traceutil/trace.go:171","msg":"trace[468728626] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"268.505897ms","start":"2026-04-21T19:17:53.022516Z","end":"2026-04-21T19:17:53.291022Z","steps":["trace[468728626] 'process raft request' (duration: 221.612175ms)","trace[468728626] 'compare' (duration: 46.434081ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:17:53.494084Z","caller":"traceutil/trace.go:171","msg":"trace[103969692] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"113.199249ms","start":"2026-04-21T19:17:53.380856Z","end":"2026-04-21T19:17:53.494055Z","steps":["trace[103969692] 'process raft request' (duration: 113.013784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:55.615012Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.15617177s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-21T19:17:55.618945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.16053504s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:17:55.619151Z","caller":"traceutil/trace.go:171","msg":"trace[1907390515] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"1.41498874s","start":"2026-04-21T19:17:54.20413Z","end":"2026-04-21T19:17:55.619119Z","steps":["trace[1907390515] 'process raft request' (duration: 254.195864ms)","trace[1907390515] 'compare' (duration: 1.160411636s)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:17:55.619289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:54.204119Z","time spent":"1.415091942s","remote":"127.0.0.1:47784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T19:17:55.619334Z","caller":"traceutil/trace.go:171","msg":"trace[209512366] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"1.396802067s","start":"2026-04-21T19:17:54.222516Z","end":"2026-04-21T19:17:55.619318Z","steps":["trace[209512366] 'process raft request' (duration: 1.396622502s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:55.619405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:54.222484Z","time spent":"1.396882199s","remote":"127.0.0.1:47280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:17:55.619543Z","caller":"traceutil/trace.go:171","msg":"trace[2018528553] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"1.389730658s","start":"2026-04-21T19:17:54.229801Z","end":"2026-04-21T19:17:55.619532Z","steps":["trace[2018528553] 'process raft request' (duration: 1.389460981s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:55.619595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:54.229768Z","time spent":"1.38979659s","remote":"127.0.0.1:47280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80679,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:17:55.619763Z","caller":"traceutil/trace.go:171","msg":"trace[1353438647] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"1.32337388s","start":"2026-04-21T19:17:54.296368Z","end":"2026-04-21T19:17:55.619742Z","steps":["trace[1353438647] 'process raft request' (duration: 1.323309849s)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:17:55.619813Z","caller":"traceutil/trace.go:171","msg":"trace[357467701] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"1.387931192s","start":"2026-04-21T19:17:54.231872Z","end":"2026-04-21T19:17:55.619803Z","steps":["trace[357467701] 'process raft request' (duration: 1.387602694s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:17:55.619835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:54.296326Z","time spent":"1.323474313s","remote":"127.0.0.1:47280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T19:17:55.619857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:17:54.231858Z","time spent":"1.387975714s","remote":"127.0.0.1:47280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59616,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:18:02.678254Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991528253552221282,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-21T19:18:02.680091Z","caller":"traceutil/trace.go:171","msg":"trace[586020902] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"766.04222ms","start":"2026-04-21T19:18:01.914015Z","end":"2026-04-21T19:18:02.680058Z","steps":["trace[586020902] 'process raft request' (duration: 765.800654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:02.680272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:01.913988Z","time spent":"766.180313ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:18:03.72374Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.042465418s","expected-duration":"1s"} {"level":"info","ts":"2026-04-21T19:18:03.725795Z","caller":"traceutil/trace.go:171","msg":"trace[737082298] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"1.741535664s","start":"2026-04-21T19:18:01.984233Z","end":"2026-04-21T19:18:03.725769Z","steps":["trace[737082298] 'process raft request' (duration: 1.740392705s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:03.725949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:01.984197Z","time spent":"1.741664207s","remote":"127.0.0.1:47334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:18:03.72618Z","caller":"traceutil/trace.go:171","msg":"trace[326681095] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"1.314556886s","start":"2026-04-21T19:18:02.411589Z","end":"2026-04-21T19:18:03.726146Z","steps":["trace[326681095] 'process raft request' (duration: 1.314102695s)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:03.726141Z","caller":"traceutil/trace.go:171","msg":"trace[190073419] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:646; }","duration":"1.548884555s","start":"2026-04-21T19:18:02.177225Z","end":"2026-04-21T19:18:03.726109Z","steps":["trace[190073419] 'read index received' (duration: 502.674963ms)","trace[190073419] 'applied index is now lower than readState.Index' (duration: 1.046207602s)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:03.72624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:02.411552Z","time spent":"1.314661859s","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:18:03.726386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.068447268s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:18:03.726429Z","caller":"traceutil/trace.go:171","msg":"trace[861330265] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:625; }","duration":"1.0685431s","start":"2026-04-21T19:18:02.657873Z","end":"2026-04-21T19:18:03.726416Z","steps":["trace[861330265] 'agreement among raft nodes before linearized reading' (duration: 1.068464798s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:03.726425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.549208873s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-21T19:18:03.726461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:02.657844Z","time spent":"1.068610772s","remote":"127.0.0.1:47204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-21T19:18:03.726472Z","caller":"traceutil/trace.go:171","msg":"trace[41843900] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:625; }","duration":"1.549297065s","start":"2026-04-21T19:18:02.177161Z","end":"2026-04-21T19:18:03.726458Z","steps":["trace[41843900] 'agreement among raft nodes before linearized reading' (duration: 1.549123351s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:03.726513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:02.177134Z","time spent":"1.549367377s","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-21T19:18:03.726537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.532900268s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-21T19:18:03.726539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.497885727s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rszwb\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-21T19:18:03.726587Z","caller":"traceutil/trace.go:171","msg":"trace[227069747] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:625; }","duration":"1.532988621s","start":"2026-04-21T19:18:02.193586Z","end":"2026-04-21T19:18:03.726574Z","steps":["trace[227069747] 'agreement among raft nodes before linearized reading' (duration: 1.532812556s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:03.726587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.132837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.141\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-21T19:18:03.726603Z","caller":"traceutil/trace.go:171","msg":"trace[161413136] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rszwb; range_end:; response_count:1; response_revision:625; }","duration":"1.49800381s","start":"2026-04-21T19:18:02.228581Z","end":"2026-04-21T19:18:03.726585Z","steps":["trace[161413136] 'agreement among raft nodes before linearized reading' (duration: 1.497779704s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:03.726625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:02.193574Z","time spent":"1.533043492s","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-21T19:18:03.726647Z","caller":"traceutil/trace.go:171","msg":"trace[1306982003] range","detail":"{range_begin:/registry/masterleases/199.204.45.141; range_end:; response_count:1; response_revision:625; }","duration":"371.236849ms","start":"2026-04-21T19:18:03.355393Z","end":"2026-04-21T19:18:03.72663Z","steps":["trace[1306982003] 'agreement among raft nodes before linearized reading' (duration: 371.097576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:03.72667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:02.228556Z","time spent":"1.498083352s","remote":"127.0.0.1:47404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-rszwb\" "} {"level":"warn","ts":"2026-04-21T19:18:03.7267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:03.355368Z","time spent":"371.320262ms","remote":"127.0.0.1:47256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.141\" "} {"level":"warn","ts":"2026-04-21T19:18:03.727069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.547625673s","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-21T19:18:03.727182Z","caller":"traceutil/trace.go:171","msg":"trace[158678178] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:625; }","duration":"1.547797728s","start":"2026-04-21T19:18:02.179365Z","end":"2026-04-21T19:18:03.727162Z","steps":["trace[158678178] 'agreement among raft nodes before linearized reading' (duration: 1.546938345s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:03.727292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:02.179338Z","time spent":"1.547940591s","remote":"127.0.0.1:47486","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":"warn","ts":"2026-04-21T19:18:04.176711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.453696ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-04-21T19:18:04.176827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:03.728114Z","time spent":"448.70737ms","remote":"127.0.0.1:47256","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-21T19:18:04.251517Z","caller":"traceutil/trace.go:171","msg":"trace[2036445068] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"519.152402ms","start":"2026-04-21T19:18:03.732335Z","end":"2026-04-21T19:18:04.251487Z","steps":["trace[2036445068] 'process raft request' (duration: 519.049089ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:04.251545Z","caller":"traceutil/trace.go:171","msg":"trace[226953587] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"520.028043ms","start":"2026-04-21T19:18:03.731477Z","end":"2026-04-21T19:18:04.251505Z","steps":["trace[226953587] 'process raft request' (duration: 519.681305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:04.251691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:03.732313Z","time spent":"519.291045ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:18:04.25175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:03.731452Z","time spent":"520.181638ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:18:04.251875Z","caller":"traceutil/trace.go:171","msg":"trace[791443636] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"518.883314ms","start":"2026-04-21T19:18:03.732937Z","end":"2026-04-21T19:18:04.251821Z","steps":["trace[791443636] 'process raft request' (duration: 518.488334ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:04.251982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:03.73292Z","time spent":"519.008047ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:18:04.252024Z","caller":"traceutil/trace.go:171","msg":"trace[690401567] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:649; }","duration":"517.554421ms","start":"2026-04-21T19:18:03.734452Z","end":"2026-04-21T19:18:04.252006Z","steps":["trace[690401567] 'read index received' (duration: 173.771349ms)","trace[690401567] 'applied index is now lower than readState.Index' (duration: 343.782212ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:04.252161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.705545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:18:04.252186Z","caller":"traceutil/trace.go:171","msg":"trace[458943359] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"453.084351ms","start":"2026-04-21T19:18:03.799088Z","end":"2026-04-21T19:18:04.252172Z","steps":["trace[458943359] 'process raft request' (duration: 452.870656ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:04.252203Z","caller":"traceutil/trace.go:171","msg":"trace[1737985008] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"517.779226ms","start":"2026-04-21T19:18:03.734413Z","end":"2026-04-21T19:18:04.252192Z","steps":["trace[1737985008] 'agreement among raft nodes before linearized reading' (duration: 517.649782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:04.252235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:03.734394Z","time spent":"517.832988ms","remote":"127.0.0.1:47204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-21T19:18:04.252244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:03.799061Z","time spent":"453.154623ms","remote":"127.0.0.1:47468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T19:18:04.252281Z","caller":"traceutil/trace.go:171","msg":"trace[1949645713] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"507.815473ms","start":"2026-04-21T19:18:03.74433Z","end":"2026-04-21T19:18:04.252145Z","steps":["trace[1949645713] 'process raft request' (duration: 507.429123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:04.252508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:03.7443Z","time spent":"508.10564ms","remote":"127.0.0.1:47404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:18:06.576898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.279909443s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:18:06.577111Z","caller":"traceutil/trace.go:171","msg":"trace[2002960585] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"567.555902ms","start":"2026-04-21T19:18:06.009536Z","end":"2026-04-21T19:18:06.577091Z","steps":["trace[2002960585] 'process raft request' (duration: 567.490221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:06.577191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:06.009503Z","time spent":"567.653525ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:18:06.577449Z","caller":"traceutil/trace.go:171","msg":"trace[2044915276] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"2.399425873s","start":"2026-04-21T19:18:04.178006Z","end":"2026-04-21T19:18:06.577431Z","steps":["trace[2044915276] 'process raft request' (duration: 118.877163ms)","trace[2044915276] 'compare' (duration: 2.279584856s)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:06.577525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:04.177978Z","time spent":"2.399512345s","remote":"127.0.0.1:47256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:18:06.577553Z","caller":"traceutil/trace.go:171","msg":"trace[1378533483] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"2.320965637s","start":"2026-04-21T19:18:04.256548Z","end":"2026-04-21T19:18:06.577513Z","steps":["trace[1378533483] 'read index received' (duration: 40.264943ms)","trace[1378533483] 'applied index is now lower than readState.Index' (duration: 2.280698554s)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:18:06.57773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.321165481s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-04-21T19:18:06.577765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"923.070232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:18:06.577813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.893116228s","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-21T19:18:06.577825Z","caller":"traceutil/trace.go:171","msg":"trace[113169866] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:632; }","duration":"2.321277054s","start":"2026-04-21T19:18:04.256529Z","end":"2026-04-21T19:18:06.577806Z","steps":["trace[113169866] 'agreement among raft nodes before linearized reading' (duration: 2.321085729s)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:06.577845Z","caller":"traceutil/trace.go:171","msg":"trace[1278260424] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:632; }","duration":"923.195374ms","start":"2026-04-21T19:18:05.654625Z","end":"2026-04-21T19:18:06.57782Z","steps":["trace[1278260424] 'agreement among raft nodes before linearized reading' (duration: 923.075881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:06.577875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:04.256459Z","time spent":"2.321405599s","remote":"127.0.0.1:47420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-04-21T19:18:06.577873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.69312ms","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-21T19:18:06.577854Z","caller":"traceutil/trace.go:171","msg":"trace[1505636549] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:632; }","duration":"1.89320338s","start":"2026-04-21T19:18:04.68464Z","end":"2026-04-21T19:18:06.577844Z","steps":["trace[1505636549] 'agreement among raft nodes before linearized reading' (duration: 1.893040736s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:06.577951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:04.684612Z","time spent":"1.893329993s","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-21T19:18:06.577962Z","caller":"traceutil/trace.go:171","msg":"trace[1796245418] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:632; }","duration":"321.816403ms","start":"2026-04-21T19:18:06.256126Z","end":"2026-04-21T19:18:06.577943Z","steps":["trace[1796245418] 'agreement among raft nodes before linearized reading' (duration: 321.556787ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:06.577908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:05.654594Z","time spent":"923.301347ms","remote":"127.0.0.1:47204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-21T19:18:06.577942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.743841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-21T19:18:06.577956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.911266ms","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-21T19:18:06.57803Z","caller":"traceutil/trace.go:171","msg":"trace[917451234] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:632; }","duration":"321.893705ms","start":"2026-04-21T19:18:06.256113Z","end":"2026-04-21T19:18:06.578007Z","steps":["trace[917451234] 'agreement among raft nodes before linearized reading' (duration: 321.592518ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:06.578082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:06.256092Z","time spent":"321.980158ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-21T19:18:06.578079Z","caller":"traceutil/trace.go:171","msg":"trace[2048932025] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:632; }","duration":"322.1047ms","start":"2026-04-21T19:18:06.255946Z","end":"2026-04-21T19:18:06.578051Z","steps":["trace[2048932025] 'agreement among raft nodes before linearized reading' (duration: 321.744961ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:06.578244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:06.255915Z","time spent":"322.298185ms","remote":"127.0.0.1:47486","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":"warn","ts":"2026-04-21T19:18:06.578004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:06.256114Z","time spent":"321.881535ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-21T19:18:08.670338Z","caller":"traceutil/trace.go:171","msg":"trace[1838326141] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"175.125703ms","start":"2026-04-21T19:18:08.495151Z","end":"2026-04-21T19:18:08.670277Z","steps":["trace[1838326141] 'process raft request' (duration: 174.877707ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:23.722507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.06538474s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:18:23.722595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"913.818126ms","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-21T19:18:23.722686Z","caller":"traceutil/trace.go:171","msg":"trace[357997401] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:793; }","duration":"913.96666ms","start":"2026-04-21T19:18:22.808698Z","end":"2026-04-21T19:18:23.722665Z","steps":["trace[357997401] 'range keys from in-memory index tree' (duration: 913.638962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:23.722739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:22.808684Z","time spent":"914.044642ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-21T19:18:23.722897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"914.149604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-21T19:18:23.722954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.06304291s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T19:18:23.722993Z","caller":"traceutil/trace.go:171","msg":"trace[1651660292] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:793; }","duration":"914.293878ms","start":"2026-04-21T19:18:22.808678Z","end":"2026-04-21T19:18:23.722972Z","steps":["trace[1651660292] 'range keys from in-memory index tree' (duration: 913.96659ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:23.723027Z","caller":"traceutil/trace.go:171","msg":"trace[425001839] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:793; }","duration":"1.063156363s","start":"2026-04-21T19:18:22.659852Z","end":"2026-04-21T19:18:23.723008Z","steps":["trace[425001839] 'count revisions from in-memory index tree' (duration: 1.062969468s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:23.723045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:22.808657Z","time spent":"914.37434ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-21T19:18:23.723021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"981.25246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-21T19:18:23.723021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.134083566s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-21T19:18:23.723086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:22.659837Z","time spent":"1.063235605s","remote":"127.0.0.1:47334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":9,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"info","ts":"2026-04-21T19:18:23.723107Z","caller":"traceutil/trace.go:171","msg":"trace[1424563918] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:793; }","duration":"1.13423917s","start":"2026-04-21T19:18:22.58885Z","end":"2026-04-21T19:18:23.723089Z","steps":["trace[1424563918] 'count revisions from in-memory index tree' (duration: 1.133975304s)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:23.723104Z","caller":"traceutil/trace.go:171","msg":"trace[1542389672] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:793; }","duration":"981.388914ms","start":"2026-04-21T19:18:22.741695Z","end":"2026-04-21T19:18:23.723083Z","steps":["trace[1542389672] 'range keys from in-memory index tree' (duration: 981.012184ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:23.723107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"972.665522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-21T19:18:23.723156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:22.741668Z","time spent":"981.473336ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-21T19:18:23.72322Z","caller":"traceutil/trace.go:171","msg":"trace[44827464] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:793; }","duration":"972.837096ms","start":"2026-04-21T19:18:22.750359Z","end":"2026-04-21T19:18:23.723196Z","steps":["trace[44827464] 'range keys from in-memory index tree' (duration: 972.462167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:23.723276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:22.750336Z","time spent":"972.928429ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T19:18:23.723153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:22.588814Z","time spent":"1.134327302s","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":52,"response size":30,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"info","ts":"2026-04-21T19:18:23.723929Z","caller":"traceutil/trace.go:171","msg":"trace[1684493062] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:793; }","duration":"1.065562664s","start":"2026-04-21T19:18:22.657037Z","end":"2026-04-21T19:18:23.722599Z","steps":["trace[1684493062] 'range keys from in-memory index tree' (duration: 1.065230726s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:23.724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:22.657015Z","time spent":"1.06696897s","remote":"127.0.0.1:47204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-21T19:18:23.856589Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991528253552221623,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-21T19:18:24.121874Z","caller":"traceutil/trace.go:171","msg":"trace[392381403] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"772.31903ms","start":"2026-04-21T19:18:23.349502Z","end":"2026-04-21T19:18:24.121821Z","steps":["trace[392381403] 'process raft request' (duration: 772.093404ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:24.122319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:23.349465Z","time spent":"772.572896ms","remote":"127.0.0.1:47468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:18:24.134219Z","caller":"traceutil/trace.go:171","msg":"trace[259198] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"407.646406ms","start":"2026-04-21T19:18:23.726555Z","end":"2026-04-21T19:18:24.134201Z","steps":["trace[259198] 'process raft request' (duration: 407.504722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:24.134338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:23.726541Z","time spent":"407.730058ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:18:24.134452Z","caller":"traceutil/trace.go:171","msg":"trace[75522481] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"407.02674ms","start":"2026-04-21T19:18:23.727413Z","end":"2026-04-21T19:18:24.13444Z","steps":["trace[75522481] 'process raft request' (duration: 406.740993ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:24.13456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:23.727406Z","time spent":"407.086301ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:18:24.13459Z","caller":"traceutil/trace.go:171","msg":"trace[248595622] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"406.401914ms","start":"2026-04-21T19:18:23.728127Z","end":"2026-04-21T19:18:24.134529Z","steps":["trace[248595622] 'process raft request' (duration: 406.21741ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:24.134622Z","caller":"traceutil/trace.go:171","msg":"trace[1208121270] linearizableReadLoop","detail":"{readStateIndex:828; appliedIndex:823; }","duration":"778.254479ms","start":"2026-04-21T19:18:23.356357Z","end":"2026-04-21T19:18:24.134611Z","steps":["trace[1208121270] 'read index received' (duration: 765.179387ms)","trace[1208121270] 'applied index is now lower than readState.Index' (duration: 13.074562ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:24.134698Z","caller":"traceutil/trace.go:171","msg":"trace[333453558] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"406.374984ms","start":"2026-04-21T19:18:23.728312Z","end":"2026-04-21T19:18:24.134687Z","steps":["trace[333453558] 'process raft request' (duration: 406.173269ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:24.134797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:23.72809Z","time spent":"406.601299ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:18:24.134814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:23.728304Z","time spent":"406.457146ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:18:24.134886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"778.525276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.141\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-04-21T19:18:24.134819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.42424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T19:18:24.13494Z","caller":"traceutil/trace.go:171","msg":"trace[653676902] range","detail":"{range_begin:/registry/masterleases/199.204.45.141; range_end:; response_count:1; response_revision:798; }","duration":"778.579117ms","start":"2026-04-21T19:18:23.356347Z","end":"2026-04-21T19:18:24.134926Z","steps":["trace[653676902] 'agreement among raft nodes before linearized reading' (duration: 778.393662ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:18:24.134964Z","caller":"traceutil/trace.go:171","msg":"trace[2079993042] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:798; }","duration":"617.592964ms","start":"2026-04-21T19:18:23.517336Z","end":"2026-04-21T19:18:24.134929Z","steps":["trace[2079993042] 'agreement among raft nodes before linearized reading' (duration: 617.41564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:24.134982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:23.356299Z","time spent":"778.675609ms","remote":"127.0.0.1:47256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.141\" "} {"level":"warn","ts":"2026-04-21T19:18:24.134997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:23.517303Z","time spent":"617.684267ms","remote":"127.0.0.1:47576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":14,"response size":30,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"warn","ts":"2026-04-21T19:18:24.134903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.79568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:18:24.135164Z","caller":"traceutil/trace.go:171","msg":"trace[1363563390] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:798; }","duration":"410.072458ms","start":"2026-04-21T19:18:23.725079Z","end":"2026-04-21T19:18:24.135151Z","steps":["trace[1363563390] 'agreement among raft nodes before linearized reading' (duration: 409.763939ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:18:24.135294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:18:23.725061Z","time spent":"410.194201ms","remote":"127.0.0.1:47210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-21T19:18:42.596049Z","caller":"traceutil/trace.go:171","msg":"trace[1999627025] transaction","detail":"{read_only:false; response_revision:1143; number_of_response:1; }","duration":"130.781635ms","start":"2026-04-21T19:18:42.465224Z","end":"2026-04-21T19:18:42.596005Z","steps":["trace[1999627025] 'process raft request' (duration: 101.847029ms)","trace[1999627025] 'compare' (duration: 28.672549ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:18:42.596367Z","caller":"traceutil/trace.go:171","msg":"trace[147357750] transaction","detail":"{read_only:false; response_revision:1144; number_of_response:1; }","duration":"128.105158ms","start":"2026-04-21T19:18:42.468192Z","end":"2026-04-21T19:18:42.596298Z","steps":["trace[147357750] 'process raft request' (duration: 127.710347ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:19:28.945894Z","caller":"traceutil/trace.go:171","msg":"trace[460028112] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"101.837531ms","start":"2026-04-21T19:19:28.844023Z","end":"2026-04-21T19:19:28.945861Z","steps":["trace[460028112] 'process raft request' (duration: 101.558594ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:19:45.032586Z","caller":"traceutil/trace.go:171","msg":"trace[1879571457] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"177.885536ms","start":"2026-04-21T19:19:44.854666Z","end":"2026-04-21T19:19:45.032552Z","steps":["trace[1879571457] 'process raft request' (duration: 177.681231ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:19:45.306361Z","caller":"traceutil/trace.go:171","msg":"trace[1129500892] transaction","detail":"{read_only:false; response_revision:1434; number_of_response:1; }","duration":"108.966573ms","start":"2026-04-21T19:19:45.197364Z","end":"2026-04-21T19:19:45.306331Z","steps":["trace[1129500892] 'process raft request' (duration: 46.990639ms)","trace[1129500892] 'compare' (duration: 61.856311ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:19:47.030424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.387883ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:19:47.030634Z","caller":"traceutil/trace.go:171","msg":"trace[1190240430] transaction","detail":"{read_only:false; response_revision:1439; number_of_response:1; }","duration":"261.711203ms","start":"2026-04-21T19:19:46.768892Z","end":"2026-04-21T19:19:47.030603Z","steps":["trace[1190240430] 'process raft request' (duration: 98.019322ms)","trace[1190240430] 'compare' (duration: 163.088296ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:19:49.141223Z","caller":"traceutil/trace.go:171","msg":"trace[248462223] transaction","detail":"{read_only:false; response_revision:1446; number_of_response:1; }","duration":"102.144379ms","start":"2026-04-21T19:19:49.03905Z","end":"2026-04-21T19:19:49.141195Z","steps":["trace[248462223] 'process raft request' (duration: 101.980075ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:19:49.168266Z","caller":"traceutil/trace.go:171","msg":"trace[1517321219] transaction","detail":"{read_only:false; response_revision:1447; number_of_response:1; }","duration":"120.108711ms","start":"2026-04-21T19:19:49.048126Z","end":"2026-04-21T19:19:49.168234Z","steps":["trace[1517321219] 'process raft request' (duration: 119.911465ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:19:49.340038Z","caller":"traceutil/trace.go:171","msg":"trace[1633296903] transaction","detail":"{read_only:false; response_revision:1451; number_of_response:1; }","duration":"112.105055ms","start":"2026-04-21T19:19:49.227894Z","end":"2026-04-21T19:19:49.339999Z","steps":["trace[1633296903] 'process raft request' (duration: 111.966542ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:19:50.24875Z","caller":"traceutil/trace.go:171","msg":"trace[462839601] linearizableReadLoop","detail":"{readStateIndex:1503; appliedIndex:1502; }","duration":"127.929651ms","start":"2026-04-21T19:19:50.120788Z","end":"2026-04-21T19:19:50.248718Z","steps":["trace[462839601] 'read index received' (duration: 72.230278ms)","trace[462839601] 'applied index is now lower than readState.Index' (duration: 55.695543ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:19:50.24884Z","caller":"traceutil/trace.go:171","msg":"trace[613190171] transaction","detail":"{read_only:false; response_revision:1453; number_of_response:1; }","duration":"129.687017ms","start":"2026-04-21T19:19:50.119105Z","end":"2026-04-21T19:19:50.248792Z","steps":["trace[613190171] 'process raft request' (duration: 73.983093ms)","trace[613190171] 'compare' (duration: 55.414077ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:19:50.249294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.467784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/cert-manager/cert-manager-startupapicheck-pg2xn.18a8756351c77484\" ","response":"range_response_count:1 size:791"} {"level":"info","ts":"2026-04-21T19:19:50.249353Z","caller":"traceutil/trace.go:171","msg":"trace[21599950] range","detail":"{range_begin:/registry/events/cert-manager/cert-manager-startupapicheck-pg2xn.18a8756351c77484; range_end:; response_count:1; response_revision:1453; }","duration":"128.572228ms","start":"2026-04-21T19:19:50.120765Z","end":"2026-04-21T19:19:50.249337Z","steps":["trace[21599950] 'agreement among raft nodes before linearized reading' (duration: 128.079885ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:19:50.965588Z","caller":"traceutil/trace.go:171","msg":"trace[2005889357] linearizableReadLoop","detail":"{readStateIndex:1506; appliedIndex:1505; }","duration":"129.880992ms","start":"2026-04-21T19:19:50.835667Z","end":"2026-04-21T19:19:50.965548Z","steps":["trace[2005889357] 'read index received' (duration: 116.497408ms)","trace[2005889357] 'applied index is now lower than readState.Index' (duration: 13.382174ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:19:50.965881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.174839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T19:19:50.965933Z","caller":"traceutil/trace.go:171","msg":"trace[252463901] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1456; }","duration":"130.279541ms","start":"2026-04-21T19:19:50.835639Z","end":"2026-04-21T19:19:50.965919Z","steps":["trace[252463901] 'agreement among raft nodes before linearized reading' (duration: 130.045905ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:19:50.965688Z","caller":"traceutil/trace.go:171","msg":"trace[1492838462] transaction","detail":"{read_only:false; response_revision:1456; number_of_response:1; }","duration":"150.254496ms","start":"2026-04-21T19:19:50.815372Z","end":"2026-04-21T19:19:50.965627Z","steps":["trace[1492838462] 'process raft request' (duration: 136.888022ms)","trace[1492838462] 'compare' (duration: 13.105557ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:19:51.214731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.152407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/cert-manager/cert-manager-webhook-548949fc64-79crd.18a8756315c43fd8\" ","response":"range_response_count:1 size:862"} {"level":"info","ts":"2026-04-21T19:19:51.214825Z","caller":"traceutil/trace.go:171","msg":"trace[5620143] range","detail":"{range_begin:/registry/events/cert-manager/cert-manager-webhook-548949fc64-79crd.18a8756315c43fd8; range_end:; response_count:1; response_revision:1457; }","duration":"102.298311ms","start":"2026-04-21T19:19:51.112502Z","end":"2026-04-21T19:19:51.2148Z","steps":["trace[5620143] 'range keys from in-memory index tree' (duration: 101.83943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:19:57.534905Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991528253552223085,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-21T19:19:57.542805Z","caller":"traceutil/trace.go:171","msg":"trace[2031403209] transaction","detail":"{read_only:false; response_revision:1478; number_of_response:1; }","duration":"531.34235ms","start":"2026-04-21T19:19:57.011439Z","end":"2026-04-21T19:19:57.542781Z","steps":["trace[2031403209] 'process raft request' (duration: 531.159326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:19:57.542957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:19:57.011413Z","time spent":"531.451312ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:19:57.580289Z","caller":"traceutil/trace.go:171","msg":"trace[1539631081] linearizableReadLoop","detail":"{readStateIndex:1530; appliedIndex:1528; }","duration":"546.362749ms","start":"2026-04-21T19:19:57.033901Z","end":"2026-04-21T19:19:57.580264Z","steps":["trace[1539631081] 'read index received' (duration: 508.696188ms)","trace[1539631081] 'applied index is now lower than readState.Index' (duration: 37.665171ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:19:57.580391Z","caller":"traceutil/trace.go:171","msg":"trace[43312234] transaction","detail":"{read_only:false; response_revision:1479; number_of_response:1; }","duration":"338.571446ms","start":"2026-04-21T19:19:57.241785Z","end":"2026-04-21T19:19:57.580356Z","steps":["trace[43312234] 'process raft request' (duration: 338.344271ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:19:57.580565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:19:57.241752Z","time spent":"338.719681ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:19:57.580634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.727209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-21T19:19:57.58067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.551707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/local-path-storage/local-path-provisioner-679c578f5-cs2p9.18a87561d0cd685e\" ","response":"range_response_count:1 size:877"} {"level":"info","ts":"2026-04-21T19:19:57.580697Z","caller":"traceutil/trace.go:171","msg":"trace[1510033599] range","detail":"{range_begin:/registry/events/local-path-storage/local-path-provisioner-679c578f5-cs2p9.18a87561d0cd685e; range_end:; response_count:1; response_revision:1479; }","duration":"469.627339ms","start":"2026-04-21T19:19:57.111063Z","end":"2026-04-21T19:19:57.58069Z","steps":["trace[1510033599] 'agreement among raft nodes before linearized reading' (duration: 469.500906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:19:57.580744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:19:57.111043Z","time spent":"469.693831ms","remote":"127.0.0.1:47316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":900,"request content":"key:\"/registry/events/local-path-storage/local-path-provisioner-679c578f5-cs2p9.18a87561d0cd685e\" "} {"level":"info","ts":"2026-04-21T19:19:57.580691Z","caller":"traceutil/trace.go:171","msg":"trace[437413732] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1479; }","duration":"546.866401ms","start":"2026-04-21T19:19:57.03381Z","end":"2026-04-21T19:19:57.580676Z","steps":["trace[437413732] 'agreement among raft nodes before linearized reading' (duration: 546.670416ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:19:57.580909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:19:57.033775Z","time spent":"547.115879ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-21T19:19:57.581051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.270321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-21T19:19:57.580969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.044425ms","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-21T19:19:57.581165Z","caller":"traceutil/trace.go:171","msg":"trace[1610552327] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1479; }","duration":"285.608899ms","start":"2026-04-21T19:19:57.295525Z","end":"2026-04-21T19:19:57.581134Z","steps":["trace[1610552327] 'agreement among raft nodes before linearized reading' (duration: 285.084735ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:19:57.581383Z","caller":"traceutil/trace.go:171","msg":"trace[2038419339] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1479; }","duration":"105.494276ms","start":"2026-04-21T19:19:57.475825Z","end":"2026-04-21T19:19:57.581319Z","steps":["trace[2038419339] 'agreement among raft nodes before linearized reading' (duration: 104.783718ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:19:58.382708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.65792ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:19:58.382807Z","caller":"traceutil/trace.go:171","msg":"trace[827984523] transaction","detail":"{read_only:false; response_revision:1480; number_of_response:1; }","duration":"799.401296ms","start":"2026-04-21T19:19:57.583389Z","end":"2026-04-21T19:19:58.38279Z","steps":["trace[827984523] 'process raft request' (duration: 295.579071ms)","trace[827984523] 'compare' (duration: 503.542508ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:19:58.382897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:19:57.583349Z","time spent":"799.522219ms","remote":"127.0.0.1:47316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":862,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:19:58.383211Z","caller":"traceutil/trace.go:171","msg":"trace[1081839573] transaction","detail":"{read_only:false; response_revision:1481; number_of_response:1; }","duration":"797.477087ms","start":"2026-04-21T19:19:57.585711Z","end":"2026-04-21T19:19:58.383188Z","steps":["trace[1081839573] 'process raft request' (duration: 797.305592ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:19:58.383359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:19:57.585683Z","time spent":"797.60222ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:19:58.383505Z","caller":"traceutil/trace.go:171","msg":"trace[987791645] transaction","detail":"{read_only:false; response_revision:1482; number_of_response:1; }","duration":"797.746453ms","start":"2026-04-21T19:19:57.585715Z","end":"2026-04-21T19:19:58.383461Z","steps":["trace[987791645] 'process raft request' (duration: 797.422455ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:19:58.383564Z","caller":"traceutil/trace.go:171","msg":"trace[160540517] linearizableReadLoop","detail":"{readStateIndex:1534; appliedIndex:1530; }","duration":"727.790845ms","start":"2026-04-21T19:19:57.655741Z","end":"2026-04-21T19:19:58.383532Z","steps":["trace[160540517] 'read index received' (duration: 223.326765ms)","trace[160540517] 'applied index is now lower than readState.Index' (duration: 504.46279ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:19:58.383732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.968659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:19:58.383773Z","caller":"traceutil/trace.go:171","msg":"trace[1865104297] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1483; }","duration":"728.068722ms","start":"2026-04-21T19:19:57.655692Z","end":"2026-04-21T19:19:58.383761Z","steps":["trace[1865104297] 'agreement among raft nodes before linearized reading' (duration: 727.967439ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:19:58.383813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:19:57.655668Z","time spent":"728.137604ms","remote":"127.0.0.1:47204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-21T19:19:58.383798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:19:57.585672Z","time spent":"797.945538ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:19:58.383842Z","caller":"traceutil/trace.go:171","msg":"trace[4206252] transaction","detail":"{read_only:false; response_revision:1483; number_of_response:1; }","duration":"797.940448ms","start":"2026-04-21T19:19:57.585885Z","end":"2026-04-21T19:19:58.383825Z","steps":["trace[4206252] 'process raft request' (duration: 797.494317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:19:58.383913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:19:57.585862Z","time spent":"798.01652ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:19:59.834611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.255906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:19:59.83477Z","caller":"traceutil/trace.go:171","msg":"trace[776860906] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1491; }","duration":"178.475431ms","start":"2026-04-21T19:19:59.656274Z","end":"2026-04-21T19:19:59.834749Z","steps":["trace[776860906] 'range keys from in-memory index tree' (duration: 178.144583ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:20:08.623657Z","caller":"traceutil/trace.go:171","msg":"trace[383372443] linearizableReadLoop","detail":"{readStateIndex:1580; appliedIndex:1578; }","duration":"160.481126ms","start":"2026-04-21T19:20:08.463143Z","end":"2026-04-21T19:20:08.623624Z","steps":["trace[383372443] 'read index received' (duration: 19.306588ms)","trace[383372443] 'applied index is now lower than readState.Index' (duration: 141.172868ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:20:08.623777Z","caller":"traceutil/trace.go:171","msg":"trace[1816149695] transaction","detail":"{read_only:false; response_revision:1527; number_of_response:1; }","duration":"164.827695ms","start":"2026-04-21T19:20:08.458907Z","end":"2026-04-21T19:20:08.623735Z","steps":["trace[1816149695] 'process raft request' (duration: 154.847723ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:20:08.624025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.846906ms","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-21T19:20:08.624181Z","caller":"traceutil/trace.go:171","msg":"trace[25305571] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1527; }","duration":"161.045371ms","start":"2026-04-21T19:20:08.463085Z","end":"2026-04-21T19:20:08.62413Z","steps":["trace[25305571] 'agreement among raft nodes before linearized reading' (duration: 160.66616ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:20:09.235995Z","caller":"traceutil/trace.go:171","msg":"trace[1383522460] transaction","detail":"{read_only:false; response_revision:1530; number_of_response:1; }","duration":"130.063687ms","start":"2026-04-21T19:20:09.105892Z","end":"2026-04-21T19:20:09.235955Z","steps":["trace[1383522460] 'process raft request' (duration: 115.268573ms)","trace[1383522460] 'compare' (duration: 14.593089ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:20:09.661337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.870893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:20:09.661344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.258034ms","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-21T19:20:09.661447Z","caller":"traceutil/trace.go:171","msg":"trace[1613990743] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1530; }","duration":"282.404288ms","start":"2026-04-21T19:20:09.379025Z","end":"2026-04-21T19:20:09.661429Z","steps":["trace[1613990743] 'count revisions from in-memory index tree' (duration: 282.203633ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:20:09.661451Z","caller":"traceutil/trace.go:171","msg":"trace[406608694] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1530; }","duration":"291.055177ms","start":"2026-04-21T19:20:09.370366Z","end":"2026-04-21T19:20:09.661421Z","steps":["trace[406608694] 'count revisions from in-memory index tree' (duration: 290.7696ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:20:09.897543Z","caller":"traceutil/trace.go:171","msg":"trace[388616150] transaction","detail":"{read_only:false; response_revision:1532; number_of_response:1; }","duration":"190.088265ms","start":"2026-04-21T19:20:09.707424Z","end":"2026-04-21T19:20:09.897512Z","steps":["trace[388616150] 'process raft request' (duration: 122.873136ms)","trace[388616150] 'compare' (duration: 67.077706ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:20:13.844257Z","caller":"traceutil/trace.go:171","msg":"trace[2066444054] transaction","detail":"{read_only:false; response_revision:1553; number_of_response:1; }","duration":"106.926472ms","start":"2026-04-21T19:20:13.737309Z","end":"2026-04-21T19:20:13.844236Z","steps":["trace[2066444054] 'process raft request' (duration: 106.806149ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:20:14.90736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.95455ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:20:14.907501Z","caller":"traceutil/trace.go:171","msg":"trace[1691094024] linearizableReadLoop","detail":"{readStateIndex:1611; appliedIndex:1610; }","duration":"252.506403ms","start":"2026-04-21T19:20:14.654974Z","end":"2026-04-21T19:20:14.90748Z","steps":["trace[1691094024] 'read index received' (duration: 30.257385ms)","trace[1691094024] 'applied index is now lower than readState.Index' (duration: 222.246778ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:20:14.907581Z","caller":"traceutil/trace.go:171","msg":"trace[1355892856] transaction","detail":"{read_only:false; response_revision:1556; number_of_response:1; }","duration":"258.550766ms","start":"2026-04-21T19:20:14.648993Z","end":"2026-04-21T19:20:14.907544Z","steps":["trace[1355892856] 'process raft request' (duration: 36.310838ms)","trace[1355892856] 'compare' (duration: 221.718024ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:20:14.909111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.923725ms","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":"warn","ts":"2026-04-21T19:20:14.909097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.109183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:20:14.909197Z","caller":"traceutil/trace.go:171","msg":"trace[487701556] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1556; }","duration":"208.019537ms","start":"2026-04-21T19:20:14.701145Z","end":"2026-04-21T19:20:14.909165Z","steps":["trace[487701556] 'agreement among raft nodes before linearized reading' (duration: 207.812072ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:20:14.909232Z","caller":"traceutil/trace.go:171","msg":"trace[1595453196] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1556; }","duration":"254.294717ms","start":"2026-04-21T19:20:14.654906Z","end":"2026-04-21T19:20:14.909201Z","steps":["trace[1595453196] 'agreement among raft nodes before linearized reading' (duration: 252.690307ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:20:15.209553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.099779ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:20:15.209685Z","caller":"traceutil/trace.go:171","msg":"trace[835579333] linearizableReadLoop","detail":"{readStateIndex:1612; appliedIndex:1611; }","duration":"118.078644ms","start":"2026-04-21T19:20:15.091587Z","end":"2026-04-21T19:20:15.209666Z","steps":["trace[835579333] 'read index received' (duration: 62.931µs)","trace[835579333] 'applied index is now lower than readState.Index' (duration: 118.014413ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:20:15.209757Z","caller":"traceutil/trace.go:171","msg":"trace[1622397729] transaction","detail":"{read_only:false; response_revision:1557; number_of_response:1; }","duration":"296.849032ms","start":"2026-04-21T19:20:14.912872Z","end":"2026-04-21T19:20:15.209721Z","steps":["trace[1622397729] 'process raft request' (duration: 145.488687ms)","trace[1622397729] 'compare' (duration: 150.954295ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:20:15.209889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.303501ms","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-21T19:20:15.209947Z","caller":"traceutil/trace.go:171","msg":"trace[1247376973] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1557; }","duration":"118.412463ms","start":"2026-04-21T19:20:15.091519Z","end":"2026-04-21T19:20:15.209931Z","steps":["trace[1247376973] 'agreement among raft nodes before linearized reading' (duration: 118.225178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:20:17.782108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.982279ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:20:17.782295Z","caller":"traceutil/trace.go:171","msg":"trace[886596312] linearizableReadLoop","detail":"{readStateIndex:1623; appliedIndex:1622; }","duration":"126.682092ms","start":"2026-04-21T19:20:17.655587Z","end":"2026-04-21T19:20:17.782269Z","steps":["trace[886596312] 'read index received' (duration: 37.491µs)","trace[886596312] 'applied index is now lower than readState.Index' (duration: 126.642201ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:20:17.782312Z","caller":"traceutil/trace.go:171","msg":"trace[2104295031] transaction","detail":"{read_only:false; response_revision:1568; number_of_response:1; }","duration":"473.353714ms","start":"2026-04-21T19:20:17.308924Z","end":"2026-04-21T19:20:17.782278Z","steps":["trace[2104295031] 'process raft request' (duration: 327.070707ms)","trace[2104295031] 'compare' (duration: 145.808865ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:20:17.782389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.806354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:20:17.782399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:20:17.308873Z","time spent":"473.486687ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:20:17.782438Z","caller":"traceutil/trace.go:171","msg":"trace[1541276411] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1568; }","duration":"126.898267ms","start":"2026-04-21T19:20:17.655524Z","end":"2026-04-21T19:20:17.782422Z","steps":["trace[1541276411] 'agreement among raft nodes before linearized reading' (duration: 126.816815ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:20:18.086056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.854987ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:20:18.08623Z","caller":"traceutil/trace.go:171","msg":"trace[1871555023] transaction","detail":"{read_only:false; response_revision:1569; number_of_response:1; }","duration":"225.282183ms","start":"2026-04-21T19:20:17.860925Z","end":"2026-04-21T19:20:18.086208Z","steps":["trace[1871555023] 'process raft request' (duration: 22.17224ms)","trace[1871555023] 'compare' (duration: 202.660582ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:20:18.172164Z","caller":"traceutil/trace.go:171","msg":"trace[2145276562] transaction","detail":"{read_only:false; response_revision:1570; number_of_response:1; }","duration":"156.129046ms","start":"2026-04-21T19:20:18.016Z","end":"2026-04-21T19:20:18.172129Z","steps":["trace[2145276562] 'process raft request' (duration: 155.990633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:20:18.400517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.362573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:20:18.400644Z","caller":"traceutil/trace.go:171","msg":"trace[1440061307] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1570; }","duration":"198.555839ms","start":"2026-04-21T19:20:18.202059Z","end":"2026-04-21T19:20:18.400614Z","steps":["trace[1440061307] 'count revisions from in-memory index tree' (duration: 198.141667ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:20:19.407019Z","caller":"traceutil/trace.go:171","msg":"trace[2087506103] transaction","detail":"{read_only:false; response_revision:1576; number_of_response:1; }","duration":"122.071995ms","start":"2026-04-21T19:20:19.284907Z","end":"2026-04-21T19:20:19.406979Z","steps":["trace[2087506103] 'process raft request' (duration: 31.899956ms)","trace[2087506103] 'compare' (duration: 90.014165ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:20:23.297419Z","caller":"traceutil/trace.go:171","msg":"trace[486020388] transaction","detail":"{read_only:false; response_revision:1589; number_of_response:1; }","duration":"110.511802ms","start":"2026-04-21T19:20:23.186871Z","end":"2026-04-21T19:20:23.297383Z","steps":["trace[486020388] 'process raft request' (duration: 110.301517ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:20:23.331592Z","caller":"traceutil/trace.go:171","msg":"trace[310578429] transaction","detail":"{read_only:false; response_revision:1590; number_of_response:1; }","duration":"139.812534ms","start":"2026-04-21T19:20:23.191743Z","end":"2026-04-21T19:20:23.331556Z","steps":["trace[310578429] 'process raft request' (duration: 139.66599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:20:23.513577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.382408ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-04-21T19:20:24.285519Z","caller":"traceutil/trace.go:171","msg":"trace[2063678618] transaction","detail":"{read_only:false; response_revision:1595; number_of_response:1; }","duration":"169.534004ms","start":"2026-04-21T19:20:24.115957Z","end":"2026-04-21T19:20:24.285491Z","steps":["trace[2063678618] 'process raft request' (duration: 168.431156ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:20:24.285904Z","caller":"traceutil/trace.go:171","msg":"trace[1890177731] transaction","detail":"{read_only:false; response_revision:1596; number_of_response:1; }","duration":"167.910354ms","start":"2026-04-21T19:20:24.117959Z","end":"2026-04-21T19:20:24.28587Z","steps":["trace[1890177731] 'process raft request' (duration: 167.468673ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:20:24.286031Z","caller":"traceutil/trace.go:171","msg":"trace[326000761] transaction","detail":"{read_only:false; response_revision:1597; number_of_response:1; }","duration":"136.321345ms","start":"2026-04-21T19:20:24.149685Z","end":"2026-04-21T19:20:24.286007Z","steps":["trace[326000761] 'process raft request' (duration: 136.049578ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:20:26.214465Z","caller":"traceutil/trace.go:171","msg":"trace[2126571331] transaction","detail":"{read_only:false; response_revision:1604; number_of_response:1; }","duration":"101.060575ms","start":"2026-04-21T19:20:26.113381Z","end":"2026-04-21T19:20:26.214442Z","steps":["trace[2126571331] 'process raft request' (duration: 100.850999ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:20:26.322501Z","caller":"traceutil/trace.go:171","msg":"trace[766808180] linearizableReadLoop","detail":"{readStateIndex:1663; appliedIndex:1662; }","duration":"104.358298ms","start":"2026-04-21T19:20:26.218113Z","end":"2026-04-21T19:20:26.322472Z","steps":["trace[766808180] 'read index received' (duration: 79.707175ms)","trace[766808180] 'applied index is now lower than readState.Index' (duration: 24.646292ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:20:26.322797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.653635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/local-path-storage/local-path-provisioner-679c578f5-cs2p9.18a87561e9c47a64\" ","response":"range_response_count:1 size:814"} {"level":"info","ts":"2026-04-21T19:20:26.322556Z","caller":"traceutil/trace.go:171","msg":"trace[657059135] transaction","detail":"{read_only:false; response_revision:1605; number_of_response:1; }","duration":"205.495914ms","start":"2026-04-21T19:20:26.117032Z","end":"2026-04-21T19:20:26.322528Z","steps":["trace[657059135] 'process raft request' (duration: 180.7807ms)","trace[657059135] 'compare' (duration: 24.504429ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:20:26.322867Z","caller":"traceutil/trace.go:171","msg":"trace[583579410] range","detail":"{range_begin:/registry/events/local-path-storage/local-path-provisioner-679c578f5-cs2p9.18a87561e9c47a64; range_end:; response_count:1; response_revision:1605; }","duration":"104.786328ms","start":"2026-04-21T19:20:26.218062Z","end":"2026-04-21T19:20:26.322848Z","steps":["trace[583579410] 'agreement among raft nodes before linearized reading' (duration: 104.522131ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:20:26.924129Z","caller":"traceutil/trace.go:171","msg":"trace[1521680444] transaction","detail":"{read_only:false; response_revision:1610; number_of_response:1; }","duration":"192.856915ms","start":"2026-04-21T19:20:26.731242Z","end":"2026-04-21T19:20:26.924099Z","steps":["trace[1521680444] 'process raft request' (duration: 192.66374ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:20:34.31199Z","caller":"traceutil/trace.go:171","msg":"trace[1824337637] linearizableReadLoop","detail":"{readStateIndex:1700; appliedIndex:1699; }","duration":"137.121716ms","start":"2026-04-21T19:20:34.17483Z","end":"2026-04-21T19:20:34.311951Z","steps":["trace[1824337637] 'read index received' (duration: 81.780238ms)","trace[1824337637] 'applied index is now lower than readState.Index' (duration: 55.339738ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:20:34.312162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.338151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:20:34.312149Z","caller":"traceutil/trace.go:171","msg":"trace[1060900379] transaction","detail":"{read_only:false; response_revision:1640; number_of_response:1; }","duration":"192.172887ms","start":"2026-04-21T19:20:34.119922Z","end":"2026-04-21T19:20:34.312095Z","steps":["trace[1060900379] 'process raft request' (duration: 136.789528ms)","trace[1060900379] 'compare' (duration: 55.072611ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:20:34.31221Z","caller":"traceutil/trace.go:171","msg":"trace[573131817] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1640; }","duration":"137.460664ms","start":"2026-04-21T19:20:34.174736Z","end":"2026-04-21T19:20:34.312196Z","steps":["trace[573131817] 'agreement among raft nodes before linearized reading' (duration: 137.345651ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:20:34.494185Z","caller":"traceutil/trace.go:171","msg":"trace[1572967069] transaction","detail":"{read_only:false; response_revision:1641; number_of_response:1; }","duration":"111.867678ms","start":"2026-04-21T19:20:34.382259Z","end":"2026-04-21T19:20:34.494127Z","steps":["trace[1572967069] 'process raft request' (duration: 36.693908ms)","trace[1572967069] 'compare' (duration: 75.031916ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:20:34.727309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.49854ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:20:34.727467Z","caller":"traceutil/trace.go:171","msg":"trace[617423736] transaction","detail":"{read_only:false; response_revision:1642; number_of_response:1; }","duration":"200.118628ms","start":"2026-04-21T19:20:34.527321Z","end":"2026-04-21T19:20:34.72744Z","steps":["trace[617423736] 'process raft request' (duration: 84.393972ms)","trace[617423736] 'compare' (duration: 115.341246ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:20:35.290895Z","caller":"traceutil/trace.go:171","msg":"trace[1421047907] transaction","detail":"{read_only:false; response_revision:1645; number_of_response:1; }","duration":"163.313368ms","start":"2026-04-21T19:20:35.127543Z","end":"2026-04-21T19:20:35.290857Z","steps":["trace[1421047907] 'process raft request' (duration: 103.387103ms)","trace[1421047907] 'compare' (duration: 59.71002ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:20:35.291191Z","caller":"traceutil/trace.go:171","msg":"trace[1773074163] transaction","detail":"{read_only:false; response_revision:1646; number_of_response:1; }","duration":"163.514242ms","start":"2026-04-21T19:20:35.127642Z","end":"2026-04-21T19:20:35.291156Z","steps":["trace[1773074163] 'process raft request' (duration: 163.141673ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:20:42.645203Z","caller":"traceutil/trace.go:171","msg":"trace[1636419904] transaction","detail":"{read_only:false; response_revision:1670; number_of_response:1; }","duration":"123.265555ms","start":"2026-04-21T19:20:42.521915Z","end":"2026-04-21T19:20:42.645181Z","steps":["trace[1636419904] 'process raft request' (duration: 123.119592ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:20:42.887743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.617071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-21T19:20:42.888318Z","caller":"traceutil/trace.go:171","msg":"trace[1328915551] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1670; }","duration":"127.307178ms","start":"2026-04-21T19:20:42.760983Z","end":"2026-04-21T19:20:42.88829Z","steps":["trace[1328915551] 'range keys from in-memory index tree' (duration: 126.392455ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:20:43.024627Z","caller":"traceutil/trace.go:171","msg":"trace[1945244747] transaction","detail":"{read_only:false; response_revision:1671; number_of_response:1; }","duration":"131.121813ms","start":"2026-04-21T19:20:42.893477Z","end":"2026-04-21T19:20:43.024598Z","steps":["trace[1945244747] 'process raft request' (duration: 130.959289ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:20:53.248203Z","caller":"traceutil/trace.go:171","msg":"trace[1247049089] transaction","detail":"{read_only:false; response_revision:1705; number_of_response:1; }","duration":"166.887088ms","start":"2026-04-21T19:20:53.081291Z","end":"2026-04-21T19:20:53.248178Z","steps":["trace[1247049089] 'process raft request' (duration: 166.717214ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:20:53.485289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.943363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.141\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-21T19:20:53.485444Z","caller":"traceutil/trace.go:171","msg":"trace[1522457315] range","detail":"{range_begin:/registry/masterleases/199.204.45.141; range_end:; response_count:1; response_revision:1706; }","duration":"122.158348ms","start":"2026-04-21T19:20:53.363264Z","end":"2026-04-21T19:20:53.485422Z","steps":["trace[1522457315] 'range keys from in-memory index tree' (duration: 121.735938ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:20:53.615918Z","caller":"traceutil/trace.go:171","msg":"trace[1415401104] transaction","detail":"{read_only:false; response_revision:1708; number_of_response:1; }","duration":"106.252725ms","start":"2026-04-21T19:20:53.509632Z","end":"2026-04-21T19:20:53.615885Z","steps":["trace[1415401104] 'process raft request' (duration: 79.692594ms)","trace[1415401104] 'compare' (duration: 26.421427ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:21:00.099858Z","caller":"traceutil/trace.go:171","msg":"trace[2084604261] linearizableReadLoop","detail":"{readStateIndex:1793; appliedIndex:1792; }","duration":"282.313273ms","start":"2026-04-21T19:20:59.817523Z","end":"2026-04-21T19:21:00.099836Z","steps":["trace[2084604261] 'read index received' (duration: 282.113348ms)","trace[2084604261] 'applied index is now lower than readState.Index' (duration: 199.095µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:21:00.099921Z","caller":"traceutil/trace.go:171","msg":"trace[1749777047] transaction","detail":"{read_only:false; response_revision:1728; number_of_response:1; }","duration":"307.861729ms","start":"2026-04-21T19:20:59.792033Z","end":"2026-04-21T19:21:00.099895Z","steps":["trace[1749777047] 'process raft request' (duration: 307.666904ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:21:00.09999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.449027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:21:00.100027Z","caller":"traceutil/trace.go:171","msg":"trace[1081538969] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1728; }","duration":"282.509638ms","start":"2026-04-21T19:20:59.817507Z","end":"2026-04-21T19:21:00.100017Z","steps":["trace[1081538969] 'agreement among raft nodes before linearized reading' (duration: 282.428686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:21:00.100052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:20:59.792016Z","time spent":"307.955001ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:23:56.484477Z","caller":"traceutil/trace.go:171","msg":"trace[989561350] transaction","detail":"{read_only:false; response_revision:2325; number_of_response:1; }","duration":"110.786136ms","start":"2026-04-21T19:23:56.373663Z","end":"2026-04-21T19:23:56.484449Z","steps":["trace[989561350] 'process raft request' (duration: 110.474368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:01.187116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.727684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-public\" ","response":"range_response_count:1 size:351"} {"level":"warn","ts":"2026-04-21T19:24:01.187138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.339704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-21T19:24:01.187187Z","caller":"traceutil/trace.go:171","msg":"trace[1225932490] range","detail":"{range_begin:/registry/namespaces/kube-public; range_end:; response_count:1; response_revision:2339; }","duration":"112.827687ms","start":"2026-04-21T19:24:01.074342Z","end":"2026-04-21T19:24:01.18717Z","steps":["trace[1225932490] 'range keys from in-memory index tree' (duration: 112.670343ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:24:01.187218Z","caller":"traceutil/trace.go:171","msg":"trace[806982937] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:2339; }","duration":"124.458136ms","start":"2026-04-21T19:24:01.062745Z","end":"2026-04-21T19:24:01.187203Z","steps":["trace[806982937] 'range keys from in-memory index tree' (duration: 124.21957ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:24:02.678731Z","caller":"traceutil/trace.go:171","msg":"trace[1568084197] transaction","detail":"{read_only:false; response_revision:2343; number_of_response:1; }","duration":"131.225914ms","start":"2026-04-21T19:24:02.547487Z","end":"2026-04-21T19:24:02.678713Z","steps":["trace[1568084197] 'process raft request' (duration: 131.121251ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:24:02.678744Z","caller":"traceutil/trace.go:171","msg":"trace[2438408] linearizableReadLoop","detail":"{readStateIndex:2445; appliedIndex:2445; }","duration":"115.448872ms","start":"2026-04-21T19:24:02.563267Z","end":"2026-04-21T19:24:02.678716Z","steps":["trace[2438408] 'read index received' (duration: 115.439322ms)","trace[2438408] 'applied index is now lower than readState.Index' (duration: 7.67µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:24:02.678978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.689578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-21T19:24:02.679053Z","caller":"traceutil/trace.go:171","msg":"trace[1315497659] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2343; }","duration":"115.785002ms","start":"2026-04-21T19:24:02.563252Z","end":"2026-04-21T19:24:02.679037Z","steps":["trace[1315497659] 'agreement among raft nodes before linearized reading' (duration: 115.587326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:03.050354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.195977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/\" range_end:\"/registry/pods/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:24:03.050446Z","caller":"traceutil/trace.go:171","msg":"trace[567352752] range","detail":"{range_begin:/registry/pods/default/; range_end:/registry/pods/default0; response_count:0; response_revision:2345; }","duration":"109.33763ms","start":"2026-04-21T19:24:02.941084Z","end":"2026-04-21T19:24:03.050422Z","steps":["trace[567352752] 'range keys from in-memory index tree' (duration: 109.118665ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:03.050568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.658083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/cert-manager/cert-manager-webhook\" ","response":"range_response_count:1 size:1084"} {"level":"info","ts":"2026-04-21T19:24:03.050644Z","caller":"traceutil/trace.go:171","msg":"trace[2128985087] range","detail":"{range_begin:/registry/services/endpoints/cert-manager/cert-manager-webhook; range_end:; response_count:1; response_revision:2345; }","duration":"157.786616ms","start":"2026-04-21T19:24:02.892841Z","end":"2026-04-21T19:24:03.050628Z","steps":["trace[2128985087] 'range keys from in-memory index tree' (duration: 157.447938ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:03.050616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.31484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/cert-manager/cert-manager\" ","response":"range_response_count:1 size:1095"} {"level":"info","ts":"2026-04-21T19:24:03.050709Z","caller":"traceutil/trace.go:171","msg":"trace[230326454] range","detail":"{range_begin:/registry/services/endpoints/cert-manager/cert-manager; range_end:; response_count:1; response_revision:2345; }","duration":"115.466333ms","start":"2026-04-21T19:24:02.93522Z","end":"2026-04-21T19:24:03.050686Z","steps":["trace[230326454] 'range keys from in-memory index tree' (duration: 115.112334ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:24:06.874741Z","caller":"traceutil/trace.go:171","msg":"trace[1518766110] linearizableReadLoop","detail":"{readStateIndex:2460; appliedIndex:2459; }","duration":"160.951154ms","start":"2026-04-21T19:24:06.71377Z","end":"2026-04-21T19:24:06.874721Z","steps":["trace[1518766110] 'read index received' (duration: 160.76922ms)","trace[1518766110] 'applied index is now lower than readState.Index' (duration: 180.904µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:24:06.874772Z","caller":"traceutil/trace.go:171","msg":"trace[1620060214] transaction","detail":"{read_only:false; response_revision:2357; number_of_response:1; }","duration":"181.050354ms","start":"2026-04-21T19:24:06.693698Z","end":"2026-04-21T19:24:06.874748Z","steps":["trace[1620060214] 'process raft request' (duration: 180.88504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:06.874958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.18125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-04-21T19:24:06.874995Z","caller":"traceutil/trace.go:171","msg":"trace[323751451] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway; range_end:; response_count:1; response_revision:2357; }","duration":"161.270872ms","start":"2026-04-21T19:24:06.713711Z","end":"2026-04-21T19:24:06.874982Z","steps":["trace[323751451] 'agreement among raft nodes before linearized reading' (duration: 161.138539ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:06.875217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.837982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-public/\" range_end:\"/registry/roles/kube-public0\" limit:500 ","response":"range_response_count:2 size:1073"} {"level":"warn","ts":"2026-04-21T19:24:06.875231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.507849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/default\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-04-21T19:24:06.875299Z","caller":"traceutil/trace.go:171","msg":"trace[238984463] range","detail":"{range_begin:/registry/roles/kube-public/; range_end:/registry/roles/kube-public0; response_count:2; response_revision:2357; }","duration":"156.936824ms","start":"2026-04-21T19:24:06.71834Z","end":"2026-04-21T19:24:06.875277Z","steps":["trace[238984463] 'agreement among raft nodes before linearized reading' (duration: 156.739009ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:24:06.875369Z","caller":"traceutil/trace.go:171","msg":"trace[353033370] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/default; range_end:; response_count:1; response_revision:2357; }","duration":"159.705294ms","start":"2026-04-21T19:24:06.715638Z","end":"2026-04-21T19:24:06.875343Z","steps":["trace[353033370] 'agreement among raft nodes before linearized reading' (duration: 159.312414ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:06.875272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.822576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-21T19:24:06.875433Z","caller":"traceutil/trace.go:171","msg":"trace[1713377121] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2357; }","duration":"109.022161ms","start":"2026-04-21T19:24:06.766387Z","end":"2026-04-21T19:24:06.875409Z","steps":["trace[1713377121] 'agreement among raft nodes before linearized reading' (duration: 108.638682ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:24:07.098513Z","caller":"traceutil/trace.go:171","msg":"trace[1802757966] linearizableReadLoop","detail":"{readStateIndex:2461; appliedIndex:2460; }","duration":"218.154998ms","start":"2026-04-21T19:24:06.880316Z","end":"2026-04-21T19:24:07.098471Z","steps":["trace[1802757966] 'read index received' (duration: 215.547083ms)","trace[1802757966] 'applied index is now lower than readState.Index' (duration: 2.605565ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:24:07.098542Z","caller":"traceutil/trace.go:171","msg":"trace[796618497] transaction","detail":"{read_only:false; response_revision:2358; number_of_response:1; }","duration":"218.835685ms","start":"2026-04-21T19:24:06.879679Z","end":"2026-04-21T19:24:07.098515Z","steps":["trace[796618497] 'process raft request' (duration: 216.098457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:07.098807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.466896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/default\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-04-21T19:24:07.098868Z","caller":"traceutil/trace.go:171","msg":"trace[10052503] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/default; range_end:; response_count:1; response_revision:2358; }","duration":"218.548748ms","start":"2026-04-21T19:24:06.880302Z","end":"2026-04-21T19:24:07.09885Z","steps":["trace[10052503] 'agreement among raft nodes before linearized reading' (duration: 218.339392ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:07.333541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.697694ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:24:07.333661Z","caller":"traceutil/trace.go:171","msg":"trace[462283063] linearizableReadLoop","detail":"{readStateIndex:2462; appliedIndex:2461; }","duration":"235.039969ms","start":"2026-04-21T19:24:07.098601Z","end":"2026-04-21T19:24:07.333641Z","steps":["trace[462283063] 'read index received' (duration: 118.098729ms)","trace[462283063] 'applied index is now lower than readState.Index' (duration: 116.93983ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:24:07.333786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.616838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-public/\" range_end:\"/registry/secrets/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:24:07.333838Z","caller":"traceutil/trace.go:171","msg":"trace[610376808] transaction","detail":"{read_only:false; response_revision:2359; number_of_response:1; }","duration":"453.161976ms","start":"2026-04-21T19:24:06.88065Z","end":"2026-04-21T19:24:07.333812Z","steps":["trace[610376808] 'process raft request' (duration: 336.086453ms)","trace[610376808] 'compare' (duration: 116.570641ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:24:07.333869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.013942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-04-21T19:24:07.333924Z","caller":"traceutil/trace.go:171","msg":"trace[653630168] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway; range_end:; response_count:1; response_revision:2359; }","duration":"453.133935ms","start":"2026-04-21T19:24:06.880774Z","end":"2026-04-21T19:24:07.333908Z","steps":["trace[653630168] 'agreement among raft nodes before linearized reading' (duration: 452.962041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:07.333913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.420183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:24:07.333924Z","caller":"traceutil/trace.go:171","msg":"trace[1868751575] range","detail":"{range_begin:/registry/secrets/kube-public/; range_end:/registry/secrets/kube-public0; response_count:0; response_revision:2359; }","duration":"314.789282ms","start":"2026-04-21T19:24:07.019106Z","end":"2026-04-21T19:24:07.333895Z","steps":["trace[1868751575] 'agreement among raft nodes before linearized reading' (duration: 314.561556ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:07.333959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:24:06.880764Z","time spent":"453.186946ms","remote":"127.0.0.1:47420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":869,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" "} {"level":"info","ts":"2026-04-21T19:24:07.333979Z","caller":"traceutil/trace.go:171","msg":"trace[914884529] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:2359; }","duration":"396.544817ms","start":"2026-04-21T19:24:06.937414Z","end":"2026-04-21T19:24:07.333959Z","steps":["trace[914884529] 'agreement among raft nodes before linearized reading' (duration: 396.399163ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:07.333979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:24:06.880626Z","time spent":"453.285619ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:24:07.333987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:24:07.019096Z","time spent":"314.879094ms","remote":"127.0.0.1:47334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/kube-public/\" range_end:\"/registry/secrets/kube-public0\" limit:500 "} {"level":"warn","ts":"2026-04-21T19:24:07.334015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:24:06.937394Z","time spent":"396.612288ms","remote":"127.0.0.1:60522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-04-21T19:24:07.334044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.424655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/kube-system/\" range_end:\"/registry/services/specs/kube-system0\" limit:500 ","response":"range_response_count:1 size:1211"} {"level":"warn","ts":"2026-04-21T19:24:07.334127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.7376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:24:07.334211Z","caller":"traceutil/trace.go:171","msg":"trace[1786454590] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:2359; }","duration":"415.17366ms","start":"2026-04-21T19:24:06.919018Z","end":"2026-04-21T19:24:07.334192Z","steps":["trace[1786454590] 'agreement among raft nodes before linearized reading' (duration: 414.705589ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:24:07.334231Z","caller":"traceutil/trace.go:171","msg":"trace[789202175] range","detail":"{range_begin:/registry/services/specs/kube-system/; range_end:/registry/services/specs/kube-system0; response_count:1; response_revision:2359; }","duration":"220.612439ms","start":"2026-04-21T19:24:07.113541Z","end":"2026-04-21T19:24:07.334154Z","steps":["trace[789202175] 'agreement among raft nodes before linearized reading' (duration: 220.319002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:07.334258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:24:06.91901Z","time spent":"415.236462ms","remote":"127.0.0.1:48788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-04-21T19:24:07.334344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.047475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" limit:500 ","response":"range_response_count:5 size:1050260"} {"level":"info","ts":"2026-04-21T19:24:07.33447Z","caller":"traceutil/trace.go:171","msg":"trace[1615701477] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:2359; }","duration":"232.223048ms","start":"2026-04-21T19:24:07.102217Z","end":"2026-04-21T19:24:07.33444Z","steps":["trace[1615701477] 'agreement among raft nodes before linearized reading' (duration: 231.610793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:15.030773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.053781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:4 size:329952"} {"level":"info","ts":"2026-04-21T19:24:15.030854Z","caller":"traceutil/trace.go:171","msg":"trace[842594861] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:2383; }","duration":"106.168664ms","start":"2026-04-21T19:24:14.924669Z","end":"2026-04-21T19:24:15.030838Z","steps":["trace[842594861] 'range keys from in-memory index tree' (duration: 105.65864ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:17.784485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.80826ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:24:17.784593Z","caller":"traceutil/trace.go:171","msg":"trace[1949927572] linearizableReadLoop","detail":"{readStateIndex:2499; appliedIndex:2498; }","duration":"244.569612ms","start":"2026-04-21T19:24:17.540007Z","end":"2026-04-21T19:24:17.784576Z","steps":["trace[1949927572] 'read index received' (duration: 68.516525ms)","trace[1949927572] 'applied index is now lower than readState.Index' (duration: 176.051727ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:24:17.784659Z","caller":"traceutil/trace.go:171","msg":"trace[1544321821] transaction","detail":"{read_only:false; response_revision:2394; number_of_response:1; }","duration":"249.285217ms","start":"2026-04-21T19:24:17.53536Z","end":"2026-04-21T19:24:17.784645Z","steps":["trace[1544321821] 'process raft request' (duration: 73.23357ms)","trace[1544321821] 'compare' (duration: 175.690517ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:24:17.78483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.802078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T19:24:17.784927Z","caller":"traceutil/trace.go:171","msg":"trace[1216230069] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:2394; }","duration":"244.940842ms","start":"2026-04-21T19:24:17.539967Z","end":"2026-04-21T19:24:17.784908Z","steps":["trace[1216230069] 'agreement among raft nodes before linearized reading' (duration: 244.788328ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:17.819713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.85217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/local-path-storage/kube-root-ca.crt\" ","response":"range_response_count:1 size:1760"} {"level":"info","ts":"2026-04-21T19:24:17.819766Z","caller":"traceutil/trace.go:171","msg":"trace[928959803] range","detail":"{range_begin:/registry/configmaps/local-path-storage/kube-root-ca.crt; range_end:; response_count:1; response_revision:2395; }","duration":"243.926362ms","start":"2026-04-21T19:24:17.575827Z","end":"2026-04-21T19:24:17.819753Z","steps":["trace[928959803] 'agreement among raft nodes before linearized reading' (duration: 243.761588ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:17.819773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.77235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-public/default\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-04-21T19:24:17.819868Z","caller":"traceutil/trace.go:171","msg":"trace[1274180097] range","detail":"{range_begin:/registry/serviceaccounts/kube-public/default; range_end:; response_count:1; response_revision:2395; }","duration":"241.920805ms","start":"2026-04-21T19:24:17.577919Z","end":"2026-04-21T19:24:17.81984Z","steps":["trace[1274180097] 'agreement among raft nodes before linearized reading' (duration: 241.7418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:18.017073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.910641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/local-path-storage/local-path-config\" ","response":"range_response_count:1 size:1464"} {"level":"info","ts":"2026-04-21T19:24:18.017376Z","caller":"traceutil/trace.go:171","msg":"trace[1865000985] range","detail":"{range_begin:/registry/configmaps/local-path-storage/local-path-config; range_end:; response_count:1; response_revision:2395; }","duration":"103.236771ms","start":"2026-04-21T19:24:17.914116Z","end":"2026-04-21T19:24:18.017353Z","steps":["trace[1865000985] 'range keys from in-memory index tree' (duration: 102.773487ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:18.017374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.880256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:3735"} {"level":"info","ts":"2026-04-21T19:24:18.017554Z","caller":"traceutil/trace.go:171","msg":"trace[425064273] range","detail":"{range_begin:/registry/deployments/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:2395; }","duration":"106.061791ms","start":"2026-04-21T19:24:17.91141Z","end":"2026-04-21T19:24:18.017471Z","steps":["trace[425064273] 'range keys from in-memory index tree' (duration: 105.646619ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:24:23.065Z","caller":"traceutil/trace.go:171","msg":"trace[45386913] transaction","detail":"{read_only:false; response_revision:2410; number_of_response:1; }","duration":"116.582723ms","start":"2026-04-21T19:24:22.94839Z","end":"2026-04-21T19:24:23.064972Z","steps":["trace[45386913] 'process raft request' (duration: 116.303215ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:23.405817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.829905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:24:23.405831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.022609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-21T19:24:23.405946Z","caller":"traceutil/trace.go:171","msg":"trace[560498822] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:2410; }","duration":"286.986269ms","start":"2026-04-21T19:24:23.118918Z","end":"2026-04-21T19:24:23.405904Z","steps":["trace[560498822] 'count revisions from in-memory index tree' (duration: 286.68661ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:23.405973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.231398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rszwb\" ","response":"range_response_count:1 size:18525"} {"level":"info","ts":"2026-04-21T19:24:23.406067Z","caller":"traceutil/trace.go:171","msg":"trace[1460774052] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rszwb; range_end:; response_count:1; response_revision:2410; }","duration":"331.382812ms","start":"2026-04-21T19:24:23.074663Z","end":"2026-04-21T19:24:23.406046Z","steps":["trace[1460774052] 'range keys from in-memory index tree' (duration: 331.061833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:24:23.406117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:24:23.074647Z","time spent":"331.460835ms","remote":"127.0.0.1:47404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":18548,"request content":"key:\"/registry/pods/kube-system/cilium-rszwb\" "} {"level":"info","ts":"2026-04-21T19:24:23.406634Z","caller":"traceutil/trace.go:171","msg":"trace[1607851083] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2410; }","duration":"137.181764ms","start":"2026-04-21T19:24:23.268746Z","end":"2026-04-21T19:24:23.405928Z","steps":["trace[1607851083] 'range keys from in-memory index tree' (duration: 136.863625ms)"],"step_count":1}