{"level":"warn","ts":"2026-06-26T02:14:31.33757Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-26T02:14:31.33766Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.116: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.116:2380","--initial-cluster=instance=https://199.204.45.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.116: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-06-26T02:14:31.337725Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-26T02:14:31.337732Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-06-26T02:14:31.337747Z","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-06-26T02:14:31.338352Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"]} {"level":"info","ts":"2026-06-26T02:14:31.338426Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.116: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-06-26T02:14:31.348095Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"9.469216ms"} {"level":"info","ts":"2026-06-26T02:14:31.366858Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5caa70ef1dd6dc04","cluster-id":"45afccab143d2c82"} {"level":"info","ts":"2026-06-26T02:14:31.367093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=()"} {"level":"info","ts":"2026-06-26T02:14:31.367282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 0"} {"level":"info","ts":"2026-06-26T02:14:31.36734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5caa70ef1dd6dc04 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-26T02:14:31.367453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 1"} {"level":"info","ts":"2026-06-26T02:14:31.36757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"warn","ts":"2026-06-26T02:14:31.373661Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-26T02:14:31.375191Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-26T02:14:31.3784Z","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-06-26T02:14:31.38228Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5caa70ef1dd6dc04","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-26T02:14:31.382882Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5caa70ef1dd6dc04","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-26T02:14:31.382953Z","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-06-26T02:14:31.383116Z","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-06-26T02:14:31.383166Z","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-06-26T02:14:31.38742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"info","ts":"2026-06-26T02:14:31.387696Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","added-peer-id":"5caa70ef1dd6dc04","added-peer-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-06-26T02:14:31.390225Z","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-06-26T02:14:31.390348Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-06-26T02:14:31.390378Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-06-26T02:14:31.390518Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5caa70ef1dd6dc04","initial-advertise-peer-urls":["https://199.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-26T02:14:31.390581Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-26T02:14:32.268037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 is starting a new election at term 1"} {"level":"info","ts":"2026-06-26T02:14:32.268106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-26T02:14:32.268144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgPreVoteResp from 5caa70ef1dd6dc04 at term 1"} {"level":"info","ts":"2026-06-26T02:14:32.268165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became candidate at term 2"} {"level":"info","ts":"2026-06-26T02:14:32.268181Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgVoteResp from 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-06-26T02:14:32.268266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became leader at term 2"} {"level":"info","ts":"2026-06-26T02:14:32.268289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5caa70ef1dd6dc04 elected leader 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-06-26T02:14:32.269543Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:14:32.270697Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5caa70ef1dd6dc04","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.116:2379]}","request-path":"/0/members/5caa70ef1dd6dc04/attributes","cluster-id":"45afccab143d2c82","publish-timeout":"7s"} {"level":"info","ts":"2026-06-26T02:14:32.270703Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T02:14:32.270738Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T02:14:32.270983Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-26T02:14:32.271056Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-26T02:14:32.271283Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:14:32.271525Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:14:32.27158Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T02:14:32.272579Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-26T02:14:32.274804Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.116:2379"} {"level":"info","ts":"2026-06-26T02:14:40.538577Z","caller":"traceutil/trace.go:171","msg":"trace[1957169624] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"119.603423ms","start":"2026-06-26T02:14:40.418945Z","end":"2026-06-26T02:14:40.538548Z","steps":["trace[1957169624] 'process raft request' (duration: 119.404438ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:14:56.144154Z","caller":"traceutil/trace.go:171","msg":"trace[1136564670] linearizableReadLoop","detail":"{readStateIndex:433; appliedIndex:432; }","duration":"431.629988ms","start":"2026-06-26T02:14:55.712495Z","end":"2026-06-26T02:14:56.144125Z","steps":["trace[1136564670] 'read index received' (duration: 431.484123ms)","trace[1136564670] 'applied index is now lower than readState.Index' (duration: 144.605µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:14:56.14421Z","caller":"traceutil/trace.go:171","msg":"trace[1005308827] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"588.625954ms","start":"2026-06-26T02:14:55.555548Z","end":"2026-06-26T02:14:56.144173Z","steps":["trace[1005308827] 'process raft request' (duration: 588.422108ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:14:56.144322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.806103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:14:56.144415Z","caller":"traceutil/trace.go:171","msg":"trace[112164079] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:420; }","duration":"431.940725ms","start":"2026-06-26T02:14:55.71246Z","end":"2026-06-26T02:14:56.1444Z","steps":["trace[112164079] 'agreement among raft nodes before linearized reading' (duration: 431.781032ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:14:56.144447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:14:55.712444Z","time spent":"431.997797ms","remote":"127.0.0.1:53424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:14:56.144491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.326602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-26T02:14:56.144612Z","caller":"traceutil/trace.go:171","msg":"trace[1804078389] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:420; }","duration":"374.470936ms","start":"2026-06-26T02:14:55.770069Z","end":"2026-06-26T02:14:56.14454Z","steps":["trace[1804078389] 'agreement among raft nodes before linearized reading' (duration: 374.307982ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:14:56.144675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:14:55.770049Z","time spent":"374.593068ms","remote":"127.0.0.1:53766","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-06-26T02:14:56.144833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:14:55.555532Z","time spent":"588.763157ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:14:56.484255Z","caller":"traceutil/trace.go:171","msg":"trace[2101357281] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"336.126042ms","start":"2026-06-26T02:14:56.148106Z","end":"2026-06-26T02:14:56.484232Z","steps":["trace[2101357281] 'process raft request' (duration: 335.989809ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:14:56.484427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:14:56.148083Z","time spent":"336.253435ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:15:08.047589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.59722ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:15:08.047698Z","caller":"traceutil/trace.go:171","msg":"trace[913400943] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"861.592714ms","start":"2026-06-26T02:15:07.186088Z","end":"2026-06-26T02:15:08.047681Z","steps":["trace[913400943] 'process raft request' (duration: 371.704177ms)","trace[913400943] 'compare' (duration: 489.349294ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:15:08.047751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:07.186073Z","time spent":"861.656465ms","remote":"127.0.0.1:54014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:15:08.064507Z","caller":"traceutil/trace.go:171","msg":"trace[1054957730] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"873.300135ms","start":"2026-06-26T02:15:07.191182Z","end":"2026-06-26T02:15:08.064482Z","steps":["trace[1054957730] 'process raft request' (duration: 873.172582ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:08.064626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:07.191151Z","time spent":"873.417138ms","remote":"127.0.0.1:53510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:15:08.064617Z","caller":"traceutil/trace.go:171","msg":"trace[737278489] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"870.982217ms","start":"2026-06-26T02:15:07.193604Z","end":"2026-06-26T02:15:08.064587Z","steps":["trace[737278489] 'process raft request' (duration: 870.815523ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:15:08.064689Z","caller":"traceutil/trace.go:171","msg":"trace[1240803971] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"878.35049ms","start":"2026-06-26T02:15:07.186317Z","end":"2026-06-26T02:15:08.064667Z","steps":["trace[1240803971] 'process raft request' (duration: 877.91711ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:08.064762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:07.19359Z","time spent":"871.11285ms","remote":"127.0.0.1:54014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T02:15:08.064773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:07.186307Z","time spent":"878.422273ms","remote":"127.0.0.1:54014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:15:08.064911Z","caller":"traceutil/trace.go:171","msg":"trace[841310996] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"867.995843ms","start":"2026-06-26T02:15:07.196902Z","end":"2026-06-26T02:15:08.064898Z","steps":["trace[841310996] 'process raft request' (duration: 867.562072ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:08.064982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:07.196867Z","time spent":"868.077905ms","remote":"127.0.0.1:53510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:15:08.065178Z","caller":"traceutil/trace.go:171","msg":"trace[1876841706] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"864.269211ms","start":"2026-06-26T02:15:07.200819Z","end":"2026-06-26T02:15:08.065088Z","steps":["trace[1876841706] 'process raft request' (duration: 863.863461ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:15:08.065263Z","caller":"traceutil/trace.go:171","msg":"trace[87457680] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"864.307621ms","start":"2026-06-26T02:15:07.200938Z","end":"2026-06-26T02:15:08.065245Z","steps":["trace[87457680] 'process raft request' (duration: 863.798489ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:08.065338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:07.200932Z","time spent":"864.371893ms","remote":"127.0.0.1:54014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T02:15:08.065336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:07.200802Z","time spent":"864.451415ms","remote":"127.0.0.1:53510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:15:08.067492Z","caller":"traceutil/trace.go:171","msg":"trace[708166943] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"191.511025ms","start":"2026-06-26T02:15:07.875963Z","end":"2026-06-26T02:15:08.067474Z","steps":["trace[708166943] 'process raft request' (duration: 191.444213ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:15:08.067575Z","caller":"traceutil/trace.go:171","msg":"trace[1216886955] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"863.808679ms","start":"2026-06-26T02:15:07.203747Z","end":"2026-06-26T02:15:08.067555Z","steps":["trace[1216886955] 'process raft request' (duration: 863.43077ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:08.067661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:07.203738Z","time spent":"863.876992ms","remote":"127.0.0.1:53510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:15:08.067669Z","caller":"traceutil/trace.go:171","msg":"trace[204418088] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"861.697087ms","start":"2026-06-26T02:15:07.205959Z","end":"2026-06-26T02:15:08.067656Z","steps":["trace[204418088] 'process raft request' (duration: 861.285466ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:08.067815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:07.205951Z","time spent":"861.746538ms","remote":"127.0.0.1:53510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:15:08.067959Z","caller":"traceutil/trace.go:171","msg":"trace[877221450] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"757.853174ms","start":"2026-06-26T02:15:07.310092Z","end":"2026-06-26T02:15:08.067945Z","steps":["trace[877221450] 'process raft request' (duration: 757.247609ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:08.06802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:07.310068Z","time spent":"757.922445ms","remote":"127.0.0.1:53510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:15:08.070417Z","caller":"traceutil/trace.go:171","msg":"trace[1334987720] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:508; }","duration":"839.967236ms","start":"2026-06-26T02:15:07.230412Z","end":"2026-06-26T02:15:08.070379Z","steps":["trace[1334987720] 'read index received' (duration: 327.425366ms)","trace[1334987720] 'applied index is now lower than readState.Index' (duration: 512.53949ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:15:08.070424Z","caller":"traceutil/trace.go:171","msg":"trace[295507008] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"869.220093ms","start":"2026-06-26T02:15:07.201143Z","end":"2026-06-26T02:15:08.070363Z","steps":["trace[295507008] 'process raft request' (duration: 863.964002ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:15:08.070449Z","caller":"traceutil/trace.go:171","msg":"trace[250416691] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"868.958667ms","start":"2026-06-26T02:15:07.201477Z","end":"2026-06-26T02:15:08.070435Z","steps":["trace[250416691] 'process raft request' (duration: 865.588513ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:08.070538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:07.201139Z","time spent":"869.365997ms","remote":"127.0.0.1:53510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T02:15:08.070621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:07.201471Z","time spent":"869.055999ms","remote":"127.0.0.1:53510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:15:08.071501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.081074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-26T02:15:08.071556Z","caller":"traceutil/trace.go:171","msg":"trace[1665048979] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:505; }","duration":"841.153865ms","start":"2026-06-26T02:15:07.230381Z","end":"2026-06-26T02:15:08.071535Z","steps":["trace[1665048979] 'agreement among raft nodes before linearized reading' (duration: 840.934109ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:08.071587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:07.230369Z","time spent":"841.211287ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-26T02:15:14.484984Z","caller":"traceutil/trace.go:171","msg":"trace[1066609317] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:604; }","duration":"370.625922ms","start":"2026-06-26T02:15:14.114335Z","end":"2026-06-26T02:15:14.484961Z","steps":["trace[1066609317] 'read index received' (duration: 369.840942ms)","trace[1066609317] 'applied index is now lower than readState.Index' (duration: 784.07µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:15:14.485102Z","caller":"traceutil/trace.go:171","msg":"trace[2145767865] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"603.747049ms","start":"2026-06-26T02:15:13.881346Z","end":"2026-06-26T02:15:14.485093Z","steps":["trace[2145767865] 'process raft request' (duration: 603.092142ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:14.485199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:13.881328Z","time spent":"603.799441ms","remote":"127.0.0.1:53562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:15:14.485314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.059767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-skdfz\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-06-26T02:15:14.485344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.000561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-26T02:15:14.485368Z","caller":"traceutil/trace.go:171","msg":"trace[865036636] range","detail":"{range_begin:/registry/pods/kube-system/cilium-skdfz; range_end:; response_count:1; response_revision:586; }","duration":"364.1444ms","start":"2026-06-26T02:15:14.12121Z","end":"2026-06-26T02:15:14.485354Z","steps":["trace[865036636] 'agreement among raft nodes before linearized reading' (duration: 364.042497ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:15:14.485399Z","caller":"traceutil/trace.go:171","msg":"trace[973808246] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:586; }","duration":"371.089363ms","start":"2026-06-26T02:15:14.114294Z","end":"2026-06-26T02:15:14.485383Z","steps":["trace[973808246] 'agreement among raft nodes before linearized reading' (duration: 370.989171ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:14.48545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:14.121196Z","time spent":"364.246742ms","remote":"127.0.0.1:53694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-skdfz\" "} {"level":"warn","ts":"2026-06-26T02:15:14.485468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:14.114276Z","time spent":"371.183455ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T02:15:14.485477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.333888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-26T02:15:14.485562Z","caller":"traceutil/trace.go:171","msg":"trace[1908805486] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:586; }","duration":"248.452511ms","start":"2026-06-26T02:15:14.237084Z","end":"2026-06-26T02:15:14.485537Z","steps":["trace[1908805486] 'agreement among raft nodes before linearized reading' (duration: 248.253506ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:15.329572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.687612ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:15:15.329728Z","caller":"traceutil/trace.go:171","msg":"trace[2128189972] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"839.861292ms","start":"2026-06-26T02:15:14.489819Z","end":"2026-06-26T02:15:15.32968Z","steps":["trace[2128189972] 'process raft request' (duration: 277.960975ms)","trace[2128189972] 'compare' (duration: 561.529018ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:15:15.329815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:14.489794Z","time spent":"839.991506ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:15:15.896279Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.128470131s","expected-duration":"1s"} {"level":"info","ts":"2026-06-26T02:15:15.896857Z","caller":"traceutil/trace.go:171","msg":"trace[1279711074] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"1.393883694s","start":"2026-06-26T02:15:14.502921Z","end":"2026-06-26T02:15:15.896804Z","steps":["trace[1279711074] 'process raft request' (duration: 1.39369505s)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:15:15.896887Z","caller":"traceutil/trace.go:171","msg":"trace[1373832927] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"1.354409482s","start":"2026-06-26T02:15:14.542463Z","end":"2026-06-26T02:15:15.896872Z","steps":["trace[1373832927] 'process raft request' (duration: 1.354204957s)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:15:15.896874Z","caller":"traceutil/trace.go:171","msg":"trace[1675434395] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"1.406236841s","start":"2026-06-26T02:15:14.490434Z","end":"2026-06-26T02:15:15.896671Z","steps":["trace[1675434395] 'process raft request' (duration: 1.406043595s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:15.896989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:14.542451Z","time spent":"1.354488434s","remote":"127.0.0.1:53988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:15:15.897029Z","caller":"traceutil/trace.go:171","msg":"trace[244378744] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:605; }","duration":"1.330051936s","start":"2026-06-26T02:15:14.566966Z","end":"2026-06-26T02:15:15.897018Z","steps":["trace[244378744] 'read index received' (duration: 200.826906ms)","trace[244378744] 'applied index is now lower than readState.Index' (duration: 1.12922409s)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:15:15.897026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:14.502912Z","time spent":"1.394031508s","remote":"127.0.0.1:53694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:15:15.897066Z","caller":"traceutil/trace.go:171","msg":"trace[2069027202] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"1.268426363s","start":"2026-06-26T02:15:14.628607Z","end":"2026-06-26T02:15:15.897034Z","steps":["trace[2069027202] 'process raft request' (duration: 1.268217598s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:15.897169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:14.628559Z","time spent":"1.268558976s","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:15:15.8972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.330237191s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-26T02:15:15.897241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.185094589s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:15:15.897279Z","caller":"traceutil/trace.go:171","msg":"trace[188047302] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:591; }","duration":"1.18512699s","start":"2026-06-26T02:15:14.712142Z","end":"2026-06-26T02:15:15.897269Z","steps":["trace[188047302] 'agreement among raft nodes before linearized reading' (duration: 1.185079909s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:15.897311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:14.712129Z","time spent":"1.185177062s","remote":"127.0.0.1:53424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T02:15:15.897243Z","caller":"traceutil/trace.go:171","msg":"trace[1330399111] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:591; }","duration":"1.330322143s","start":"2026-06-26T02:15:14.566911Z","end":"2026-06-26T02:15:15.897234Z","steps":["trace[1330399111] 'agreement among raft nodes before linearized reading' (duration: 1.330171789s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:15.897465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:14.566888Z","time spent":"1.330566128s","remote":"127.0.0.1:53766","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-06-26T02:15:15.897389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.079675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.116\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-26T02:15:15.897595Z","caller":"traceutil/trace.go:171","msg":"trace[1866054897] range","detail":"{range_begin:/registry/masterleases/199.204.45.116; range_end:; response_count:1; response_revision:591; }","duration":"661.321481ms","start":"2026-06-26T02:15:15.236253Z","end":"2026-06-26T02:15:15.897574Z","steps":["trace[1866054897] 'agreement among raft nodes before linearized reading' (duration: 660.913301ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:15.897586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:14.49042Z","time spent":"1.406529338s","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:15:15.8972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.185181632s","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-06-26T02:15:15.89776Z","caller":"traceutil/trace.go:171","msg":"trace[1322751554] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:591; }","duration":"1.185767706s","start":"2026-06-26T02:15:14.711982Z","end":"2026-06-26T02:15:15.89775Z","steps":["trace[1322751554] 'agreement among raft nodes before linearized reading' (duration: 1.18511892s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:15.89769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:15.236237Z","time spent":"661.440994ms","remote":"127.0.0.1:53482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.116\" "} {"level":"warn","ts":"2026-06-26T02:15:15.897799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:14.711972Z","time spent":"1.185818158s","remote":"127.0.0.1:53766","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-06-26T02:15:16.054714Z","caller":"traceutil/trace.go:171","msg":"trace[1861750215] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:610; }","duration":"145.54911ms","start":"2026-06-26T02:15:15.909144Z","end":"2026-06-26T02:15:16.054693Z","steps":["trace[1861750215] 'read index received' (duration: 76.605655ms)","trace[1861750215] 'applied index is now lower than readState.Index' (duration: 68.942395ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:15:16.054937Z","caller":"traceutil/trace.go:171","msg":"trace[1957739455] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"145.850828ms","start":"2026-06-26T02:15:15.90905Z","end":"2026-06-26T02:15:16.0549Z","steps":["trace[1957739455] 'process raft request' (duration: 145.589352ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:15:16.055213Z","caller":"traceutil/trace.go:171","msg":"trace[1146309092] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"150.882303ms","start":"2026-06-26T02:15:15.904303Z","end":"2026-06-26T02:15:16.055185Z","steps":["trace[1146309092] 'process raft request' (duration: 150.236208ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:16.055291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.193921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T02:15:16.055275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.110744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:15:16.055401Z","caller":"traceutil/trace.go:171","msg":"trace[1253320459] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:593; }","duration":"146.271528ms","start":"2026-06-26T02:15:15.909112Z","end":"2026-06-26T02:15:16.055384Z","steps":["trace[1253320459] 'agreement among raft nodes before linearized reading' (duration: 146.108464ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:15:16.055392Z","caller":"traceutil/trace.go:171","msg":"trace[190653214] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:593; }","duration":"145.328505ms","start":"2026-06-26T02:15:15.910047Z","end":"2026-06-26T02:15:16.055375Z","steps":["trace[190653214] 'agreement among raft nodes before linearized reading' (duration: 145.060298ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:17.835755Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853971417932549173,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:15:18.039241Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.594828197s","expected-duration":"1s"} {"level":"info","ts":"2026-06-26T02:15:18.041391Z","caller":"traceutil/trace.go:171","msg":"trace[986158597] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"706.646856ms","start":"2026-06-26T02:15:17.334718Z","end":"2026-06-26T02:15:18.041365Z","steps":["trace[986158597] 'read index received' (duration: 704.722898ms)","trace[986158597] 'applied index is now lower than readState.Index' (duration: 1.922598ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:15:18.041523Z","caller":"traceutil/trace.go:171","msg":"trace[820163064] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"1.599109254s","start":"2026-06-26T02:15:16.4424Z","end":"2026-06-26T02:15:18.041509Z","steps":["trace[820163064] 'process raft request' (duration: 1.597251208s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:18.041638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:16.442362Z","time spent":"1.599194336s","remote":"127.0.0.1:53562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:15:18.041688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.206223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:15:18.041738Z","caller":"traceutil/trace.go:171","msg":"trace[244620113] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:595; }","duration":"328.310366ms","start":"2026-06-26T02:15:17.713414Z","end":"2026-06-26T02:15:18.041724Z","steps":["trace[244620113] 'agreement among raft nodes before linearized reading' (duration: 328.216944ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:18.041771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:17.713386Z","time spent":"328.378458ms","remote":"127.0.0.1:53424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:15:18.041921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.168168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-26T02:15:18.041981Z","caller":"traceutil/trace.go:171","msg":"trace[1776904626] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:595; }","duration":"707.320943ms","start":"2026-06-26T02:15:17.334636Z","end":"2026-06-26T02:15:18.041957Z","steps":["trace[1776904626] 'agreement among raft nodes before linearized reading' (duration: 707.016055ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:18.041991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.596196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-06-26T02:15:18.042041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:17.334604Z","time spent":"707.425815ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-26T02:15:18.042071Z","caller":"traceutil/trace.go:171","msg":"trace[846897119] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:595; }","duration":"140.73348ms","start":"2026-06-26T02:15:17.901306Z","end":"2026-06-26T02:15:18.042039Z","steps":["trace[846897119] 'agreement among raft nodes before linearized reading' (duration: 140.426082ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:19.676517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.252415ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:15:19.676644Z","caller":"traceutil/trace.go:171","msg":"trace[296247742] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:617; }","duration":"174.391868ms","start":"2026-06-26T02:15:19.502234Z","end":"2026-06-26T02:15:19.676626Z","steps":["trace[296247742] 'range keys from in-memory index tree' (duration: 174.236934ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:26.908066Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853971417932549378,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:15:26.964256Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.199570108s","expected-duration":"1s"} {"level":"info","ts":"2026-06-26T02:15:26.964589Z","caller":"traceutil/trace.go:171","msg":"trace[2133262146] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"1.199970047s","start":"2026-06-26T02:15:25.764601Z","end":"2026-06-26T02:15:26.964571Z","steps":["trace[2133262146] 'process raft request' (duration: 1.199842254s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:26.964724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:25.764581Z","time spent":"1.200071209s","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:15:27.567769Z","caller":"traceutil/trace.go:171","msg":"trace[1186641940] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"1.468601711s","start":"2026-06-26T02:15:26.099139Z","end":"2026-06-26T02:15:27.56774Z","steps":["trace[1186641940] 'process raft request' (duration: 1.468354145s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:27.567941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:26.099116Z","time spent":"1.468742986s","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:15:27.568233Z","caller":"traceutil/trace.go:171","msg":"trace[2081636216] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"659.888356ms","start":"2026-06-26T02:15:26.908326Z","end":"2026-06-26T02:15:27.568214Z","steps":["trace[2081636216] 'process raft request' (duration: 659.355242ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:15:27.568284Z","caller":"traceutil/trace.go:171","msg":"trace[948548474] linearizableReadLoop","detail":"{readStateIndex:725; appliedIndex:723; }","duration":"1.560947489s","start":"2026-06-26T02:15:26.007309Z","end":"2026-06-26T02:15:27.568256Z","steps":["trace[948548474] 'read index received' (duration: 957.149018ms)","trace[948548474] 'applied index is now lower than readState.Index' (duration: 603.796911ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:15:27.568286Z","caller":"traceutil/trace.go:171","msg":"trace[1499894100] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"659.882126ms","start":"2026-06-26T02:15:26.908371Z","end":"2026-06-26T02:15:27.568254Z","steps":["trace[1499894100] 'process raft request' (duration: 659.544077ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:27.568322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:26.908307Z","time spent":"659.971068ms","remote":"127.0.0.1:53540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":780,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T02:15:27.568432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.561107422s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:1 size:1712"} {"level":"warn","ts":"2026-06-26T02:15:27.568446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:26.908352Z","time spent":"659.997379ms","remote":"127.0.0.1:36268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1697,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:15:27.568478Z","caller":"traceutil/trace.go:171","msg":"trace[2070082080] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:1; response_revision:704; }","duration":"1.561198655s","start":"2026-06-26T02:15:26.007266Z","end":"2026-06-26T02:15:27.568465Z","steps":["trace[2070082080] 'agreement among raft nodes before linearized reading' (duration: 1.561105682s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:27.568521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:26.007245Z","time spent":"1.561264466s","remote":"127.0.0.1:36268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":1734,"request content":"key:\"/registry/cilium.io/ciliumnodes/instance\" "} {"level":"warn","ts":"2026-06-26T02:15:27.56852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.978729ms","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-06-26T02:15:27.568569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.322356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:15:27.568585Z","caller":"traceutil/trace.go:171","msg":"trace[458148115] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:704; }","duration":"656.348748ms","start":"2026-06-26T02:15:26.912231Z","end":"2026-06-26T02:15:27.56858Z","steps":["trace[458148115] 'agreement among raft nodes before linearized reading' (duration: 656.328067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:27.568597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:26.912224Z","time spent":"656.370868ms","remote":"127.0.0.1:53424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T02:15:27.568593Z","caller":"traceutil/trace.go:171","msg":"trace[1212291670] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:704; }","duration":"660.06327ms","start":"2026-06-26T02:15:26.908501Z","end":"2026-06-26T02:15:27.568565Z","steps":["trace[1212291670] 'agreement among raft nodes before linearized reading' (duration: 659.904556ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:27.568637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:26.908493Z","time spent":"660.135182ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T02:15:27.568726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.195744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-26T02:15:27.568742Z","caller":"traceutil/trace.go:171","msg":"trace[1671331358] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:704; }","duration":"660.241924ms","start":"2026-06-26T02:15:26.908496Z","end":"2026-06-26T02:15:27.568738Z","steps":["trace[1671331358] 'agreement among raft nodes before linearized reading' (duration: 660.198063ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:27.568549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.540172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-26T02:15:27.568754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:26.908481Z","time spent":"660.270286ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-26T02:15:27.568775Z","caller":"traceutil/trace.go:171","msg":"trace[269903133] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:704; }","duration":"658.766637ms","start":"2026-06-26T02:15:26.909996Z","end":"2026-06-26T02:15:27.568763Z","steps":["trace[269903133] 'agreement among raft nodes before linearized reading' (duration: 658.49032ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:27.568808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:26.909991Z","time spent":"658.807559ms","remote":"127.0.0.1:53766","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-06-26T02:15:27.568701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.149612ms","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-06-26T02:15:27.568963Z","caller":"traceutil/trace.go:171","msg":"trace[1584822885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:704; }","duration":"660.416599ms","start":"2026-06-26T02:15:26.908531Z","end":"2026-06-26T02:15:27.568948Z","steps":["trace[1584822885] 'agreement among raft nodes before linearized reading' (duration: 660.089351ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:27.569006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:26.908528Z","time spent":"660.464771ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T02:15:30.086054Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853971417932549411,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T02:15:30.291008Z","caller":"traceutil/trace.go:171","msg":"trace[525731599] linearizableReadLoop","detail":"{readStateIndex:741; appliedIndex:740; }","duration":"705.717055ms","start":"2026-06-26T02:15:29.585267Z","end":"2026-06-26T02:15:30.290984Z","steps":["trace[525731599] 'read index received' (duration: 705.443819ms)","trace[525731599] 'applied index is now lower than readState.Index' (duration: 272.256µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:15:30.29113Z","caller":"traceutil/trace.go:171","msg":"trace[1659972587] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"707.86818ms","start":"2026-06-26T02:15:29.583249Z","end":"2026-06-26T02:15:30.291117Z","steps":["trace[1659972587] 'process raft request' (duration: 707.548932ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:30.291656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.519473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-skdfz\" ","response":"range_response_count:1 size:18713"} {"level":"warn","ts":"2026-06-26T02:15:30.291657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"706.171887ms","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-06-26T02:15:30.291713Z","caller":"traceutil/trace.go:171","msg":"trace[823518233] range","detail":"{range_begin:/registry/pods/kube-system/cilium-skdfz; range_end:; response_count:1; response_revision:718; }","duration":"359.624936ms","start":"2026-06-26T02:15:29.932076Z","end":"2026-06-26T02:15:30.291701Z","steps":["trace[823518233] 'agreement among raft nodes before linearized reading' (duration: 359.223946ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:15:30.291743Z","caller":"traceutil/trace.go:171","msg":"trace[1926133195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:718; }","duration":"706.465115ms","start":"2026-06-26T02:15:29.585261Z","end":"2026-06-26T02:15:30.291726Z","steps":["trace[1926133195] 'agreement among raft nodes before linearized reading' (duration: 706.005023ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:30.291729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"706.358152ms","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-06-26T02:15:30.291763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:29.932022Z","time spent":"359.731998ms","remote":"127.0.0.1:53694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":18735,"request content":"key:\"/registry/pods/kube-system/cilium-skdfz\" "} {"level":"warn","ts":"2026-06-26T02:15:30.291787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:29.585245Z","time spent":"706.532026ms","remote":"127.0.0.1:53766","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-06-26T02:15:30.291802Z","caller":"traceutil/trace.go:171","msg":"trace[650713550] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:718; }","duration":"706.467554ms","start":"2026-06-26T02:15:29.585316Z","end":"2026-06-26T02:15:30.291783Z","steps":["trace[650713550] 'agreement among raft nodes before linearized reading' (duration: 706.158636ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:30.29203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:29.585308Z","time spent":"706.7064ms","remote":"127.0.0.1:53766","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-06-26T02:15:30.292057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:29.58323Z","time spent":"707.960541ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:15:30.292391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.10333ms","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-06-26T02:15:30.293031Z","caller":"traceutil/trace.go:171","msg":"trace[1072322007] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:718; }","duration":"707.228703ms","start":"2026-06-26T02:15:29.585214Z","end":"2026-06-26T02:15:30.292442Z","steps":["trace[1072322007] 'agreement among raft nodes before linearized reading' (duration: 706.258769ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:30.293122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:29.585187Z","time spent":"707.91617ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-26T02:15:31.650681Z","caller":"traceutil/trace.go:171","msg":"trace[1072975615] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"139.1131ms","start":"2026-06-26T02:15:31.511548Z","end":"2026-06-26T02:15:31.650661Z","steps":["trace[1072975615] 'process raft request' (duration: 138.68636ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:32.801755Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853971417932549445,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T02:15:33.027361Z","caller":"traceutil/trace.go:171","msg":"trace[190973965] linearizableReadLoop","detail":"{readStateIndex:764; appliedIndex:763; }","duration":"726.418751ms","start":"2026-06-26T02:15:32.300915Z","end":"2026-06-26T02:15:33.027334Z","steps":["trace[190973965] 'read index received' (duration: 726.167715ms)","trace[190973965] 'applied index is now lower than readState.Index' (duration: 250.086µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:15:33.027638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.57956ms","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-06-26T02:15:33.027686Z","caller":"traceutil/trace.go:171","msg":"trace[1972262338] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:740; }","duration":"725.852647ms","start":"2026-06-26T02:15:32.301821Z","end":"2026-06-26T02:15:33.027674Z","steps":["trace[1972262338] 'agreement among raft nodes before linearized reading' (duration: 725.663832ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:33.027689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"723.881699ms","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-06-26T02:15:33.027721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:32.301811Z","time spent":"725.901457ms","remote":"127.0.0.1:53766","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-06-26T02:15:33.027754Z","caller":"traceutil/trace.go:171","msg":"trace[2120659695] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:740; }","duration":"723.96763ms","start":"2026-06-26T02:15:32.303773Z","end":"2026-06-26T02:15:33.027741Z","steps":["trace[2120659695] 'agreement among raft nodes before linearized reading' (duration: 723.830617ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:33.027792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:32.303764Z","time spent":"724.017501ms","remote":"127.0.0.1:53766","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-06-26T02:15:33.027775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"726.821931ms","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-06-26T02:15:33.02787Z","caller":"traceutil/trace.go:171","msg":"trace[354843458] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:740; }","duration":"726.939794ms","start":"2026-06-26T02:15:32.30091Z","end":"2026-06-26T02:15:33.027849Z","steps":["trace[354843458] 'agreement among raft nodes before linearized reading' (duration: 726.562875ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:15:33.027869Z","caller":"traceutil/trace.go:171","msg":"trace[71965675] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"727.468408ms","start":"2026-06-26T02:15:32.300169Z","end":"2026-06-26T02:15:33.027637Z","steps":["trace[71965675] 'process raft request' (duration: 726.990926ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:33.028072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:32.300147Z","time spent":"727.838936ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:15:33.027935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:32.300872Z","time spent":"727.049007ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T02:15:37.387393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.825727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T02:15:37.387415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.987883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T02:15:37.387451Z","caller":"traceutil/trace.go:171","msg":"trace[1107622815] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:759; }","duration":"674.927ms","start":"2026-06-26T02:15:36.71251Z","end":"2026-06-26T02:15:37.387437Z","steps":["trace[1107622815] 'range keys from in-memory index tree' (duration: 674.678614ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:15:37.387465Z","caller":"traceutil/trace.go:171","msg":"trace[666209031] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:759; }","duration":"657.095177ms","start":"2026-06-26T02:15:36.730356Z","end":"2026-06-26T02:15:37.387451Z","steps":["trace[666209031] 'count revisions from in-memory index tree' (duration: 656.86692ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:37.387487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:36.712487Z","time spent":"674.993462ms","remote":"127.0.0.1:53424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:15:37.387506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:36.73033Z","time spent":"657.160858ms","remote":"127.0.0.1:53850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":52,"response size":29,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"info","ts":"2026-06-26T02:15:37.443733Z","caller":"traceutil/trace.go:171","msg":"trace[789025387] linearizableReadLoop","detail":"{readStateIndex:785; appliedIndex:784; }","duration":"402.400749ms","start":"2026-06-26T02:15:37.041318Z","end":"2026-06-26T02:15:37.443719Z","steps":["trace[789025387] 'read index received' (duration: 402.287437ms)","trace[789025387] 'applied index is now lower than readState.Index' (duration: 112.672µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:15:37.443831Z","caller":"traceutil/trace.go:171","msg":"trace[2040846933] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"482.019281ms","start":"2026-06-26T02:15:36.961802Z","end":"2026-06-26T02:15:37.443821Z","steps":["trace[2040846933] 'process raft request' (duration: 481.812226ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:37.443913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:36.961778Z","time spent":"482.077053ms","remote":"127.0.0.1:53752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:15:37.44406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.75135ms","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-06-26T02:15:37.444088Z","caller":"traceutil/trace.go:171","msg":"trace[1385108593] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:760; }","duration":"402.816621ms","start":"2026-06-26T02:15:37.041265Z","end":"2026-06-26T02:15:37.444081Z","steps":["trace[1385108593] 'agreement among raft nodes before linearized reading' (duration: 402.732029ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:37.444105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:37.041245Z","time spent":"402.856082ms","remote":"127.0.0.1:53766","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-06-26T02:15:37.444259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.146885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-26T02:15:37.444285Z","caller":"traceutil/trace.go:171","msg":"trace[1512398425] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:760; }","duration":"396.193605ms","start":"2026-06-26T02:15:37.048086Z","end":"2026-06-26T02:15:37.444279Z","steps":["trace[1512398425] 'agreement among raft nodes before linearized reading' (duration: 396.131844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:37.444311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:37.048075Z","time spent":"396.231437ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T02:15:37.444443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.055757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-26T02:15:37.444467Z","caller":"traceutil/trace.go:171","msg":"trace[631734291] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:760; }","duration":"352.113379ms","start":"2026-06-26T02:15:37.092348Z","end":"2026-06-26T02:15:37.444462Z","steps":["trace[631734291] 'agreement among raft nodes before linearized reading' (duration: 352.053237ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:37.444463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.538784ms","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-06-26T02:15:37.444483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:37.092326Z","time spent":"352.152929ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-26T02:15:37.444503Z","caller":"traceutil/trace.go:171","msg":"trace[1377357025] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:760; }","duration":"349.600046ms","start":"2026-06-26T02:15:37.094893Z","end":"2026-06-26T02:15:37.444493Z","steps":["trace[1377357025] 'agreement among raft nodes before linearized reading' (duration: 349.411492ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:37.444535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:37.094884Z","time spent":"349.644637ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T02:15:37.444659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.028677ms","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-06-26T02:15:37.444681Z","caller":"traceutil/trace.go:171","msg":"trace[1190003169] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:760; }","duration":"346.064918ms","start":"2026-06-26T02:15:37.098611Z","end":"2026-06-26T02:15:37.444676Z","steps":["trace[1190003169] 'agreement among raft nodes before linearized reading' (duration: 346.008717ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:15:37.444701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:15:37.098603Z","time spent":"346.092819ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-26T02:16:13.047074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.19166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:16:13.047202Z","caller":"traceutil/trace.go:171","msg":"trace[1985842725] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:978; }","duration":"331.363494ms","start":"2026-06-26T02:16:12.715821Z","end":"2026-06-26T02:16:13.047184Z","steps":["trace[1985842725] 'range keys from in-memory index tree' (duration: 331.118359ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:16:13.047238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:16:12.715802Z","time spent":"331.427787ms","remote":"127.0.0.1:53438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T02:16:14.079874Z","caller":"traceutil/trace.go:171","msg":"trace[1092083742] linearizableReadLoop","detail":"{readStateIndex:1013; appliedIndex:1012; }","duration":"433.4665ms","start":"2026-06-26T02:16:13.646383Z","end":"2026-06-26T02:16:14.079849Z","steps":["trace[1092083742] 'read index received' (duration: 433.317916ms)","trace[1092083742] 'applied index is now lower than readState.Index' (duration: 147.664µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:16:14.079994Z","caller":"traceutil/trace.go:171","msg":"trace[256075212] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"436.595067ms","start":"2026-06-26T02:16:13.643387Z","end":"2026-06-26T02:16:14.079982Z","steps":["trace[256075212] 'process raft request' (duration: 436.33097ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:16:14.080103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:16:13.643365Z","time spent":"436.654849ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:16:14.080221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.928638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-26T02:16:14.080308Z","caller":"traceutil/trace.go:171","msg":"trace[1627027352] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:979; }","duration":"419.0533ms","start":"2026-06-26T02:16:13.66124Z","end":"2026-06-26T02:16:14.080293Z","steps":["trace[1627027352] 'agreement among raft nodes before linearized reading' (duration: 418.833525ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:16:14.080383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:16:13.661227Z","time spent":"419.144623ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-26T02:16:14.080456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.068124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-26T02:16:14.080509Z","caller":"traceutil/trace.go:171","msg":"trace[2037444098] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:979; }","duration":"434.153766ms","start":"2026-06-26T02:16:13.646338Z","end":"2026-06-26T02:16:14.080491Z","steps":["trace[2037444098] 'agreement among raft nodes before linearized reading' (duration: 434.047284ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:16:14.080522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.172888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T02:16:14.080558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:16:13.646317Z","time spent":"434.227199ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-26T02:16:14.080604Z","caller":"traceutil/trace.go:171","msg":"trace[1490002201] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:979; }","duration":"368.313652ms","start":"2026-06-26T02:16:13.712272Z","end":"2026-06-26T02:16:14.080585Z","steps":["trace[1490002201] 'agreement among raft nodes before linearized reading' (duration: 368.132607ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:16:14.080685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:16:13.712256Z","time spent":"368.386793ms","remote":"127.0.0.1:53424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:16:14.080714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.206604ms","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-06-26T02:16:14.080749Z","caller":"traceutil/trace.go:171","msg":"trace[1011638181] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:979; }","duration":"419.263226ms","start":"2026-06-26T02:16:13.661476Z","end":"2026-06-26T02:16:14.080739Z","steps":["trace[1011638181] 'agreement among raft nodes before linearized reading' (duration: 419.141673ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:16:14.080777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:16:13.661467Z","time spent":"419.303497ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T02:16:14.081188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.35175ms","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-06-26T02:16:14.081273Z","caller":"traceutil/trace.go:171","msg":"trace[1493370365] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:979; }","duration":"419.499753ms","start":"2026-06-26T02:16:13.661752Z","end":"2026-06-26T02:16:14.081252Z","steps":["trace[1493370365] 'agreement among raft nodes before linearized reading' (duration: 418.679902ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:16:14.081318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:16:13.661743Z","time spent":"419.565384ms","remote":"127.0.0.1:53766","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-06-26T02:16:42.414316Z","caller":"traceutil/trace.go:171","msg":"trace[1669174288] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"196.655411ms","start":"2026-06-26T02:16:42.217602Z","end":"2026-06-26T02:16:42.414257Z","steps":["trace[1669174288] 'process raft request' (duration: 196.435876ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:16:43.442268Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.028185542s","expected-duration":"1s"} {"level":"info","ts":"2026-06-26T02:16:43.442863Z","caller":"traceutil/trace.go:171","msg":"trace[1541919915] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"1.221484949s","start":"2026-06-26T02:16:42.22134Z","end":"2026-06-26T02:16:43.442825Z","steps":["trace[1541919915] 'process raft request' (duration: 1.221146801s)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:16:43.442966Z","caller":"traceutil/trace.go:171","msg":"trace[1024471959] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"1.153572494s","start":"2026-06-26T02:16:42.289365Z","end":"2026-06-26T02:16:43.442938Z","steps":["trace[1024471959] 'process raft request' (duration: 1.153261017s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:16:43.443034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:16:42.22132Z","time spent":"1.221623023s","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:16:43.443106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:16:42.289336Z","time spent":"1.153691067s","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:16:43.443133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.220695931s","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-06-26T02:16:43.443189Z","caller":"traceutil/trace.go:171","msg":"trace[889580824] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1074; }","duration":"1.220779742s","start":"2026-06-26T02:16:42.222396Z","end":"2026-06-26T02:16:43.443176Z","steps":["trace[889580824] 'agreement among raft nodes before linearized reading' (duration: 1.220623208s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:16:43.443233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:16:42.222384Z","time spent":"1.220835194s","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-26T02:16:43.443244Z","caller":"traceutil/trace.go:171","msg":"trace[451080526] linearizableReadLoop","detail":"{readStateIndex:1113; appliedIndex:1111; }","duration":"1.220473325s","start":"2026-06-26T02:16:42.222428Z","end":"2026-06-26T02:16:43.442902Z","steps":["trace[451080526] 'read index received' (duration: 191.628797ms)","trace[451080526] 'applied index is now lower than readState.Index' (duration: 1.028843618s)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:16:43.443368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"730.79702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:16:43.443417Z","caller":"traceutil/trace.go:171","msg":"trace[117717919] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1074; }","duration":"730.877493ms","start":"2026-06-26T02:16:42.712527Z","end":"2026-06-26T02:16:43.443405Z","steps":["trace[117717919] 'agreement among raft nodes before linearized reading' (duration: 730.804431ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:16:43.443452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.177116379s","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-06-26T02:16:43.443463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:16:42.712506Z","time spent":"730.945714ms","remote":"127.0.0.1:53438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T02:16:43.443484Z","caller":"traceutil/trace.go:171","msg":"trace[1876894105] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1074; }","duration":"1.17717748s","start":"2026-06-26T02:16:42.266299Z","end":"2026-06-26T02:16:43.443476Z","steps":["trace[1876894105] 'agreement among raft nodes before linearized reading' (duration: 1.177102639s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:16:43.443517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:16:42.266282Z","time spent":"1.177229251s","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-26T02:16:43.443544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.094846377s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T02:16:43.443745Z","caller":"traceutil/trace.go:171","msg":"trace[1268438691] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1074; }","duration":"1.095072652s","start":"2026-06-26T02:16:42.348566Z","end":"2026-06-26T02:16:43.443639Z","steps":["trace[1268438691] 'agreement among raft nodes before linearized reading' (duration: 1.094837687s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:16:43.44337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.220877015s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-06-26T02:16:43.443803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:16:42.348547Z","time spent":"1.095241916s","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":3,"response size":29,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"info","ts":"2026-06-26T02:16:43.443824Z","caller":"traceutil/trace.go:171","msg":"trace[855052112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1074; }","duration":"1.221348806s","start":"2026-06-26T02:16:42.222455Z","end":"2026-06-26T02:16:43.443804Z","steps":["trace[855052112] 'agreement among raft nodes before linearized reading' (duration: 1.220850704s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:16:43.443882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:16:42.22244Z","time spent":"1.221424728s","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-26T02:16:45.697592Z","caller":"traceutil/trace.go:171","msg":"trace[539182459] linearizableReadLoop","detail":"{readStateIndex:1119; appliedIndex:1118; }","duration":"250.457198ms","start":"2026-06-26T02:16:45.447104Z","end":"2026-06-26T02:16:45.697561Z","steps":["trace[539182459] 'read index received' (duration: 250.17647ms)","trace[539182459] 'applied index is now lower than readState.Index' (duration: 278.688µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:16:45.697681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:16:45.241455Z","time spent":"456.215715ms","remote":"127.0.0.1:53482","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-26T02:16:45.697868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.743125ms","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-06-26T02:16:45.697951Z","caller":"traceutil/trace.go:171","msg":"trace[35253481] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1078; }","duration":"250.862268ms","start":"2026-06-26T02:16:45.447068Z","end":"2026-06-26T02:16:45.69793Z","steps":["trace[35253481] 'agreement among raft nodes before linearized reading' (duration: 250.595991ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:16:45.703607Z","caller":"traceutil/trace.go:171","msg":"trace[297062674] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"255.529894ms","start":"2026-06-26T02:16:45.448059Z","end":"2026-06-26T02:16:45.703589Z","steps":["trace[297062674] 'process raft request' (duration: 255.415251ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:16:45.703978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.311428ms","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-06-26T02:16:45.704026Z","caller":"traceutil/trace.go:171","msg":"trace[1247109777] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1079; }","duration":"172.400089ms","start":"2026-06-26T02:16:45.531613Z","end":"2026-06-26T02:16:45.704013Z","steps":["trace[1247109777] 'agreement among raft nodes before linearized reading' (duration: 172.293847ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:16:45.704074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.359369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-26T02:16:45.70418Z","caller":"traceutil/trace.go:171","msg":"trace[960191200] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1079; }","duration":"172.511553ms","start":"2026-06-26T02:16:45.531651Z","end":"2026-06-26T02:16:45.704163Z","steps":["trace[960191200] 'agreement among raft nodes before linearized reading' (duration: 172.244337ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:16:45.704242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.668887ms","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-06-26T02:16:45.704287Z","caller":"traceutil/trace.go:171","msg":"trace[434194411] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1079; }","duration":"172.769069ms","start":"2026-06-26T02:16:45.531511Z","end":"2026-06-26T02:16:45.70428Z","steps":["trace[434194411] 'agreement among raft nodes before linearized reading' (duration: 172.360909ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:16:47.945527Z","caller":"traceutil/trace.go:171","msg":"trace[1901537524] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"157.708484ms","start":"2026-06-26T02:16:47.787792Z","end":"2026-06-26T02:16:47.945501Z","steps":["trace[1901537524] 'process raft request' (duration: 103.420007ms)","trace[1901537524] 'compare' (duration: 54.109693ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:16:47.946023Z","caller":"traceutil/trace.go:171","msg":"trace[1975057130] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"157.588531ms","start":"2026-06-26T02:16:47.788396Z","end":"2026-06-26T02:16:47.945985Z","steps":["trace[1975057130] 'process raft request' (duration: 157.052978ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:16:47.94606Z","caller":"traceutil/trace.go:171","msg":"trace[1260259239] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"157.111879ms","start":"2026-06-26T02:16:47.788924Z","end":"2026-06-26T02:16:47.946036Z","steps":["trace[1260259239] 'process raft request' (duration: 156.988876ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:16:48.288797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.829394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:16:48.288896Z","caller":"traceutil/trace.go:171","msg":"trace[31904444] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1090; }","duration":"142.964599ms","start":"2026-06-26T02:16:48.145893Z","end":"2026-06-26T02:16:48.288858Z","steps":["trace[31904444] 'count revisions from in-memory index tree' (duration: 142.747642ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:16:48.706906Z","caller":"traceutil/trace.go:171","msg":"trace[396341358] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"128.338506ms","start":"2026-06-26T02:16:48.57854Z","end":"2026-06-26T02:16:48.706878Z","steps":["trace[396341358] 'process raft request' (duration: 128.08564ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:16:58.03428Z","caller":"traceutil/trace.go:171","msg":"trace[1176992481] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"113.24834ms","start":"2026-06-26T02:16:57.921Z","end":"2026-06-26T02:16:58.034248Z","steps":["trace[1176992481] 'process raft request' (duration: 113.073816ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:03.335316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.351257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:17:03.335415Z","caller":"traceutil/trace.go:171","msg":"trace[495475508] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1189; }","duration":"126.514601ms","start":"2026-06-26T02:17:03.20888Z","end":"2026-06-26T02:17:03.335395Z","steps":["trace[495475508] 'count revisions from in-memory index tree' (duration: 126.242954ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:05.561724Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853971417932550478,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:17:06.061995Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853971417932550478,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T02:17:06.377131Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.527570168s","expected-duration":"1s"} {"level":"info","ts":"2026-06-26T02:17:06.37762Z","caller":"traceutil/trace.go:171","msg":"trace[329502296] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"1.528086781s","start":"2026-06-26T02:17:04.8495Z","end":"2026-06-26T02:17:06.377587Z","steps":["trace[329502296] 'process raft request' (duration: 1.527900496s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:06.377806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:04.849489Z","time spent":"1.528225334s","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:17:06.378223Z","caller":"traceutil/trace.go:171","msg":"trace[1614283891] linearizableReadLoop","detail":"{readStateIndex:1242; appliedIndex:1240; }","duration":"1.316671293s","start":"2026-06-26T02:17:05.061527Z","end":"2026-06-26T02:17:06.378198Z","steps":["trace[1614283891] 'read index received' (duration: 1.315891604s)","trace[1614283891] 'applied index is now lower than readState.Index' (duration: 778.719µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:17:06.378434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.316879548s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:17:06.378559Z","caller":"traceutil/trace.go:171","msg":"trace[1821945446] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1196; }","duration":"1.316989901s","start":"2026-06-26T02:17:05.061489Z","end":"2026-06-26T02:17:06.378479Z","steps":["trace[1821945446] 'agreement among raft nodes before linearized reading' (duration: 1.316868458s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:06.378572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.136286221s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.116\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-26T02:17:06.378616Z","caller":"traceutil/trace.go:171","msg":"trace[871423083] range","detail":"{range_begin:/registry/masterleases/199.204.45.116; range_end:; response_count:1; response_revision:1196; }","duration":"1.136364974s","start":"2026-06-26T02:17:05.242238Z","end":"2026-06-26T02:17:06.378603Z","steps":["trace[871423083] 'agreement among raft nodes before linearized reading' (duration: 1.13622968s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:06.378621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:05.061473Z","time spent":"1.317132734s","remote":"127.0.0.1:43420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:17:06.37865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:05.24222Z","time spent":"1.136422135s","remote":"127.0.0.1:53482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.116\" "} {"level":"info","ts":"2026-06-26T02:17:06.378919Z","caller":"traceutil/trace.go:171","msg":"trace[2110858575] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"451.655696ms","start":"2026-06-26T02:17:05.927232Z","end":"2026-06-26T02:17:06.378888Z","steps":["trace[2110858575] 'process raft request' (duration: 450.870386ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:06.37895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.186438ms","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-06-26T02:17:06.378951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.904222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-26T02:17:06.379002Z","caller":"traceutil/trace.go:171","msg":"trace[1102400059] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1196; }","duration":"310.988965ms","start":"2026-06-26T02:17:06.068Z","end":"2026-06-26T02:17:06.378989Z","steps":["trace[1102400059] 'agreement among raft nodes before linearized reading' (duration: 310.825551ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:17:06.378997Z","caller":"traceutil/trace.go:171","msg":"trace[1015553105] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1196; }","duration":"315.253149ms","start":"2026-06-26T02:17:06.06373Z","end":"2026-06-26T02:17:06.378984Z","steps":["trace[1015553105] 'agreement among raft nodes before linearized reading' (duration: 315.146686ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:06.379029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:06.067986Z","time spent":"311.037476ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T02:17:06.379035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:06.063717Z","time spent":"315.308541ms","remote":"127.0.0.1:53766","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-06-26T02:17:06.379068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:05.927209Z","time spent":"451.772999ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:17:06.379102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"914.291942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:17:06.37914Z","caller":"traceutil/trace.go:171","msg":"trace[358644848] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1196; }","duration":"914.333723ms","start":"2026-06-26T02:17:05.464794Z","end":"2026-06-26T02:17:06.379128Z","steps":["trace[358644848] 'agreement among raft nodes before linearized reading' (duration: 914.271272ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:06.379153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.204047ms","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-06-26T02:17:06.379167Z","caller":"traceutil/trace.go:171","msg":"trace[382150780] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1196; }","duration":"274.239538ms","start":"2026-06-26T02:17:06.104923Z","end":"2026-06-26T02:17:06.379162Z","steps":["trace[382150780] 'agreement among raft nodes before linearized reading' (duration: 274.200207ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:06.379164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:05.464727Z","time spent":"914.430276ms","remote":"127.0.0.1:43422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:17:06.379264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.35884ms","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-06-26T02:17:06.37926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.960125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:17:06.379295Z","caller":"traceutil/trace.go:171","msg":"trace[1967646854] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1196; }","duration":"306.397661ms","start":"2026-06-26T02:17:06.072887Z","end":"2026-06-26T02:17:06.379285Z","steps":["trace[1967646854] 'agreement among raft nodes before linearized reading' (duration: 306.272458ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:06.379323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:06.072882Z","time spent":"306.434722ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-26T02:17:06.379307Z","caller":"traceutil/trace.go:171","msg":"trace[408935160] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1196; }","duration":"666.042427ms","start":"2026-06-26T02:17:05.713254Z","end":"2026-06-26T02:17:06.379296Z","steps":["trace[408935160] 'agreement among raft nodes before linearized reading' (duration: 665.962555ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:06.380232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:05.713238Z","time spent":"666.975961ms","remote":"127.0.0.1:53424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T02:17:10.086025Z","caller":"traceutil/trace.go:171","msg":"trace[1912584440] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"256.12214ms","start":"2026-06-26T02:17:09.829873Z","end":"2026-06-26T02:17:10.085995Z","steps":["trace[1912584440] 'process raft request' (duration: 255.952466ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:17:10.167076Z","caller":"traceutil/trace.go:171","msg":"trace[1019277516] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"163.020433ms","start":"2026-06-26T02:17:10.004016Z","end":"2026-06-26T02:17:10.167037Z","steps":["trace[1019277516] 'process raft request' (duration: 147.320486ms)","trace[1019277516] 'compare' (duration: 15.536083ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:17:10.55083Z","caller":"traceutil/trace.go:171","msg":"trace[312833190] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"114.577257ms","start":"2026-06-26T02:17:10.436226Z","end":"2026-06-26T02:17:10.550804Z","steps":["trace[312833190] 'process raft request' (duration: 80.700831ms)","trace[312833190] 'compare' (duration: 33.703942ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:17:10.551001Z","caller":"traceutil/trace.go:171","msg":"trace[1623842474] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"114.72751ms","start":"2026-06-26T02:17:10.436256Z","end":"2026-06-26T02:17:10.550983Z","steps":["trace[1623842474] 'process raft request' (duration: 114.481844ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:17:10.551168Z","caller":"traceutil/trace.go:171","msg":"trace[970975230] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"114.901925ms","start":"2026-06-26T02:17:10.436261Z","end":"2026-06-26T02:17:10.551163Z","steps":["trace[970975230] 'process raft request' (duration: 114.644969ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:17:10.551308Z","caller":"traceutil/trace.go:171","msg":"trace[112475751] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"114.942116ms","start":"2026-06-26T02:17:10.436361Z","end":"2026-06-26T02:17:10.551303Z","steps":["trace[112475751] 'process raft request' (duration: 114.780392ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:23.07949Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853971417932550622,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T02:17:23.507182Z","caller":"traceutil/trace.go:171","msg":"trace[134645756] linearizableReadLoop","detail":"{readStateIndex:1307; appliedIndex:1306; }","duration":"928.333879ms","start":"2026-06-26T02:17:22.578832Z","end":"2026-06-26T02:17:23.507166Z","steps":["trace[134645756] 'read index received' (duration: 928.189385ms)","trace[134645756] 'applied index is now lower than readState.Index' (duration: 143.704µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:17:23.507241Z","caller":"traceutil/trace.go:171","msg":"trace[1223802154] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"940.503999ms","start":"2026-06-26T02:17:22.566709Z","end":"2026-06-26T02:17:23.507213Z","steps":["trace[1223802154] 'process raft request' (duration: 940.333425ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:23.507381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:22.566684Z","time spent":"940.625621ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:17:23.507437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"880.16626ms","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-06-26T02:17:23.507468Z","caller":"traceutil/trace.go:171","msg":"trace[1285484923] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1257; }","duration":"880.226062ms","start":"2026-06-26T02:17:22.627235Z","end":"2026-06-26T02:17:23.507461Z","steps":["trace[1285484923] 'agreement among raft nodes before linearized reading' (duration: 880.15473ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:23.507489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:22.627223Z","time spent":"880.261653ms","remote":"127.0.0.1:53766","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-06-26T02:17:23.507511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"879.331039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-26T02:17:23.507579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"928.546764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-26T02:17:23.507577Z","caller":"traceutil/trace.go:171","msg":"trace[1343369836] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1257; }","duration":"879.427802ms","start":"2026-06-26T02:17:22.628136Z","end":"2026-06-26T02:17:23.507564Z","steps":["trace[1343369836] 'agreement among raft nodes before linearized reading' (duration: 879.243157ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:17:23.5076Z","caller":"traceutil/trace.go:171","msg":"trace[1413335273] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1257; }","duration":"928.773429ms","start":"2026-06-26T02:17:22.578821Z","end":"2026-06-26T02:17:23.507594Z","steps":["trace[1413335273] 'agreement among raft nodes before linearized reading' (duration: 928.437021ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:23.507615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:22.628122Z","time spent":"879.484733ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-26T02:17:23.507661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"903.760162ms","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-06-26T02:17:23.507687Z","caller":"traceutil/trace.go:171","msg":"trace[1466154277] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1257; }","duration":"903.811814ms","start":"2026-06-26T02:17:22.603872Z","end":"2026-06-26T02:17:23.507684Z","steps":["trace[1466154277] 'agreement among raft nodes before linearized reading' (duration: 903.757752ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:23.507706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:22.603858Z","time spent":"903.843034ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T02:17:23.507769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:22.57876Z","time spent":"929.005906ms","remote":"127.0.0.1:53766","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-06-26T02:17:23.507854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"878.974371ms","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-06-26T02:17:23.507963Z","caller":"traceutil/trace.go:171","msg":"trace[1044555226] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1257; }","duration":"879.046573ms","start":"2026-06-26T02:17:22.628847Z","end":"2026-06-26T02:17:23.507893Z","steps":["trace[1044555226] 'agreement among raft nodes before linearized reading' (duration: 878.661252ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:23.508007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:22.628839Z","time spent":"879.158096ms","remote":"127.0.0.1:53766","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-06-26T02:17:24.23957Z","caller":"traceutil/trace.go:171","msg":"trace[1194223267] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"728.481437ms","start":"2026-06-26T02:17:23.511058Z","end":"2026-06-26T02:17:24.239539Z","steps":["trace[1194223267] 'process raft request' (duration: 643.933171ms)","trace[1194223267] 'compare' (duration: 84.432153ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:17:24.239719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:23.511042Z","time spent":"728.598411ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:17:24.27932Z","caller":"traceutil/trace.go:171","msg":"trace[1820126825] linearizableReadLoop","detail":"{readStateIndex:1312; appliedIndex:1307; }","duration":"566.50374ms","start":"2026-06-26T02:17:23.71279Z","end":"2026-06-26T02:17:24.279294Z","steps":["trace[1820126825] 'read index received' (duration: 442.183772ms)","trace[1820126825] 'applied index is now lower than readState.Index' (duration: 124.318708ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:17:24.279555Z","caller":"traceutil/trace.go:171","msg":"trace[163211832] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"766.884036ms","start":"2026-06-26T02:17:23.512652Z","end":"2026-06-26T02:17:24.279536Z","steps":["trace[163211832] 'process raft request' (duration: 766.498257ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:24.279658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:23.512641Z","time spent":"766.953157ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:17:24.279606Z","caller":"traceutil/trace.go:171","msg":"trace[453275374] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"766.254649ms","start":"2026-06-26T02:17:23.513334Z","end":"2026-06-26T02:17:24.279589Z","steps":["trace[453275374] 'process raft request' (duration: 765.86994ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:24.279735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:23.513324Z","time spent":"766.377662ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:17:24.279774Z","caller":"traceutil/trace.go:171","msg":"trace[1844717690] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"767.240304ms","start":"2026-06-26T02:17:23.512523Z","end":"2026-06-26T02:17:24.279763Z","steps":["trace[1844717690] 'process raft request' (duration: 766.478756ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:24.279826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:23.512502Z","time spent":"767.293615ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:17:24.279825Z","caller":"traceutil/trace.go:171","msg":"trace[271046545] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"766.163357ms","start":"2026-06-26T02:17:23.513647Z","end":"2026-06-26T02:17:24.27981Z","steps":["trace[271046545] 'process raft request' (duration: 765.603273ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:24.279514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.704635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T02:17:24.279883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:23.51364Z","time spent":"766.214339ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:17:24.279894Z","caller":"traceutil/trace.go:171","msg":"trace[905018257] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1262; }","duration":"567.132675ms","start":"2026-06-26T02:17:23.712752Z","end":"2026-06-26T02:17:24.279885Z","steps":["trace[905018257] 'agreement among raft nodes before linearized reading' (duration: 566.654404ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:24.279919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:23.712736Z","time spent":"567.176146ms","remote":"127.0.0.1:53424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:17:25.507977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.501406ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:17:25.508372Z","caller":"traceutil/trace.go:171","msg":"trace[1288412065] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"248.985655ms","start":"2026-06-26T02:17:25.25936Z","end":"2026-06-26T02:17:25.508345Z","steps":["trace[1288412065] 'process raft request' (duration: 27.003656ms)","trace[1288412065] 'compare' (duration: 221.333472ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:17:26.301446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.299845ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:17:26.301596Z","caller":"traceutil/trace.go:171","msg":"trace[1267175403] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"972.154911ms","start":"2026-06-26T02:17:25.329412Z","end":"2026-06-26T02:17:26.301567Z","steps":["trace[1267175403] 'process raft request' (duration: 480.62802ms)","trace[1267175403] 'compare' (duration: 490.917986ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:17:26.301687Z","caller":"traceutil/trace.go:171","msg":"trace[1632737184] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"789.230217ms","start":"2026-06-26T02:17:25.512439Z","end":"2026-06-26T02:17:26.301669Z","steps":["trace[1632737184] 'process raft request' (duration: 789.134745ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:26.301713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:25.329396Z","time spent":"972.261634ms","remote":"127.0.0.1:53540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":757,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T02:17:26.301718Z","caller":"traceutil/trace.go:171","msg":"trace[865605004] linearizableReadLoop","detail":"{readStateIndex:1316; appliedIndex:1315; }","duration":"791.36972ms","start":"2026-06-26T02:17:25.510321Z","end":"2026-06-26T02:17:26.301691Z","steps":["trace[865605004] 'read index received' (duration: 299.702026ms)","trace[865605004] 'applied index is now lower than readState.Index' (duration: 491.665364ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:17:26.301767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:25.512409Z","time spent":"789.313379ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:17:26.301854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.527674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-06-26T02:17:26.301886Z","caller":"traceutil/trace.go:171","msg":"trace[1273300543] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1266; }","duration":"791.606086ms","start":"2026-06-26T02:17:25.510271Z","end":"2026-06-26T02:17:26.301877Z","steps":["trace[1273300543] 'agreement among raft nodes before linearized reading' (duration: 791.524954ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:26.301918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:25.510251Z","time spent":"791.660717ms","remote":"127.0.0.1:53666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-06-26T02:17:26.301923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.662702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:17:26.302096Z","caller":"traceutil/trace.go:171","msg":"trace[1540684695] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1266; }","duration":"589.868277ms","start":"2026-06-26T02:17:25.712217Z","end":"2026-06-26T02:17:26.302085Z","steps":["trace[1540684695] 'agreement among raft nodes before linearized reading' (duration: 589.677083ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:26.302128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:25.712197Z","time spent":"589.922148ms","remote":"127.0.0.1:53424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:17:26.302299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.45152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:17:26.302337Z","caller":"traceutil/trace.go:171","msg":"trace[232743056] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1266; }","duration":"560.512982ms","start":"2026-06-26T02:17:25.741811Z","end":"2026-06-26T02:17:26.302324Z","steps":["trace[232743056] 'agreement among raft nodes before linearized reading' (duration: 560.460511ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:26.302367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:25.741796Z","time spent":"560.561783ms","remote":"127.0.0.1:53820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:17:26.892967Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853971417932550647,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T02:17:27.101139Z","caller":"traceutil/trace.go:171","msg":"trace[780863412] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"790.97833ms","start":"2026-06-26T02:17:26.31014Z","end":"2026-06-26T02:17:27.101119Z","steps":["trace[780863412] 'process raft request' (duration: 790.861757ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:27.101346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:26.310123Z","time spent":"791.084992ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:17:27.108839Z","caller":"traceutil/trace.go:171","msg":"trace[1929197326] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"798.594588ms","start":"2026-06-26T02:17:26.310223Z","end":"2026-06-26T02:17:27.108818Z","steps":["trace[1929197326] 'process raft request' (duration: 798.459385ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:27.108956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:26.310213Z","time spent":"798.68258ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:17:27.109086Z","caller":"traceutil/trace.go:171","msg":"trace[878727309] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"798.319481ms","start":"2026-06-26T02:17:26.310748Z","end":"2026-06-26T02:17:27.109068Z","steps":["trace[878727309] 'process raft request' (duration: 798.040024ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:17:27.109149Z","caller":"traceutil/trace.go:171","msg":"trace[1623435721] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"797.769228ms","start":"2026-06-26T02:17:26.31137Z","end":"2026-06-26T02:17:27.109139Z","steps":["trace[1623435721] 'process raft request' (duration: 797.617484ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:27.109166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:26.310743Z","time spent":"798.382512ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:17:27.109191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:26.311365Z","time spent":"797.802538ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:17:27.109198Z","caller":"traceutil/trace.go:171","msg":"trace[267478040] linearizableReadLoop","detail":"{readStateIndex:1322; appliedIndex:1317; }","duration":"716.245166ms","start":"2026-06-26T02:17:26.392935Z","end":"2026-06-26T02:17:27.10918Z","steps":["trace[267478040] 'read index received' (duration: 708.157986ms)","trace[267478040] 'applied index is now lower than readState.Index' (duration: 8.08605ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:17:27.109405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.140036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:17:27.109459Z","caller":"traceutil/trace.go:171","msg":"trace[883967333] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1272; }","duration":"396.226017ms","start":"2026-06-26T02:17:26.713216Z","end":"2026-06-26T02:17:27.109442Z","steps":["trace[883967333] 'agreement among raft nodes before linearized reading' (duration: 396.150545ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:27.109488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:26.713195Z","time spent":"396.286919ms","remote":"127.0.0.1:53424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:17:27.109489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"716.539063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5331"} {"level":"info","ts":"2026-06-26T02:17:27.109567Z","caller":"traceutil/trace.go:171","msg":"trace[1114845644] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1272; }","duration":"716.651755ms","start":"2026-06-26T02:17:26.392892Z","end":"2026-06-26T02:17:27.109544Z","steps":["trace[1114845644] 'agreement among raft nodes before linearized reading' (duration: 716.391279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:27.109628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:26.392875Z","time spent":"716.732777ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":5353,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-06-26T02:17:27.109607Z","caller":"traceutil/trace.go:171","msg":"trace[965293598] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"797.425848ms","start":"2026-06-26T02:17:26.312145Z","end":"2026-06-26T02:17:27.109571Z","steps":["trace[965293598] 'process raft request' (duration: 796.925296ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:27.109795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:26.312139Z","time spent":"797.554051ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:17:27.223706Z","caller":"traceutil/trace.go:171","msg":"trace[9528907] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"109.643946ms","start":"2026-06-26T02:17:27.114023Z","end":"2026-06-26T02:17:27.223667Z","steps":["trace[9528907] 'process raft request' (duration: 67.337822ms)","trace[9528907] 'compare' (duration: 42.159281ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:17:27.27144Z","caller":"traceutil/trace.go:171","msg":"trace[1298975626] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"153.808495ms","start":"2026-06-26T02:17:27.117607Z","end":"2026-06-26T02:17:27.271415Z","steps":["trace[1298975626] 'process raft request' (duration: 153.677022ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:27.441667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.08984ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:17:27.441767Z","caller":"traceutil/trace.go:171","msg":"trace[2110192558] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"161.749722ms","start":"2026-06-26T02:17:27.280001Z","end":"2026-06-26T02:17:27.441751Z","steps":["trace[2110192558] 'process raft request' (duration: 44.498468ms)","trace[2110192558] 'compare' (duration: 116.961457ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:17:28.471741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.848902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:17:28.471817Z","caller":"traceutil/trace.go:171","msg":"trace[1687629279] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1275; }","duration":"618.974955ms","start":"2026-06-26T02:17:27.852825Z","end":"2026-06-26T02:17:28.471799Z","steps":["trace[1687629279] 'count revisions from in-memory index tree' (duration: 618.763639ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:28.471858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:27.852804Z","time spent":"619.043817ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:17:28.47185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"752.49002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:17:28.471914Z","caller":"traceutil/trace.go:171","msg":"trace[979578874] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1275; }","duration":"752.589722ms","start":"2026-06-26T02:17:27.719307Z","end":"2026-06-26T02:17:28.471897Z","steps":["trace[979578874] 'range keys from in-memory index tree' (duration: 752.426528ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:28.471962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:27.719291Z","time spent":"752.662064ms","remote":"127.0.0.1:53424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T02:17:28.745607Z","caller":"traceutil/trace.go:171","msg":"trace[1547057237] linearizableReadLoop","detail":"{readStateIndex:1327; appliedIndex:1326; }","duration":"272.429773ms","start":"2026-06-26T02:17:28.473153Z","end":"2026-06-26T02:17:28.745583Z","steps":["trace[1547057237] 'read index received' (duration: 272.219688ms)","trace[1547057237] 'applied index is now lower than readState.Index' (duration: 208.945µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:17:28.74574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.562176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:17:28.745773Z","caller":"traceutil/trace.go:171","msg":"trace[1196635880] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1276; }","duration":"272.645498ms","start":"2026-06-26T02:17:28.473118Z","end":"2026-06-26T02:17:28.745763Z","steps":["trace[1196635880] 'agreement among raft nodes before linearized reading' (duration: 272.571496ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:17:28.74584Z","caller":"traceutil/trace.go:171","msg":"trace[685245580] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"434.027501ms","start":"2026-06-26T02:17:28.311791Z","end":"2026-06-26T02:17:28.745819Z","steps":["trace[685245580] 'process raft request' (duration: 433.582261ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:28.745952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:28.311758Z","time spent":"434.134894ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:17:33.251852Z","caller":"traceutil/trace.go:171","msg":"trace[778975674] linearizableReadLoop","detail":"{readStateIndex:1363; appliedIndex:1362; }","duration":"119.606832ms","start":"2026-06-26T02:17:33.132227Z","end":"2026-06-26T02:17:33.251833Z","steps":["trace[778975674] 'read index received' (duration: 119.459398ms)","trace[778975674] 'applied index is now lower than readState.Index' (duration: 146.714µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:17:33.251891Z","caller":"traceutil/trace.go:171","msg":"trace[255082090] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"124.530293ms","start":"2026-06-26T02:17:33.127339Z","end":"2026-06-26T02:17:33.25187Z","steps":["trace[255082090] 'process raft request' (duration: 124.365219ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:33.252027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.779416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-26T02:17:33.252055Z","caller":"traceutil/trace.go:171","msg":"trace[1691671102] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1311; }","duration":"119.841428ms","start":"2026-06-26T02:17:33.132207Z","end":"2026-06-26T02:17:33.252048Z","steps":["trace[1691671102] 'agreement among raft nodes before linearized reading' (duration: 119.724045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:33.252148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.471759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-06-26T02:17:33.252174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.638143ms","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-06-26T02:17:33.252233Z","caller":"traceutil/trace.go:171","msg":"trace[1793685090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1311; }","duration":"115.723245ms","start":"2026-06-26T02:17:33.136498Z","end":"2026-06-26T02:17:33.252221Z","steps":["trace[1793685090] 'agreement among raft nodes before linearized reading' (duration: 115.51865ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:17:33.252251Z","caller":"traceutil/trace.go:171","msg":"trace[2010230921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1311; }","duration":"115.618422ms","start":"2026-06-26T02:17:33.136614Z","end":"2026-06-26T02:17:33.252232Z","steps":["trace[2010230921] 'agreement among raft nodes before linearized reading' (duration: 115.405677ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:33.252795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.857468ms","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-06-26T02:17:33.252849Z","caller":"traceutil/trace.go:171","msg":"trace[2090388968] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1311; }","duration":"117.912869ms","start":"2026-06-26T02:17:33.134924Z","end":"2026-06-26T02:17:33.252837Z","steps":["trace[2090388968] 'agreement among raft nodes before linearized reading' (duration: 117.060198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:34.003051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.998941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:56602"} {"level":"info","ts":"2026-06-26T02:17:34.003127Z","caller":"traceutil/trace.go:171","msg":"trace[468564682] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1315; }","duration":"447.109684ms","start":"2026-06-26T02:17:33.555998Z","end":"2026-06-26T02:17:34.003108Z","steps":["trace[468564682] 'range keys from in-memory index tree' (duration: 446.819627ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:34.003167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:33.555979Z","time spent":"447.179066ms","remote":"127.0.0.1:53522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":56624,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-06-26T02:17:34.003276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.866541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T02:17:34.003349Z","caller":"traceutil/trace.go:171","msg":"trace[1552521938] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1315; }","duration":"486.583208ms","start":"2026-06-26T02:17:33.516748Z","end":"2026-06-26T02:17:34.003331Z","steps":["trace[1552521938] 'count revisions from in-memory index tree' (duration: 485.753088ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:34.00339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:33.51672Z","time spent":"486.65911ms","remote":"127.0.0.1:53780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":5,"response size":29,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-06-26T02:17:34.003085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.31935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-06-26T02:17:34.004229Z","caller":"traceutil/trace.go:171","msg":"trace[134071962] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1315; }","duration":"446.492068ms","start":"2026-06-26T02:17:33.55771Z","end":"2026-06-26T02:17:34.004202Z","steps":["trace[134071962] 'range keys from in-memory index tree' (duration: 445.238538ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:34.00428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:33.557706Z","time spent":"446.56113ms","remote":"127.0.0.1:53534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":140,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"info","ts":"2026-06-26T02:17:35.351596Z","caller":"traceutil/trace.go:171","msg":"trace[14803542] linearizableReadLoop","detail":"{readStateIndex:1368; appliedIndex:1367; }","duration":"349.582526ms","start":"2026-06-26T02:17:35.001977Z","end":"2026-06-26T02:17:35.35156Z","steps":["trace[14803542] 'read index received' (duration: 349.256888ms)","trace[14803542] 'applied index is now lower than readState.Index' (duration: 324.208µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:17:35.351679Z","caller":"traceutil/trace.go:171","msg":"trace[110842833] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"537.938785ms","start":"2026-06-26T02:17:34.813715Z","end":"2026-06-26T02:17:35.351654Z","steps":["trace[110842833] 'process raft request' (duration: 537.642618ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:35.351874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:34.813684Z","time spent":"538.067398ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:17:35.351944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.700392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.116\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-26T02:17:35.352001Z","caller":"traceutil/trace.go:171","msg":"trace[2079642202] range","detail":"{range_begin:/registry/masterleases/199.204.45.116; range_end:; response_count:1; response_revision:1316; }","duration":"108.800365ms","start":"2026-06-26T02:17:35.243187Z","end":"2026-06-26T02:17:35.351988Z","steps":["trace[2079642202] 'agreement among raft nodes before linearized reading' (duration: 108.591819ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:35.352061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.055899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-06-26T02:17:35.352196Z","caller":"traceutil/trace.go:171","msg":"trace[1346156637] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1316; }","duration":"350.259414ms","start":"2026-06-26T02:17:35.001909Z","end":"2026-06-26T02:17:35.352168Z","steps":["trace[1346156637] 'agreement among raft nodes before linearized reading' (duration: 349.836253ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:35.352257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:17:35.00188Z","time spent":"350.361476ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-06-26T02:17:49.560632Z","caller":"traceutil/trace.go:171","msg":"trace[1242984167] linearizableReadLoop","detail":"{readStateIndex:1460; appliedIndex:1459; }","duration":"122.312179ms","start":"2026-06-26T02:17:49.438282Z","end":"2026-06-26T02:17:49.560594Z","steps":["trace[1242984167] 'read index received' (duration: 118.646647ms)","trace[1242984167] 'applied index is now lower than readState.Index' (duration: 3.663692ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:17:49.560962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.647317ms","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-06-26T02:17:49.561055Z","caller":"traceutil/trace.go:171","msg":"trace[4046495] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1405; }","duration":"122.812941ms","start":"2026-06-26T02:17:49.438215Z","end":"2026-06-26T02:17:49.561028Z","steps":["trace[4046495] 'agreement among raft nodes before linearized reading' (duration: 122.521114ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:17:49.560736Z","caller":"traceutil/trace.go:171","msg":"trace[1474491501] transaction","detail":"{read_only:false; response_revision:1405; number_of_response:1; }","duration":"128.743777ms","start":"2026-06-26T02:17:49.431949Z","end":"2026-06-26T02:17:49.560693Z","steps":["trace[1474491501] 'process raft request' (duration: 124.984353ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:49.561496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.491009ms","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-06-26T02:17:49.5616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.960651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-26T02:17:49.561576Z","caller":"traceutil/trace.go:171","msg":"trace[455164857] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1405; }","duration":"121.617222ms","start":"2026-06-26T02:17:49.439938Z","end":"2026-06-26T02:17:49.561556Z","steps":["trace[455164857] 'agreement among raft nodes before linearized reading' (duration: 121.430787ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:17:49.561691Z","caller":"traceutil/trace.go:171","msg":"trace[431418799] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1405; }","duration":"118.070094ms","start":"2026-06-26T02:17:49.443605Z","end":"2026-06-26T02:17:49.561675Z","steps":["trace[431418799] 'agreement among raft nodes before linearized reading' (duration: 117.825278ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:17:49.561887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.430343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-26T02:17:49.562065Z","caller":"traceutil/trace.go:171","msg":"trace[1038933996] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1405; }","duration":"118.683059ms","start":"2026-06-26T02:17:49.443362Z","end":"2026-06-26T02:17:49.562045Z","steps":["trace[1038933996] 'agreement among raft nodes before linearized reading' (duration: 118.110705ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:17:50.591659Z","caller":"traceutil/trace.go:171","msg":"trace[64457990] transaction","detail":"{read_only:false; response_revision:1411; number_of_response:1; }","duration":"191.385123ms","start":"2026-06-26T02:17:50.400249Z","end":"2026-06-26T02:17:50.591634Z","steps":["trace[64457990] 'process raft request' (duration: 191.221939ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:17:57.53169Z","caller":"traceutil/trace.go:171","msg":"trace[1575191843] transaction","detail":"{read_only:false; response_revision:1443; number_of_response:1; }","duration":"104.53896ms","start":"2026-06-26T02:17:57.427122Z","end":"2026-06-26T02:17:57.531661Z","steps":["trace[1575191843] 'process raft request' (duration: 54.215478ms)","trace[1575191843] 'compare' (duration: 50.106077ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:17:59.912885Z","caller":"traceutil/trace.go:171","msg":"trace[2114542258] transaction","detail":"{read_only:false; response_revision:1456; number_of_response:1; }","duration":"141.465412ms","start":"2026-06-26T02:17:59.771397Z","end":"2026-06-26T02:17:59.912863Z","steps":["trace[2114542258] 'process raft request' (duration: 141.428021ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:17:59.912926Z","caller":"traceutil/trace.go:171","msg":"trace[1444334465] transaction","detail":"{read_only:false; response_revision:1454; number_of_response:1; }","duration":"142.824105ms","start":"2026-06-26T02:17:59.77008Z","end":"2026-06-26T02:17:59.912904Z","steps":["trace[1444334465] 'process raft request' (duration: 142.404285ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:17:59.912935Z","caller":"traceutil/trace.go:171","msg":"trace[1431671570] transaction","detail":"{read_only:false; response_revision:1455; number_of_response:1; }","duration":"142.263241ms","start":"2026-06-26T02:17:59.770644Z","end":"2026-06-26T02:17:59.912908Z","steps":["trace[1431671570] 'process raft request' (duration: 142.143498ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:18:01.887238Z","caller":"traceutil/trace.go:171","msg":"trace[1922302150] transaction","detail":"{read_only:false; response_revision:1463; number_of_response:1; }","duration":"144.874586ms","start":"2026-06-26T02:18:01.742334Z","end":"2026-06-26T02:18:01.887208Z","steps":["trace[1922302150] 'process raft request' (duration: 65.719661ms)","trace[1922302150] 'compare' (duration: 78.946479ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:18:03.867193Z","caller":"traceutil/trace.go:171","msg":"trace[1803005845] transaction","detail":"{read_only:false; response_revision:1471; number_of_response:1; }","duration":"122.464252ms","start":"2026-06-26T02:18:03.7447Z","end":"2026-06-26T02:18:03.867165Z","steps":["trace[1803005845] 'process raft request' (duration: 49.221284ms)","trace[1803005845] 'compare' (duration: 73.132515ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:18:18.233572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.74221ms","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-06-26T02:18:18.233626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.308669ms","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-06-26T02:18:18.23365Z","caller":"traceutil/trace.go:171","msg":"trace[1193459377] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1538; }","duration":"109.869692ms","start":"2026-06-26T02:18:18.123764Z","end":"2026-06-26T02:18:18.233634Z","steps":["trace[1193459377] 'range keys from in-memory index tree' (duration: 109.566215ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:18:18.233691Z","caller":"traceutil/trace.go:171","msg":"trace[616345133] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1538; }","duration":"109.424662ms","start":"2026-06-26T02:18:18.12425Z","end":"2026-06-26T02:18:18.233675Z","steps":["trace[616345133] 'range keys from in-memory index tree' (duration: 109.099074ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:18:18.23376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.009515ms","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-06-26T02:18:18.233842Z","caller":"traceutil/trace.go:171","msg":"trace[732052782] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1538; }","duration":"110.129949ms","start":"2026-06-26T02:18:18.123694Z","end":"2026-06-26T02:18:18.233824Z","steps":["trace[732052782] 'range keys from in-memory index tree' (duration: 109.815561ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:18:18.23429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.484097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-06-26T02:18:18.234327Z","caller":"traceutil/trace.go:171","msg":"trace[815328484] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1538; }","duration":"110.57513ms","start":"2026-06-26T02:18:18.123743Z","end":"2026-06-26T02:18:18.234318Z","steps":["trace[815328484] 'range keys from in-memory index tree' (duration: 109.564324ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:18:18.502557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.273654ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:18:18.502709Z","caller":"traceutil/trace.go:171","msg":"trace[1052421304] transaction","detail":"{read_only:false; response_revision:1541; number_of_response:1; }","duration":"264.959807ms","start":"2026-06-26T02:18:18.237734Z","end":"2026-06-26T02:18:18.502694Z","steps":["trace[1052421304] 'process raft request' (duration: 264.892836ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:18:18.5028Z","caller":"traceutil/trace.go:171","msg":"trace[5738687] transaction","detail":"{read_only:false; response_revision:1542; number_of_response:1; }","duration":"264.535587ms","start":"2026-06-26T02:18:18.238211Z","end":"2026-06-26T02:18:18.502747Z","steps":["trace[5738687] 'process raft request' (duration: 264.463985ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:18:18.502799Z","caller":"traceutil/trace.go:171","msg":"trace[1034319786] transaction","detail":"{read_only:false; response_revision:1540; number_of_response:1; }","duration":"265.025719ms","start":"2026-06-26T02:18:18.237719Z","end":"2026-06-26T02:18:18.502745Z","steps":["trace[1034319786] 'process raft request' (duration: 110.458207ms)","trace[1034319786] 'compare' (duration: 153.948647ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:18:25.917292Z","caller":"traceutil/trace.go:171","msg":"trace[835569235] transaction","detail":"{read_only:false; response_revision:1573; number_of_response:1; }","duration":"106.5437ms","start":"2026-06-26T02:18:25.810724Z","end":"2026-06-26T02:18:25.917268Z","steps":["trace[835569235] 'process raft request' (duration: 106.456738ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:18:26.604892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.253926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-26T02:18:26.604981Z","caller":"traceutil/trace.go:171","msg":"trace[1235251520] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1575; }","duration":"281.358058ms","start":"2026-06-26T02:18:26.323603Z","end":"2026-06-26T02:18:26.604961Z","steps":["trace[1235251520] 'range keys from in-memory index tree' (duration: 281.073022ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:18:26.929154Z","caller":"traceutil/trace.go:171","msg":"trace[669958341] transaction","detail":"{read_only:false; response_revision:1577; number_of_response:1; }","duration":"319.61197ms","start":"2026-06-26T02:18:26.609522Z","end":"2026-06-26T02:18:26.929134Z","steps":["trace[669958341] 'process raft request' (duration: 318.508773ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:18:26.929251Z","caller":"traceutil/trace.go:171","msg":"trace[809963237] transaction","detail":"{read_only:false; response_revision:1578; number_of_response:1; }","duration":"319.646501ms","start":"2026-06-26T02:18:26.609587Z","end":"2026-06-26T02:18:26.929233Z","steps":["trace[809963237] 'process raft request' (duration: 319.143549ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:18:26.929327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:18:26.609497Z","time spent":"319.728774ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T02:18:26.929381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:18:26.609571Z","time spent":"319.762164ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:18:26.928885Z","caller":"traceutil/trace.go:171","msg":"trace[1872952793] transaction","detail":"{read_only:false; response_revision:1579; number_of_response:1; }","duration":"317.821766ms","start":"2026-06-26T02:18:26.61103Z","end":"2026-06-26T02:18:26.928852Z","steps":["trace[1872952793] 'process raft request' (duration: 317.769875ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:18:26.929588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:18:26.611019Z","time spent":"318.520434ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:18:32.352053Z","caller":"traceutil/trace.go:171","msg":"trace[1174153828] transaction","detail":"{read_only:false; response_revision:1603; number_of_response:1; }","duration":"137.83174ms","start":"2026-06-26T02:18:32.214191Z","end":"2026-06-26T02:18:32.352023Z","steps":["trace[1174153828] 'process raft request' (duration: 44.683409ms)","trace[1174153828] 'compare' (duration: 92.683589ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:18:38.085714Z","caller":"traceutil/trace.go:171","msg":"trace[1543761831] transaction","detail":"{read_only:false; response_revision:1628; number_of_response:1; }","duration":"104.375647ms","start":"2026-06-26T02:18:37.981315Z","end":"2026-06-26T02:18:38.08569Z","steps":["trace[1543761831] 'process raft request' (duration: 104.224663ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:18:39.174602Z","caller":"traceutil/trace.go:171","msg":"trace[1546683993] transaction","detail":"{read_only:false; response_revision:1633; number_of_response:1; }","duration":"127.29577ms","start":"2026-06-26T02:18:39.047276Z","end":"2026-06-26T02:18:39.174572Z","steps":["trace[1546683993] 'process raft request' (duration: 95.102449ms)","trace[1546683993] 'compare' (duration: 31.974896ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:18:39.174722Z","caller":"traceutil/trace.go:171","msg":"trace[1162032703] transaction","detail":"{read_only:false; response_revision:1634; number_of_response:1; }","duration":"125.2059ms","start":"2026-06-26T02:18:39.049495Z","end":"2026-06-26T02:18:39.174701Z","steps":["trace[1162032703] 'process raft request' (duration: 125.022335ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:18:51.430292Z","caller":"traceutil/trace.go:171","msg":"trace[488236446] linearizableReadLoop","detail":"{readStateIndex:1757; appliedIndex:1755; }","duration":"107.865183ms","start":"2026-06-26T02:18:51.322401Z","end":"2026-06-26T02:18:51.430266Z","steps":["trace[488236446] 'read index received' (duration: 58.000867ms)","trace[488236446] 'applied index is now lower than readState.Index' (duration: 49.863236ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:18:51.430405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.978306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:18:51.430377Z","caller":"traceutil/trace.go:171","msg":"trace[1106253760] transaction","detail":"{read_only:false; response_revision:1689; number_of_response:1; }","duration":"192.775201ms","start":"2026-06-26T02:18:51.237564Z","end":"2026-06-26T02:18:51.430339Z","steps":["trace[1106253760] 'process raft request' (duration: 192.655358ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:18:51.430446Z","caller":"traceutil/trace.go:171","msg":"trace[1641371753] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1689; }","duration":"108.069698ms","start":"2026-06-26T02:18:51.322366Z","end":"2026-06-26T02:18:51.430435Z","steps":["trace[1641371753] 'agreement among raft nodes before linearized reading' (duration: 107.987186ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:18:51.431083Z","caller":"traceutil/trace.go:171","msg":"trace[951555589] transaction","detail":"{read_only:false; response_revision:1688; number_of_response:1; }","duration":"193.769646ms","start":"2026-06-26T02:18:51.236519Z","end":"2026-06-26T02:18:51.430289Z","steps":["trace[951555589] 'process raft request' (duration: 144.046553ms)","trace[951555589] 'compare' (duration: 49.528758ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:18:52.212287Z","caller":"traceutil/trace.go:171","msg":"trace[101062162] transaction","detail":"{read_only:false; response_revision:1690; number_of_response:1; }","duration":"120.297748ms","start":"2026-06-26T02:18:52.09196Z","end":"2026-06-26T02:18:52.212258Z","steps":["trace[101062162] 'process raft request' (duration: 120.167335ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:18:52.414201Z","caller":"traceutil/trace.go:171","msg":"trace[563763891] transaction","detail":"{read_only:false; response_revision:1691; number_of_response:1; }","duration":"284.971789ms","start":"2026-06-26T02:18:52.129206Z","end":"2026-06-26T02:18:52.414178Z","steps":["trace[563763891] 'process raft request' (duration: 284.831096ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:18:52.476319Z","caller":"traceutil/trace.go:171","msg":"trace[556553579] transaction","detail":"{read_only:false; response_revision:1692; number_of_response:1; }","duration":"208.175159ms","start":"2026-06-26T02:18:52.268111Z","end":"2026-06-26T02:18:52.476286Z","steps":["trace[556553579] 'process raft request' (duration: 208.009145ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:18:52.476324Z","caller":"traceutil/trace.go:171","msg":"trace[1770826165] transaction","detail":"{read_only:false; response_revision:1693; number_of_response:1; }","duration":"202.765806ms","start":"2026-06-26T02:18:52.273537Z","end":"2026-06-26T02:18:52.476303Z","steps":["trace[1770826165] 'process raft request' (duration: 202.683584ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:18:55.711671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.56691ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:18:55.711781Z","caller":"traceutil/trace.go:171","msg":"trace[1936952373] transaction","detail":"{read_only:false; response_revision:1707; number_of_response:1; }","duration":"252.355926ms","start":"2026-06-26T02:18:55.459405Z","end":"2026-06-26T02:18:55.711761Z","steps":["trace[1936952373] 'process raft request' (duration: 56.580991ms)","trace[1936952373] 'compare' (duration: 195.364055ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:18:55.72958Z","caller":"traceutil/trace.go:171","msg":"trace[458140734] transaction","detail":"{read_only:false; response_revision:1708; number_of_response:1; }","duration":"267.5584ms","start":"2026-06-26T02:18:55.46198Z","end":"2026-06-26T02:18:55.729539Z","steps":["trace[458140734] 'process raft request' (duration: 267.363206ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:18:56.218519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.728083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-06-26T02:18:56.218603Z","caller":"traceutil/trace.go:171","msg":"trace[1790642602] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1709; }","duration":"184.832146ms","start":"2026-06-26T02:18:56.033752Z","end":"2026-06-26T02:18:56.218584Z","steps":["trace[1790642602] 'range keys from in-memory index tree' (duration: 184.574869ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:18:56.642977Z","caller":"traceutil/trace.go:171","msg":"trace[1783658698] transaction","detail":"{read_only:false; response_revision:1712; number_of_response:1; }","duration":"103.354632ms","start":"2026-06-26T02:18:56.539596Z","end":"2026-06-26T02:18:56.64295Z","steps":["trace[1783658698] 'process raft request' (duration: 96.141904ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:18:56.81683Z","caller":"traceutil/trace.go:171","msg":"trace[673042758] linearizableReadLoop","detail":"{readStateIndex:1782; appliedIndex:1781; }","duration":"103.000863ms","start":"2026-06-26T02:18:56.713804Z","end":"2026-06-26T02:18:56.816805Z","steps":["trace[673042758] 'read index received' (duration: 89.06569ms)","trace[673042758] 'applied index is now lower than readState.Index' (duration: 13.933823ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:18:56.816971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.141627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:18:56.817022Z","caller":"traceutil/trace.go:171","msg":"trace[1887023549] transaction","detail":"{read_only:false; response_revision:1713; number_of_response:1; }","duration":"109.39026ms","start":"2026-06-26T02:18:56.707603Z","end":"2026-06-26T02:18:56.816993Z","steps":["trace[1887023549] 'process raft request' (duration: 95.299243ms)","trace[1887023549] 'compare' (duration: 13.549284ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:18:56.81715Z","caller":"traceutil/trace.go:171","msg":"trace[419764117] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1713; }","duration":"103.210468ms","start":"2026-06-26T02:18:56.713786Z","end":"2026-06-26T02:18:56.816997Z","steps":["trace[419764117] 'agreement among raft nodes before linearized reading' (duration: 103.112546ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:18:57.289971Z","caller":"traceutil/trace.go:171","msg":"trace[1471311832] transaction","detail":"{read_only:false; response_revision:1714; number_of_response:1; }","duration":"242.097464ms","start":"2026-06-26T02:18:57.047844Z","end":"2026-06-26T02:18:57.289942Z","steps":["trace[1471311832] 'process raft request' (duration: 241.854088ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:18:57.468982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.963233ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:18:57.469262Z","caller":"traceutil/trace.go:171","msg":"trace[234860318] transaction","detail":"{read_only:false; response_revision:1715; number_of_response:1; }","duration":"174.711728ms","start":"2026-06-26T02:18:57.294523Z","end":"2026-06-26T02:18:57.469235Z","steps":["trace[234860318] 'process raft request' (duration: 73.408336ms)","trace[234860318] 'compare' (duration: 100.848691ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:18:59.79981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.367074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:18:59.799899Z","caller":"traceutil/trace.go:171","msg":"trace[1830388414] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1724; }","duration":"221.492337ms","start":"2026-06-26T02:18:59.578383Z","end":"2026-06-26T02:18:59.799875Z","steps":["trace[1830388414] 'count revisions from in-memory index tree' (duration: 221.301433ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:00.008602Z","caller":"traceutil/trace.go:171","msg":"trace[1215347724] transaction","detail":"{read_only:false; response_revision:1725; number_of_response:1; }","duration":"205.180715ms","start":"2026-06-26T02:18:59.803392Z","end":"2026-06-26T02:19:00.008573Z","steps":["trace[1215347724] 'process raft request' (duration: 205.002761ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:00.161499Z","caller":"traceutil/trace.go:171","msg":"trace[322278588] transaction","detail":"{read_only:false; response_revision:1726; number_of_response:1; }","duration":"357.136494ms","start":"2026-06-26T02:18:59.804329Z","end":"2026-06-26T02:19:00.161465Z","steps":["trace[322278588] 'process raft request' (duration: 314.621668ms)","trace[322278588] 'compare' (duration: 42.390153ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:19:00.161658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:18:59.804309Z","time spent":"357.265786ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:19:12.48001Z","caller":"traceutil/trace.go:171","msg":"trace[36835620] transaction","detail":"{read_only:false; response_revision:1781; number_of_response:1; }","duration":"203.892895ms","start":"2026-06-26T02:19:12.276088Z","end":"2026-06-26T02:19:12.479981Z","steps":["trace[36835620] 'process raft request' (duration: 203.725131ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:19.588537Z","caller":"traceutil/trace.go:171","msg":"trace[1391258348] transaction","detail":"{read_only:false; response_revision:1815; number_of_response:1; }","duration":"101.008556ms","start":"2026-06-26T02:19:19.487482Z","end":"2026-06-26T02:19:19.58849Z","steps":["trace[1391258348] 'process raft request' (duration: 100.892332ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:22.675698Z","caller":"traceutil/trace.go:171","msg":"trace[1186044974] linearizableReadLoop","detail":"{readStateIndex:1901; appliedIndex:1900; }","duration":"142.748158ms","start":"2026-06-26T02:19:22.532928Z","end":"2026-06-26T02:19:22.675676Z","steps":["trace[1186044974] 'read index received' (duration: 142.623745ms)","trace[1186044974] 'applied index is now lower than readState.Index' (duration: 123.623µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:19:22.675752Z","caller":"traceutil/trace.go:171","msg":"trace[1587119437] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"146.936361ms","start":"2026-06-26T02:19:22.528779Z","end":"2026-06-26T02:19:22.675715Z","steps":["trace[1587119437] 'process raft request' (duration: 146.743885ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:22.675884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.943312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-26T02:19:22.676179Z","caller":"traceutil/trace.go:171","msg":"trace[736231034] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1827; }","duration":"143.29727ms","start":"2026-06-26T02:19:22.532865Z","end":"2026-06-26T02:19:22.676162Z","steps":["trace[736231034] 'agreement among raft nodes before linearized reading' (duration: 142.901501ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:22.71116Z","caller":"traceutil/trace.go:171","msg":"trace[1806093358] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"117.249543ms","start":"2026-06-26T02:19:22.593881Z","end":"2026-06-26T02:19:22.71113Z","steps":["trace[1806093358] 'process raft request' (duration: 90.390585ms)","trace[1806093358] 'compare' (duration: 26.612752ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:19:25.919521Z","caller":"traceutil/trace.go:171","msg":"trace[1188542223] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"184.548081ms","start":"2026-06-26T02:19:25.734936Z","end":"2026-06-26T02:19:25.919484Z","steps":["trace[1188542223] 'process raft request' (duration: 94.187857ms)","trace[1188542223] 'compare' (duration: 90.012815ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:19:25.919832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.052826ms","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-06-26T02:19:25.919896Z","caller":"traceutil/trace.go:171","msg":"trace[1576388534] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1844; }","duration":"179.305683ms","start":"2026-06-26T02:19:25.740579Z","end":"2026-06-26T02:19:25.919885Z","steps":["trace[1576388534] 'agreement among raft nodes before linearized reading' (duration: 178.977055ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:25.919508Z","caller":"traceutil/trace.go:171","msg":"trace[1352098987] linearizableReadLoop","detail":"{readStateIndex:1919; appliedIndex:1918; }","duration":"178.872651ms","start":"2026-06-26T02:19:25.740587Z","end":"2026-06-26T02:19:25.919459Z","steps":["trace[1352098987] 'read index received' (duration: 88.490967ms)","trace[1352098987] 'applied index is now lower than readState.Index' (duration: 90.380834ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:19:25.920399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.40876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-26T02:19:25.920451Z","caller":"traceutil/trace.go:171","msg":"trace[689490891] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1844; }","duration":"129.514053ms","start":"2026-06-26T02:19:25.790921Z","end":"2026-06-26T02:19:25.920435Z","steps":["trace[689490891] 'agreement among raft nodes before linearized reading' (duration: 129.346899ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:28.858524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.764464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-26T02:19:28.858615Z","caller":"traceutil/trace.go:171","msg":"trace[1764414213] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1857; }","duration":"112.898336ms","start":"2026-06-26T02:19:28.745696Z","end":"2026-06-26T02:19:28.858595Z","steps":["trace[1764414213] 'range keys from in-memory index tree' (duration: 112.59459ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:43.148987Z","caller":"traceutil/trace.go:171","msg":"trace[422096526] linearizableReadLoop","detail":"{readStateIndex:2001; appliedIndex:2000; }","duration":"166.257714ms","start":"2026-06-26T02:19:42.982711Z","end":"2026-06-26T02:19:43.148968Z","steps":["trace[422096526] 'read index received' (duration: 166.09408ms)","trace[422096526] 'applied index is now lower than readState.Index' (duration: 160.364µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:19:43.149119Z","caller":"traceutil/trace.go:171","msg":"trace[2077531794] transaction","detail":"{read_only:false; response_revision:1923; number_of_response:1; }","duration":"171.544323ms","start":"2026-06-26T02:19:42.97754Z","end":"2026-06-26T02:19:43.149084Z","steps":["trace[2077531794] 'process raft request' (duration: 171.313517ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:43.149185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.467328ms","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-06-26T02:19:43.149239Z","caller":"traceutil/trace.go:171","msg":"trace[990204655] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1923; }","duration":"166.561021ms","start":"2026-06-26T02:19:42.982668Z","end":"2026-06-26T02:19:43.149229Z","steps":["trace[990204655] 'agreement among raft nodes before linearized reading' (duration: 166.375207ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:19:43.360608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.715545ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T02:19:43.360678Z","caller":"traceutil/trace.go:171","msg":"trace[1970532881] linearizableReadLoop","detail":"{readStateIndex:2002; appliedIndex:2001; }","duration":"118.671887ms","start":"2026-06-26T02:19:43.241995Z","end":"2026-06-26T02:19:43.360667Z","steps":["trace[1970532881] 'read index received' (duration: 53.661µs)","trace[1970532881] 'applied index is now lower than readState.Index' (duration: 118.617426ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:19:43.360758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.761649ms","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-06-26T02:19:43.360772Z","caller":"traceutil/trace.go:171","msg":"trace[661880620] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1924; }","duration":"118.80508ms","start":"2026-06-26T02:19:43.241961Z","end":"2026-06-26T02:19:43.360766Z","steps":["trace[661880620] 'agreement among raft nodes before linearized reading' (duration: 118.733089ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:43.360861Z","caller":"traceutil/trace.go:171","msg":"trace[1019443658] transaction","detail":"{read_only:false; response_revision:1924; number_of_response:1; }","duration":"207.147204ms","start":"2026-06-26T02:19:43.153677Z","end":"2026-06-26T02:19:43.360824Z","steps":["trace[1019443658] 'process raft request' (duration: 82.163782ms)","trace[1019443658] 'compare' (duration: 124.638473ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:19:44.029465Z","caller":"traceutil/trace.go:171","msg":"trace[1268284799] transaction","detail":"{read_only:false; response_revision:1928; number_of_response:1; }","duration":"108.921579ms","start":"2026-06-26T02:19:43.920515Z","end":"2026-06-26T02:19:44.029436Z","steps":["trace[1268284799] 'process raft request' (duration: 28.489578ms)","trace[1268284799] 'compare' (duration: 80.110833ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:19:44.476975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.989321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-26T02:19:44.477095Z","caller":"traceutil/trace.go:171","msg":"trace[1881277486] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1929; }","duration":"107.172725ms","start":"2026-06-26T02:19:44.369895Z","end":"2026-06-26T02:19:44.477067Z","steps":["trace[1881277486] 'range keys from in-memory index tree' (duration: 106.750005ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:19:44.582309Z","caller":"traceutil/trace.go:171","msg":"trace[158033979] transaction","detail":"{read_only:false; response_revision:1930; number_of_response:1; }","duration":"100.82003ms","start":"2026-06-26T02:19:44.481447Z","end":"2026-06-26T02:19:44.582267Z","steps":["trace[158033979] 'process raft request' (duration: 100.655306ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:20:03.036231Z","caller":"traceutil/trace.go:171","msg":"trace[2035600925] transaction","detail":"{read_only:false; response_revision:2014; number_of_response:1; }","duration":"118.906353ms","start":"2026-06-26T02:20:02.917305Z","end":"2026-06-26T02:20:03.036211Z","steps":["trace[2035600925] 'process raft request' (duration: 95.191852ms)","trace[2035600925] 'compare' (duration: 23.635809ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:20:13.694836Z","caller":"traceutil/trace.go:171","msg":"trace[1230907190] transaction","detail":"{read_only:false; response_revision:2062; number_of_response:1; }","duration":"113.319246ms","start":"2026-06-26T02:20:13.581479Z","end":"2026-06-26T02:20:13.694799Z","steps":["trace[1230907190] 'process raft request' (duration: 61.109427ms)","trace[1230907190] 'compare' (duration: 51.952583ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:20:24.894254Z","caller":"traceutil/trace.go:171","msg":"trace[1774652433] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"204.451624ms","start":"2026-06-26T02:20:24.689767Z","end":"2026-06-26T02:20:24.894219Z","steps":["trace[1774652433] 'process raft request' (duration: 201.797279ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:20:50.352741Z","caller":"traceutil/trace.go:171","msg":"trace[1021204665] linearizableReadLoop","detail":"{readStateIndex:2320; appliedIndex:2319; }","duration":"148.638858ms","start":"2026-06-26T02:20:50.204078Z","end":"2026-06-26T02:20:50.352716Z","steps":["trace[1021204665] 'read index received' (duration: 148.483194ms)","trace[1021204665] 'applied index is now lower than readState.Index' (duration: 154.494µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T02:20:50.352795Z","caller":"traceutil/trace.go:171","msg":"trace[1588913138] transaction","detail":"{read_only:false; response_revision:2229; number_of_response:1; }","duration":"349.182194ms","start":"2026-06-26T02:20:50.003579Z","end":"2026-06-26T02:20:50.352761Z","steps":["trace[1588913138] 'process raft request' (duration: 348.972769ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:50.35293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.843373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-26T02:20:50.352961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:20:50.003539Z","time spent":"349.328858ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T02:20:50.353012Z","caller":"traceutil/trace.go:171","msg":"trace[1942574823] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2229; }","duration":"149.011967ms","start":"2026-06-26T02:20:50.20398Z","end":"2026-06-26T02:20:50.352992Z","steps":["trace[1942574823] 'agreement among raft nodes before linearized reading' (duration: 148.862933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:20:51.892132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.588913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:20:51.892228Z","caller":"traceutil/trace.go:171","msg":"trace[171209874] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:2236; }","duration":"109.744787ms","start":"2026-06-26T02:20:51.782465Z","end":"2026-06-26T02:20:51.89221Z","steps":["trace[171209874] 'count revisions from in-memory index tree' (duration: 109.47093ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:19.28422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.074986ms","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-06-26T02:21:19.284326Z","caller":"traceutil/trace.go:171","msg":"trace[1792346528] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:2384; }","duration":"240.25177ms","start":"2026-06-26T02:21:19.044053Z","end":"2026-06-26T02:21:19.284305Z","steps":["trace[1792346528] 'count revisions from in-memory index tree' (duration: 239.956413ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:21:27.091159Z","caller":"traceutil/trace.go:171","msg":"trace[103939122] linearizableReadLoop","detail":"{readStateIndex:2524; appliedIndex:2523; }","duration":"423.596544ms","start":"2026-06-26T02:21:26.667537Z","end":"2026-06-26T02:21:27.091133Z","steps":["trace[103939122] 'read index received' (duration: 423.344098ms)","trace[103939122] 'applied index is now lower than readState.Index' (duration: 251.426µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T02:21:27.091348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.866236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:21:27.091413Z","caller":"traceutil/trace.go:171","msg":"trace[1529711127] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2424; }","duration":"379.967948ms","start":"2026-06-26T02:21:26.71143Z","end":"2026-06-26T02:21:27.091398Z","steps":["trace[1529711127] 'agreement among raft nodes before linearized reading' (duration: 379.857545ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:27.091464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:26.711417Z","time spent":"380.035929ms","remote":"127.0.0.1:53424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T02:21:27.091508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.840969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-26T02:21:27.091492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.898822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-06-26T02:21:27.091591Z","caller":"traceutil/trace.go:171","msg":"trace[933311227] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2424; }","duration":"239.928841ms","start":"2026-06-26T02:21:26.851631Z","end":"2026-06-26T02:21:27.09156Z","steps":["trace[933311227] 'agreement among raft nodes before linearized reading' (duration: 239.789698ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T02:21:27.091594Z","caller":"traceutil/trace.go:171","msg":"trace[1935862887] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2424; }","duration":"424.063376ms","start":"2026-06-26T02:21:26.667504Z","end":"2026-06-26T02:21:27.091568Z","steps":["trace[1935862887] 'agreement among raft nodes before linearized reading' (duration: 423.763998ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:27.091642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:26.667486Z","time spent":"424.144688ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-26T02:21:27.09168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.50313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-26T02:21:27.091734Z","caller":"traceutil/trace.go:171","msg":"trace[1605364020] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2424; }","duration":"324.590742ms","start":"2026-06-26T02:21:26.76713Z","end":"2026-06-26T02:21:27.09172Z","steps":["trace[1605364020] 'agreement among raft nodes before linearized reading' (duration: 324.410488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:27.091773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:26.767099Z","time spent":"324.666284ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-26T02:21:27.091663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.264032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T02:21:27.091874Z","caller":"traceutil/trace.go:171","msg":"trace[683411913] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:2424; }","duration":"308.54874ms","start":"2026-06-26T02:21:26.783309Z","end":"2026-06-26T02:21:27.091858Z","steps":["trace[683411913] 'agreement among raft nodes before linearized reading' (duration: 308.176031ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:27.091988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:26.783298Z","time spent":"308.675972ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"info","ts":"2026-06-26T02:21:27.091223Z","caller":"traceutil/trace.go:171","msg":"trace[2120013246] transaction","detail":"{read_only:false; response_revision:2424; number_of_response:1; }","duration":"544.345731ms","start":"2026-06-26T02:21:26.546843Z","end":"2026-06-26T02:21:27.091188Z","steps":["trace[2120013246] 'process raft request' (duration: 544.110375ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T02:21:27.092213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T02:21:26.546826Z","time spent":"545.283753ms","remote":"127.0.0.1:53766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"}