{"level":"warn","ts":"2026-06-10T10:24:39.990746Z","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-10T10:24:39.990852Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.229: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.229:2380","--initial-cluster=instance=https://199.204.45.229:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.229:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.229: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-10T10:24:39.990946Z","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-10T10:24:39.990963Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-06-10T10:24:39.991Z","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-10T10:24:39.991826Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"]} {"level":"info","ts":"2026-06-10T10:24:39.991926Z","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.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.229: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-10T10:24:39.997918Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.729373ms"} {"level":"info","ts":"2026-06-10T10:24:40.003873Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3ba9ae53cc4335db","cluster-id":"4ad2674607ff1d60"} {"level":"info","ts":"2026-06-10T10:24:40.004017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=()"} {"level":"info","ts":"2026-06-10T10:24:40.004044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 0"} {"level":"info","ts":"2026-06-10T10:24:40.00407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3ba9ae53cc4335db [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-10T10:24:40.004093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 1"} {"level":"info","ts":"2026-06-10T10:24:40.004148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"warn","ts":"2026-06-10T10:24:40.013744Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-10T10:24:40.019231Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-10T10:24:40.020743Z","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-10T10:24:40.02273Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3ba9ae53cc4335db","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-10T10:24:40.022915Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3ba9ae53cc4335db","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-10T10:24:40.023596Z","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-10T10:24:40.023827Z","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-10T10:24:40.023857Z","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-10T10:24:40.025031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"info","ts":"2026-06-10T10:24:40.025197Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","added-peer-id":"3ba9ae53cc4335db","added-peer-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-06-10T10:24:40.027309Z","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-10T10:24:40.027471Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-06-10T10:24:40.027489Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-06-10T10:24:40.028401Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3ba9ae53cc4335db","initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-10T10:24:40.028436Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-10T10:24:40.104936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db is starting a new election at term 1"} {"level":"info","ts":"2026-06-10T10:24:40.104989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became pre-candidate at term 1"} {"level":"info","ts":"2026-06-10T10:24:40.105003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgPreVoteResp from 3ba9ae53cc4335db at term 1"} {"level":"info","ts":"2026-06-10T10:24:40.105015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became candidate at term 2"} {"level":"info","ts":"2026-06-10T10:24:40.105062Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgVoteResp from 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-06-10T10:24:40.105083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became leader at term 2"} {"level":"info","ts":"2026-06-10T10:24:40.105092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3ba9ae53cc4335db elected leader 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-06-10T10:24:40.105795Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T10:24:40.106961Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T10:24:40.107036Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T10:24:40.107055Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T10:24:40.107093Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3ba9ae53cc4335db","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.229:2379]}","request-path":"/0/members/3ba9ae53cc4335db/attributes","cluster-id":"4ad2674607ff1d60","publish-timeout":"7s"} {"level":"info","ts":"2026-06-10T10:24:40.107112Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T10:24:40.109737Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T10:24:40.111165Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.229:2379"} {"level":"info","ts":"2026-06-10T10:24:40.112092Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-10T10:24:40.112274Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-10T10:24:40.112495Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-10T10:25:10.523659Z","caller":"traceutil/trace.go:171","msg":"trace[2096979605] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"367.134936ms","start":"2026-06-10T10:25:10.15649Z","end":"2026-06-10T10:25:10.523625Z","steps":["trace[2096979605] 'process raft request' (duration: 366.971231ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:10.524252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:10.156452Z","time spent":"367.305691ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:25:10.714384Z","caller":"traceutil/trace.go:171","msg":"trace[751228178] linearizableReadLoop","detail":"{readStateIndex:461; appliedIndex:459; }","duration":"556.464443ms","start":"2026-06-10T10:25:10.157895Z","end":"2026-06-10T10:25:10.71436Z","steps":["trace[751228178] 'read index received' (duration: 365.523178ms)","trace[751228178] 'applied index is now lower than readState.Index' (duration: 190.940245ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:25:10.714521Z","caller":"traceutil/trace.go:171","msg":"trace[29736260] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"557.530187ms","start":"2026-06-10T10:25:10.156981Z","end":"2026-06-10T10:25:10.714512Z","steps":["trace[29736260] 'process raft request' (duration: 556.707571ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:10.714623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:10.156959Z","time spent":"557.588738ms","remote":"127.0.0.1:53040","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-10T10:25:10.714772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.120101ms","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-10T10:25:10.714869Z","caller":"traceutil/trace.go:171","msg":"trace[1018179576] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:441; }","duration":"239.227674ms","start":"2026-06-10T10:25:10.475623Z","end":"2026-06-10T10:25:10.714851Z","steps":["trace[1018179576] 'agreement among raft nodes before linearized reading' (duration: 239.08806ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:10.715035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.136803ms","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-10T10:25:10.7151Z","caller":"traceutil/trace.go:171","msg":"trace[2071746606] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:441; }","duration":"557.197275ms","start":"2026-06-10T10:25:10.157885Z","end":"2026-06-10T10:25:10.715082Z","steps":["trace[2071746606] 'agreement among raft nodes before linearized reading' (duration: 557.103392ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:10.715143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:10.15785Z","time spent":"557.282728ms","remote":"127.0.0.1:53040","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-10T10:25:15.253396Z","caller":"traceutil/trace.go:171","msg":"trace[992362722] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"161.134546ms","start":"2026-06-10T10:25:15.092232Z","end":"2026-06-10T10:25:15.253367Z","steps":["trace[992362722] 'process raft request' (duration: 160.678572ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:15.505375Z","caller":"traceutil/trace.go:171","msg":"trace[1784948719] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"225.757088ms","start":"2026-06-10T10:25:15.279593Z","end":"2026-06-10T10:25:15.50535Z","steps":["trace[1784948719] 'process raft request' (duration: 225.601774ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:15.516544Z","caller":"traceutil/trace.go:171","msg":"trace[945817479] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"236.068308ms","start":"2026-06-10T10:25:15.280451Z","end":"2026-06-10T10:25:15.51652Z","steps":["trace[945817479] 'process raft request' (duration: 235.918844ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:16.20423Z","caller":"traceutil/trace.go:171","msg":"trace[557439505] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"491.361678ms","start":"2026-06-10T10:25:15.71284Z","end":"2026-06-10T10:25:16.204201Z","steps":["trace[557439505] 'process raft request' (duration: 490.307856ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:16.204363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:15.712818Z","time spent":"491.485611ms","remote":"127.0.0.1:53128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":770,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T10:25:16.204625Z","caller":"traceutil/trace.go:171","msg":"trace[222460283] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"490.801431ms","start":"2026-06-10T10:25:15.71376Z","end":"2026-06-10T10:25:16.204562Z","steps":["trace[222460283] 'process raft request' (duration: 490.326367ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:16.204798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:15.713741Z","time spent":"490.982467ms","remote":"127.0.0.1:53128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":734,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T10:25:16.20488Z","caller":"traceutil/trace.go:171","msg":"trace[738243865] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"169.446026ms","start":"2026-06-10T10:25:16.035348Z","end":"2026-06-10T10:25:16.204794Z","steps":["trace[738243865] 'process raft request' (duration: 168.799456ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:18.760949Z","caller":"traceutil/trace.go:171","msg":"trace[473352124] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"978.831888ms","start":"2026-06-10T10:25:17.782092Z","end":"2026-06-10T10:25:18.760924Z","steps":["trace[473352124] 'process raft request' (duration: 978.692744ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:18.761206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:17.782074Z","time spent":"979.061944ms","remote":"127.0.0.1:52796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T10:25:18.77183Z","caller":"traceutil/trace.go:171","msg":"trace[1855560231] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"989.165929ms","start":"2026-06-10T10:25:17.78264Z","end":"2026-06-10T10:25:18.771806Z","steps":["trace[1855560231] 'process raft request' (duration: 988.930892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:18.772027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:17.782619Z","time spent":"989.324394ms","remote":"127.0.0.1:52796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T10:25:18.772096Z","caller":"traceutil/trace.go:171","msg":"trace[1617621509] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"958.123393ms","start":"2026-06-10T10:25:17.813963Z","end":"2026-06-10T10:25:18.772087Z","steps":["trace[1617621509] 'process raft request' (duration: 957.840964ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:18.772224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:17.813945Z","time spent":"958.207496ms","remote":"127.0.0.1:52796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T10:25:18.77221Z","caller":"traceutil/trace.go:171","msg":"trace[245099838] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"958.148874ms","start":"2026-06-10T10:25:17.814034Z","end":"2026-06-10T10:25:18.772183Z","steps":["trace[245099838] 'process raft request' (duration: 957.812134ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:18.772355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:17.814029Z","time spent":"958.254737ms","remote":"127.0.0.1:52796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T10:25:18.772364Z","caller":"traceutil/trace.go:171","msg":"trace[1913409178] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"964.856645ms","start":"2026-06-10T10:25:17.807484Z","end":"2026-06-10T10:25:18.772341Z","steps":["trace[1913409178] 'process raft request' (duration: 964.291238ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:18.772039Z","caller":"traceutil/trace.go:171","msg":"trace[549230776] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"972.440725ms","start":"2026-06-10T10:25:17.799469Z","end":"2026-06-10T10:25:18.77191Z","steps":["trace[549230776] 'process raft request' (duration: 972.228398ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:18.771875Z","caller":"traceutil/trace.go:171","msg":"trace[2017161807] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"971.95153ms","start":"2026-06-10T10:25:17.799905Z","end":"2026-06-10T10:25:18.771857Z","steps":["trace[2017161807] 'process raft request' (duration: 971.823376ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:18.77243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:17.807459Z","time spent":"964.942358ms","remote":"127.0.0.1:52796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T10:25:18.772509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:17.799897Z","time spent":"972.584789ms","remote":"127.0.0.1:52796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T10:25:18.772512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:17.79945Z","time spent":"973.007691ms","remote":"127.0.0.1:52796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T10:25:18.772616Z","caller":"traceutil/trace.go:171","msg":"trace[1117788477] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"957.938788ms","start":"2026-06-10T10:25:17.814665Z","end":"2026-06-10T10:25:18.772604Z","steps":["trace[1117788477] 'process raft request' (duration: 957.203676ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:18.772631Z","caller":"traceutil/trace.go:171","msg":"trace[898386167] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"956.220935ms","start":"2026-06-10T10:25:17.816397Z","end":"2026-06-10T10:25:18.772618Z","steps":["trace[898386167] 'process raft request' (duration: 955.678589ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:18.772655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:17.814661Z","time spent":"957.976789ms","remote":"127.0.0.1:52796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T10:25:18.772685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:17.816387Z","time spent":"956.272716ms","remote":"127.0.0.1:52796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T10:25:18.772718Z","caller":"traceutil/trace.go:171","msg":"trace[948120275] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"952.891074ms","start":"2026-06-10T10:25:17.819817Z","end":"2026-06-10T10:25:18.772708Z","steps":["trace[948120275] 'process raft request' (duration: 952.419799ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:18.77275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:17.819808Z","time spent":"952.928306ms","remote":"127.0.0.1:52796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T10:25:18.772916Z","caller":"traceutil/trace.go:171","msg":"trace[517581422] linearizableReadLoop","detail":"{readStateIndex:525; appliedIndex:514; }","duration":"213.514797ms","start":"2026-06-10T10:25:18.559383Z","end":"2026-06-10T10:25:18.772897Z","steps":["trace[517581422] 'read index received' (duration: 201.68534ms)","trace[517581422] 'applied index is now lower than readState.Index' (duration: 11.828847ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:25:18.772938Z","caller":"traceutil/trace.go:171","msg":"trace[1866452530] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"921.852087ms","start":"2026-06-10T10:25:17.851072Z","end":"2026-06-10T10:25:18.772924Z","steps":["trace[1866452530] 'process raft request' (duration: 921.447995ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:18.773013Z","caller":"traceutil/trace.go:171","msg":"trace[256545582] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"820.689112ms","start":"2026-06-10T10:25:17.952317Z","end":"2026-06-10T10:25:18.773006Z","steps":["trace[256545582] 'process raft request' (duration: 820.490737ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:18.773005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:17.851045Z","time spent":"921.93241ms","remote":"127.0.0.1:52796","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-10T10:25:18.773081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:17.952284Z","time spent":"820.745693ms","remote":"127.0.0.1:52796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T10:25:18.773241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.858509ms","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-10T10:25:18.773273Z","caller":"traceutil/trace.go:171","msg":"trace[161433306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:504; }","duration":"213.935571ms","start":"2026-06-10T10:25:18.559329Z","end":"2026-06-10T10:25:18.773265Z","steps":["trace[161433306] 'agreement among raft nodes before linearized reading' (duration: 213.743264ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:21.044214Z","caller":"traceutil/trace.go:171","msg":"trace[1274661541] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"226.726247ms","start":"2026-06-10T10:25:20.81747Z","end":"2026-06-10T10:25:21.044196Z","steps":["trace[1274661541] 'read index received' (duration: 226.552382ms)","trace[1274661541] 'applied index is now lower than readState.Index' (duration: 173.085µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:25:21.04442Z","caller":"traceutil/trace.go:171","msg":"trace[1440144908] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"233.972096ms","start":"2026-06-10T10:25:20.810439Z","end":"2026-06-10T10:25:21.044411Z","steps":["trace[1440144908] 'process raft request' (duration: 233.637586ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:21.044614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.107399ms","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-10T10:25:21.044635Z","caller":"traceutil/trace.go:171","msg":"trace[1576021217] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:572; }","duration":"227.193542ms","start":"2026-06-10T10:25:20.817435Z","end":"2026-06-10T10:25:21.044629Z","steps":["trace[1576021217] 'agreement among raft nodes before linearized reading' (duration: 227.085049ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:21.044764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.977734ms","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-10T10:25:21.04479Z","caller":"traceutil/trace.go:171","msg":"trace[1084168354] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:572; }","duration":"226.013275ms","start":"2026-06-10T10:25:20.818768Z","end":"2026-06-10T10:25:21.044781Z","steps":["trace[1084168354] 'agreement among raft nodes before linearized reading' (duration: 225.941073ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:21.044825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.04738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:25:21.044843Z","caller":"traceutil/trace.go:171","msg":"trace[1688686742] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:572; }","duration":"142.079991ms","start":"2026-06-10T10:25:20.902758Z","end":"2026-06-10T10:25:21.044838Z","steps":["trace[1688686742] 'agreement among raft nodes before linearized reading' (duration: 142.04755ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:21.044868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.705242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:25:21.044884Z","caller":"traceutil/trace.go:171","msg":"trace[912625] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:572; }","duration":"162.737674ms","start":"2026-06-10T10:25:20.88214Z","end":"2026-06-10T10:25:21.044877Z","steps":["trace[912625] 'agreement among raft nodes before linearized reading' (duration: 162.712633ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:21.044957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.854757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:25:21.04497Z","caller":"traceutil/trace.go:171","msg":"trace[1550287258] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:572; }","duration":"162.891008ms","start":"2026-06-10T10:25:20.882074Z","end":"2026-06-10T10:25:21.044965Z","steps":["trace[1550287258] 'agreement among raft nodes before linearized reading' (duration: 162.871228ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:21.045073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.99281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:25:21.04509Z","caller":"traceutil/trace.go:171","msg":"trace[277074550] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:572; }","duration":"201.017921ms","start":"2026-06-10T10:25:20.844067Z","end":"2026-06-10T10:25:21.045085Z","steps":["trace[277074550] 'agreement among raft nodes before linearized reading' (duration: 200.9897ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:21.045162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.081675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:25:21.045175Z","caller":"traceutil/trace.go:171","msg":"trace[2035719097] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:572; }","duration":"163.109885ms","start":"2026-06-10T10:25:20.882061Z","end":"2026-06-10T10:25:21.045171Z","steps":["trace[2035719097] 'agreement among raft nodes before linearized reading' (duration: 163.089305ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:21.045172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.872179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:25:21.045197Z","caller":"traceutil/trace.go:171","msg":"trace[1009861322] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:572; }","duration":"112.90646ms","start":"2026-06-10T10:25:20.932286Z","end":"2026-06-10T10:25:21.045192Z","steps":["trace[1009861322] 'agreement among raft nodes before linearized reading' (duration: 112.870719ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:21.045221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.015167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:25:21.045232Z","caller":"traceutil/trace.go:171","msg":"trace[696695638] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:572; }","duration":"181.050908ms","start":"2026-06-10T10:25:20.864178Z","end":"2026-06-10T10:25:21.045229Z","steps":["trace[696695638] 'agreement among raft nodes before linearized reading' (duration: 181.034088ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:21.045282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.326832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:25:21.045299Z","caller":"traceutil/trace.go:171","msg":"trace[1052085182] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:572; }","duration":"113.351823ms","start":"2026-06-10T10:25:20.931943Z","end":"2026-06-10T10:25:21.045295Z","steps":["trace[1052085182] 'agreement among raft nodes before linearized reading' (duration: 113.326272ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:21.045337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.75879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:25:21.045369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.871845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:25:21.04538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.676746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:25:21.045384Z","caller":"traceutil/trace.go:171","msg":"trace[1928574424] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:572; }","duration":"141.894125ms","start":"2026-06-10T10:25:20.903486Z","end":"2026-06-10T10:25:21.04538Z","steps":["trace[1928574424] 'agreement among raft nodes before linearized reading' (duration: 141.874255ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:21.045394Z","caller":"traceutil/trace.go:171","msg":"trace[874657729] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:572; }","duration":"183.705447ms","start":"2026-06-10T10:25:20.861685Z","end":"2026-06-10T10:25:21.04539Z","steps":["trace[874657729] 'agreement among raft nodes before linearized reading' (duration: 183.680226ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:21.04543Z","caller":"traceutil/trace.go:171","msg":"trace[1555507288] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:572; }","duration":"183.873313ms","start":"2026-06-10T10:25:20.861504Z","end":"2026-06-10T10:25:21.045377Z","steps":["trace[1555507288] 'agreement among raft nodes before linearized reading' (duration: 183.76228ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:21.045351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.415185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:25:21.045621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.157999ms","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-10T10:25:21.045639Z","caller":"traceutil/trace.go:171","msg":"trace[686114144] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:572; }","duration":"226.194471ms","start":"2026-06-10T10:25:20.819441Z","end":"2026-06-10T10:25:21.045635Z","steps":["trace[686114144] 'agreement among raft nodes before linearized reading' (duration: 226.146839ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:21.045621Z","caller":"traceutil/trace.go:171","msg":"trace[370175788] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:572; }","duration":"113.696313ms","start":"2026-06-10T10:25:20.931917Z","end":"2026-06-10T10:25:21.045613Z","steps":["trace[370175788] 'agreement among raft nodes before linearized reading' (duration: 113.423885ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:21.045437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.517153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:25:21.045699Z","caller":"traceutil/trace.go:171","msg":"trace[738668419] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:572; }","duration":"142.77889ms","start":"2026-06-10T10:25:20.902915Z","end":"2026-06-10T10:25:21.045694Z","steps":["trace[738668419] 'agreement among raft nodes before linearized reading' (duration: 142.511233ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:21.045667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.6655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:25:21.045806Z","caller":"traceutil/trace.go:171","msg":"trace[1114935022] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:572; }","duration":"201.827696ms","start":"2026-06-10T10:25:20.843973Z","end":"2026-06-10T10:25:21.045801Z","steps":["trace[1114935022] 'agreement among raft nodes before linearized reading' (duration: 201.67862ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:23.048161Z","caller":"traceutil/trace.go:171","msg":"trace[1298526922] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"105.557867ms","start":"2026-06-10T10:25:22.94258Z","end":"2026-06-10T10:25:23.048137Z","steps":["trace[1298526922] 'read index received' (duration: 104.815565ms)","trace[1298526922] 'applied index is now lower than readState.Index' (duration: 741.452µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:25:23.048211Z","caller":"traceutil/trace.go:171","msg":"trace[729300030] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"135.067729ms","start":"2026-06-10T10:25:22.91311Z","end":"2026-06-10T10:25:23.048178Z","steps":["trace[729300030] 'process raft request' (duration: 134.541853ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:23.048307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.687981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:25:23.048343Z","caller":"traceutil/trace.go:171","msg":"trace[1779864451] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:582; }","duration":"105.777584ms","start":"2026-06-10T10:25:22.942552Z","end":"2026-06-10T10:25:23.04833Z","steps":["trace[1779864451] 'agreement among raft nodes before linearized reading' (duration: 105.689411ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:23.194066Z","caller":"traceutil/trace.go:171","msg":"trace[42219436] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"139.848104ms","start":"2026-06-10T10:25:23.054184Z","end":"2026-06-10T10:25:23.194032Z","steps":["trace[42219436] 'process raft request' (duration: 86.573415ms)","trace[42219436] 'compare' (duration: 53.141045ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:25:23.19914Z","caller":"traceutil/trace.go:171","msg":"trace[191562513] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:609; }","duration":"115.116556ms","start":"2026-06-10T10:25:23.084011Z","end":"2026-06-10T10:25:23.199127Z","steps":["trace[191562513] 'read index received' (duration: 56.755564ms)","trace[191562513] 'applied index is now lower than readState.Index' (duration: 58.360302ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:25:23.199218Z","caller":"traceutil/trace.go:171","msg":"trace[1328541869] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"119.448036ms","start":"2026-06-10T10:25:23.079741Z","end":"2026-06-10T10:25:23.199189Z","steps":["trace[1328541869] 'process raft request' (duration: 119.305612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:23.199472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.916378ms","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-10T10:25:23.199454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.206878ms","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-10T10:25:23.199503Z","caller":"traceutil/trace.go:171","msg":"trace[355907128] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:585; }","duration":"105.97518ms","start":"2026-06-10T10:25:23.093518Z","end":"2026-06-10T10:25:23.199493Z","steps":["trace[355907128] 'agreement among raft nodes before linearized reading' (duration: 105.895648ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:23.199523Z","caller":"traceutil/trace.go:171","msg":"trace[1184591791] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:585; }","duration":"107.29329ms","start":"2026-06-10T10:25:23.092211Z","end":"2026-06-10T10:25:23.199505Z","steps":["trace[1184591791] 'agreement among raft nodes before linearized reading' (duration: 107.084464ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:23.19952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.473978ms","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-10T10:25:23.199585Z","caller":"traceutil/trace.go:171","msg":"trace[1979511156] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:585; }","duration":"115.57632ms","start":"2026-06-10T10:25:23.08399Z","end":"2026-06-10T10:25:23.199567Z","steps":["trace[1979511156] 'agreement among raft nodes before linearized reading' (duration: 115.347353ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:24.538869Z","caller":"traceutil/trace.go:171","msg":"trace[1611687754] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"117.275002ms","start":"2026-06-10T10:25:24.421566Z","end":"2026-06-10T10:25:24.538841Z","steps":["trace[1611687754] 'process raft request' (duration: 104.635541ms)","trace[1611687754] 'compare' (duration: 12.499427ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:25:25.106443Z","caller":"traceutil/trace.go:171","msg":"trace[1411145209] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"152.063803ms","start":"2026-06-10T10:25:24.954354Z","end":"2026-06-10T10:25:25.106418Z","steps":["trace[1411145209] 'process raft request' (duration: 151.509786ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:25.462221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.176962ms","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-10T10:25:25.462336Z","caller":"traceutil/trace.go:171","msg":"trace[1462698258] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:595; }","duration":"232.325776ms","start":"2026-06-10T10:25:25.22998Z","end":"2026-06-10T10:25:25.462306Z","steps":["trace[1462698258] 'range keys from in-memory index tree' (duration: 232.006596ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:25.462305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.352853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-10T10:25:25.462354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.121468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:25:25.462388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.314426ms","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-10T10:25:25.462419Z","caller":"traceutil/trace.go:171","msg":"trace[1404220160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:595; }","duration":"264.524158ms","start":"2026-06-10T10:25:25.197866Z","end":"2026-06-10T10:25:25.462391Z","steps":["trace[1404220160] 'range keys from in-memory index tree' (duration: 264.133367ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:25.46244Z","caller":"traceutil/trace.go:171","msg":"trace[1320629995] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:595; }","duration":"237.409849ms","start":"2026-06-10T10:25:25.225014Z","end":"2026-06-10T10:25:25.462423Z","steps":["trace[1320629995] 'range keys from in-memory index tree' (duration: 237.135971ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:25.462445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.692437ms","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-10T10:25:25.462464Z","caller":"traceutil/trace.go:171","msg":"trace[637664365] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:595; }","duration":"274.275603ms","start":"2026-06-10T10:25:25.188144Z","end":"2026-06-10T10:25:25.462419Z","steps":["trace[637664365] 'range keys from in-memory index tree' (duration: 273.981713ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:25.462507Z","caller":"traceutil/trace.go:171","msg":"trace[2037446160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:595; }","duration":"232.79984ms","start":"2026-06-10T10:25:25.229688Z","end":"2026-06-10T10:25:25.462488Z","steps":["trace[2037446160] 'range keys from in-memory index tree' (duration: 232.517342ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:26.322823Z","caller":"traceutil/trace.go:171","msg":"trace[1090821458] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:630; }","duration":"379.443798ms","start":"2026-06-10T10:25:25.943354Z","end":"2026-06-10T10:25:26.322798Z","steps":["trace[1090821458] 'read index received' (duration: 378.644714ms)","trace[1090821458] 'applied index is now lower than readState.Index' (duration: 798.004µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:25:26.323052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.676576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:25:26.323098Z","caller":"traceutil/trace.go:171","msg":"trace[1737452169] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"379.785409ms","start":"2026-06-10T10:25:25.943299Z","end":"2026-06-10T10:25:26.323085Z","steps":["trace[1737452169] 'agreement among raft nodes before linearized reading' (duration: 379.696116ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:26.323133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:25.943275Z","time spent":"379.850451ms","remote":"127.0.0.1:52750","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-10T10:25:26.323033Z","caller":"traceutil/trace.go:171","msg":"trace[602457209] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"459.449204ms","start":"2026-06-10T10:25:25.863549Z","end":"2026-06-10T10:25:26.322999Z","steps":["trace[602457209] 'process raft request' (duration: 458.726902ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:26.323334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:25.863521Z","time spent":"459.710332ms","remote":"127.0.0.1:52862","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:25:26.573586Z","caller":"traceutil/trace.go:171","msg":"trace[652000737] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"188.545983ms","start":"2026-06-10T10:25:26.385019Z","end":"2026-06-10T10:25:26.573565Z","steps":["trace[652000737] 'process raft request' (duration: 169.843949ms)","trace[652000737] 'compare' (duration: 18.490838ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:25:26.573584Z","caller":"traceutil/trace.go:171","msg":"trace[942868311] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:631; }","duration":"155.362372ms","start":"2026-06-10T10:25:26.418184Z","end":"2026-06-10T10:25:26.573547Z","steps":["trace[942868311] 'read index received' (duration: 136.73274ms)","trace[942868311] 'applied index is now lower than readState.Index' (duration: 18.628692ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:25:26.573997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.790205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6586z\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-10T10:25:26.574215Z","caller":"traceutil/trace.go:171","msg":"trace[1898002280] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"189.142261ms","start":"2026-06-10T10:25:26.38502Z","end":"2026-06-10T10:25:26.574162Z","steps":["trace[1898002280] 'process raft request' (duration: 188.464051ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:26.574348Z","caller":"traceutil/trace.go:171","msg":"trace[192080672] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6586z; range_end:; response_count:1; response_revision:605; }","duration":"156.126604ms","start":"2026-06-10T10:25:26.418136Z","end":"2026-06-10T10:25:26.574263Z","steps":["trace[192080672] 'agreement among raft nodes before linearized reading' (duration: 155.488045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:27.44451Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869987225586002,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T10:25:27.945203Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869987225586002,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T10:25:28.012547Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.424972551s","expected-duration":"1s"} {"level":"info","ts":"2026-06-10T10:25:28.045409Z","caller":"traceutil/trace.go:171","msg":"trace[1410564899] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"1.457953167s","start":"2026-06-10T10:25:26.587431Z","end":"2026-06-10T10:25:28.045384Z","steps":["trace[1410564899] 'process raft request' (duration: 1.42561636s)","trace[1410564899] 'compare' (duration: 31.014147ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:25:28.045545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:26.587401Z","time spent":"1.45807417s","remote":"127.0.0.1:52962","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-10T10:25:28.05945Z","caller":"traceutil/trace.go:171","msg":"trace[661122317] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:633; }","duration":"1.115606469s","start":"2026-06-10T10:25:26.943814Z","end":"2026-06-10T10:25:28.05942Z","steps":["trace[661122317] 'read index received' (duration: 1.069208967s)","trace[661122317] 'applied index is now lower than readState.Index' (duration: 46.396632ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:25:28.059566Z","caller":"traceutil/trace.go:171","msg":"trace[1470530406] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"1.084323344s","start":"2026-06-10T10:25:26.975214Z","end":"2026-06-10T10:25:28.059538Z","steps":["trace[1470530406] 'process raft request' (duration: 1.083780187s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:28.059611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.115775113s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:25:28.059637Z","caller":"traceutil/trace.go:171","msg":"trace[470009257] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:607; }","duration":"1.115855957s","start":"2026-06-10T10:25:26.943773Z","end":"2026-06-10T10:25:28.059629Z","steps":["trace[470009257] 'agreement among raft nodes before linearized reading' (duration: 1.115774814s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:28.059662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:26.943759Z","time spent":"1.115897777s","remote":"127.0.0.1:52750","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-10T10:25:28.059719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:26.975182Z","time spent":"1.084448078s","remote":"127.0.0.1:52862","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:25:28.059711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.054947ms","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-10T10:25:28.059759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.767848ms","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-10T10:25:28.059777Z","caller":"traceutil/trace.go:171","msg":"trace[90350749] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:607; }","duration":"585.16568ms","start":"2026-06-10T10:25:27.474593Z","end":"2026-06-10T10:25:28.059759Z","steps":["trace[90350749] 'agreement among raft nodes before linearized reading' (duration: 584.977355ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:28.059791Z","caller":"traceutil/trace.go:171","msg":"trace[519360948] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:607; }","duration":"582.82269ms","start":"2026-06-10T10:25:27.476959Z","end":"2026-06-10T10:25:28.059782Z","steps":["trace[519360948] 'agreement among raft nodes before linearized reading' (duration: 582.699116ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:28.05981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:27.474574Z","time spent":"585.229583ms","remote":"127.0.0.1:53040","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-10T10:25:28.059817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:27.476946Z","time spent":"582.865541ms","remote":"127.0.0.1:53040","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-10T10:25:28.060029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.693725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-10T10:25:28.060119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.764629ms","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-10T10:25:28.060145Z","caller":"traceutil/trace.go:171","msg":"trace[1880677921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:607; }","duration":"583.81015ms","start":"2026-06-10T10:25:27.476327Z","end":"2026-06-10T10:25:28.060138Z","steps":["trace[1880677921] 'agreement among raft nodes before linearized reading' (duration: 583.725688ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:28.060164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:27.476301Z","time spent":"583.858931ms","remote":"127.0.0.1:53040","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-10T10:25:28.060157Z","caller":"traceutil/trace.go:171","msg":"trace[1077597173] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:607; }","duration":"583.867762ms","start":"2026-06-10T10:25:27.476256Z","end":"2026-06-10T10:25:28.060124Z","steps":["trace[1077597173] 'agreement among raft nodes before linearized reading' (duration: 583.467889ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:28.060236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:27.476246Z","time spent":"583.978185ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-10T10:25:29.874553Z","caller":"traceutil/trace.go:171","msg":"trace[934493472] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"188.44686ms","start":"2026-06-10T10:25:29.68608Z","end":"2026-06-10T10:25:29.874527Z","steps":["trace[934493472] 'process raft request' (duration: 188.300046ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:43.254158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.214005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:25:43.254261Z","caller":"traceutil/trace.go:171","msg":"trace[890275721] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:770; }","duration":"309.392921ms","start":"2026-06-10T10:25:42.944848Z","end":"2026-06-10T10:25:43.254241Z","steps":["trace[890275721] 'range keys from in-memory index tree' (duration: 309.110533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:43.254307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:42.944817Z","time spent":"309.479514ms","remote":"127.0.0.1:52750","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-10T10:25:44.002894Z","caller":"traceutil/trace.go:171","msg":"trace[1617707748] linearizableReadLoop","detail":"{readStateIndex:804; appliedIndex:803; }","duration":"450.958892ms","start":"2026-06-10T10:25:43.551899Z","end":"2026-06-10T10:25:44.002858Z","steps":["trace[1617707748] 'read index received' (duration: 450.770497ms)","trace[1617707748] 'applied index is now lower than readState.Index' (duration: 187.355µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:25:44.002978Z","caller":"traceutil/trace.go:171","msg":"trace[496754886] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"458.868338ms","start":"2026-06-10T10:25:43.544042Z","end":"2026-06-10T10:25:44.00291Z","steps":["trace[496754886] 'process raft request' (duration: 458.665473ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:44.003203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:43.544013Z","time spent":"459.018393ms","remote":"127.0.0.1:53014","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-10T10:25:44.003351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.394484ms","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-10T10:25:44.003397Z","caller":"traceutil/trace.go:171","msg":"trace[1314316432] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:771; }","duration":"451.522528ms","start":"2026-06-10T10:25:43.551861Z","end":"2026-06-10T10:25:44.003383Z","steps":["trace[1314316432] 'agreement among raft nodes before linearized reading' (duration: 451.145507ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:44.004703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:43.551841Z","time spent":"451.646241ms","remote":"127.0.0.1:53040","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":"info","ts":"2026-06-10T10:25:44.044511Z","caller":"traceutil/trace.go:171","msg":"trace[1353166298] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"436.532507ms","start":"2026-06-10T10:25:43.607953Z","end":"2026-06-10T10:25:44.044486Z","steps":["trace[1353166298] 'process raft request' (duration: 436.046384ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:44.044765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:43.607925Z","time spent":"436.746653ms","remote":"127.0.0.1:53040","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-10T10:25:44.045199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.413185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-10T10:25:44.045264Z","caller":"traceutil/trace.go:171","msg":"trace[1028334056] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:772; }","duration":"462.523487ms","start":"2026-06-10T10:25:43.582728Z","end":"2026-06-10T10:25:44.045251Z","steps":["trace[1028334056] 'agreement among raft nodes before linearized reading' (duration: 461.725286ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:44.045367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:25:43.582704Z","time spent":"462.650752ms","remote":"127.0.0.1:52790","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.229\" "} {"level":"info","ts":"2026-06-10T10:25:51.917065Z","caller":"traceutil/trace.go:171","msg":"trace[1905394941] transaction","detail":"{read_only:false; response_revision:852; number_of_response:1; }","duration":"198.817207ms","start":"2026-06-10T10:25:51.71822Z","end":"2026-06-10T10:25:51.917038Z","steps":["trace[1905394941] 'process raft request' (duration: 198.634153ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:51.939145Z","caller":"traceutil/trace.go:171","msg":"trace[562050024] transaction","detail":"{read_only:false; response_revision:853; number_of_response:1; }","duration":"170.898643ms","start":"2026-06-10T10:25:51.768198Z","end":"2026-06-10T10:25:51.939097Z","steps":["trace[562050024] 'process raft request' (duration: 170.717978ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:03.054047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.771817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:26:03.05421Z","caller":"traceutil/trace.go:171","msg":"trace[549356310] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:931; }","duration":"112.004303ms","start":"2026-06-10T10:26:02.942184Z","end":"2026-06-10T10:26:03.054188Z","steps":["trace[549356310] 'range keys from in-memory index tree' (duration: 111.605022ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:19.079082Z","caller":"traceutil/trace.go:171","msg":"trace[1528382854] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"110.701407ms","start":"2026-06-10T10:26:18.968323Z","end":"2026-06-10T10:26:19.079024Z","steps":["trace[1528382854] 'process raft request' (duration: 110.444329ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:20.838794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.619361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:26:20.838916Z","caller":"traceutil/trace.go:171","msg":"trace[37093649] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:990; }","duration":"228.831777ms","start":"2026-06-10T10:26:20.61006Z","end":"2026-06-10T10:26:20.838892Z","steps":["trace[37093649] 'count revisions from in-memory index tree' (duration: 228.473968ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:20.839358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.575526ms","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-10T10:26:20.839417Z","caller":"traceutil/trace.go:171","msg":"trace[1563314121] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:990; }","duration":"245.651098ms","start":"2026-06-10T10:26:20.593754Z","end":"2026-06-10T10:26:20.839405Z","steps":["trace[1563314121] 'range keys from in-memory index tree' (duration: 244.829295ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:20.83966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.028385ms","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-10T10:26:20.839799Z","caller":"traceutil/trace.go:171","msg":"trace[1005879195] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:990; }","duration":"300.241891ms","start":"2026-06-10T10:26:20.539527Z","end":"2026-06-10T10:26:20.839769Z","steps":["trace[1005879195] 'range keys from in-memory index tree' (duration: 298.965166ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:20.839868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:20.539498Z","time spent":"300.356193ms","remote":"127.0.0.1:53040","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-10T10:26:20.839873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.584863ms","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-10T10:26:20.839956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.393408ms","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-10T10:26:20.839963Z","caller":"traceutil/trace.go:171","msg":"trace[1837793643] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:990; }","duration":"246.716167ms","start":"2026-06-10T10:26:20.59323Z","end":"2026-06-10T10:26:20.839947Z","steps":["trace[1837793643] 'range keys from in-memory index tree' (duration: 245.336749ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:20.839998Z","caller":"traceutil/trace.go:171","msg":"trace[759631027] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:990; }","duration":"246.44557ms","start":"2026-06-10T10:26:20.593539Z","end":"2026-06-10T10:26:20.839984Z","steps":["trace[759631027] 'range keys from in-memory index tree' (duration: 245.265288ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:27.018008Z","caller":"traceutil/trace.go:171","msg":"trace[902241299] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"142.150617ms","start":"2026-06-10T10:26:26.875819Z","end":"2026-06-10T10:26:27.017969Z","steps":["trace[902241299] 'process raft request' (duration: 78.704972ms)","trace[902241299] 'compare' (duration: 63.133686ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:26:27.01804Z","caller":"traceutil/trace.go:171","msg":"trace[340950237] linearizableReadLoop","detail":"{readStateIndex:1057; appliedIndex:1056; }","duration":"141.309225ms","start":"2026-06-10T10:26:26.876699Z","end":"2026-06-10T10:26:27.018009Z","steps":["trace[340950237] 'read index received' (duration: 77.837499ms)","trace[340950237] 'applied index is now lower than readState.Index' (duration: 63.470536ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:26:27.0183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.35663ms","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-10T10:26:27.018379Z","caller":"traceutil/trace.go:171","msg":"trace[819047581] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"138.23168ms","start":"2026-06-10T10:26:26.880129Z","end":"2026-06-10T10:26:27.018361Z","steps":["trace[819047581] 'process raft request' (duration: 137.777948ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:27.018383Z","caller":"traceutil/trace.go:171","msg":"trace[1995077525] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1012; }","duration":"143.458653ms","start":"2026-06-10T10:26:26.87491Z","end":"2026-06-10T10:26:27.018368Z","steps":["trace[1995077525] 'agreement among raft nodes before linearized reading' (duration: 143.198796ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:27.260985Z","caller":"traceutil/trace.go:171","msg":"trace[664452723] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"155.914584ms","start":"2026-06-10T10:26:27.105045Z","end":"2026-06-10T10:26:27.260959Z","steps":["trace[664452723] 'process raft request' (duration: 78.6635ms)","trace[664452723] 'compare' (duration: 77.12335ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:26:45.047327Z","caller":"traceutil/trace.go:171","msg":"trace[2132200430] linearizableReadLoop","detail":"{readStateIndex:1118; appliedIndex:1117; }","duration":"385.505238ms","start":"2026-06-10T10:26:44.661787Z","end":"2026-06-10T10:26:45.047293Z","steps":["trace[2132200430] 'read index received' (duration: 385.281183ms)","trace[2132200430] 'applied index is now lower than readState.Index' (duration: 222.875µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:26:45.047393Z","caller":"traceutil/trace.go:171","msg":"trace[1307556000] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"396.760535ms","start":"2026-06-10T10:26:44.650589Z","end":"2026-06-10T10:26:45.047349Z","steps":["trace[1307556000] 'process raft request' (duration: 396.541419ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:45.047483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.674143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:26:45.047522Z","caller":"traceutil/trace.go:171","msg":"trace[655157668] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1069; }","duration":"385.781436ms","start":"2026-06-10T10:26:44.66173Z","end":"2026-06-10T10:26:45.047511Z","steps":["trace[655157668] 'agreement among raft nodes before linearized reading' (duration: 385.688983ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:45.047529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.209575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:26:45.047547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:44.66169Z","time spent":"385.850337ms","remote":"127.0.0.1:36412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"info","ts":"2026-06-10T10:26:45.047579Z","caller":"traceutil/trace.go:171","msg":"trace[1947013734] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1069; }","duration":"106.307888ms","start":"2026-06-10T10:26:44.941254Z","end":"2026-06-10T10:26:45.047562Z","steps":["trace[1947013734] 'agreement among raft nodes before linearized reading' (duration: 106.216136ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:45.047573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:44.650561Z","time spent":"396.92394ms","remote":"127.0.0.1:53040","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-10T10:26:45.597773Z","caller":"traceutil/trace.go:171","msg":"trace[1848149676] linearizableReadLoop","detail":"{readStateIndex:1119; appliedIndex:1119; }","duration":"489.494286ms","start":"2026-06-10T10:26:45.108245Z","end":"2026-06-10T10:26:45.597739Z","steps":["trace[1848149676] 'read index received' (duration: 489.456865ms)","trace[1848149676] 'applied index is now lower than readState.Index' (duration: 34.951µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:26:45.597781Z","caller":"traceutil/trace.go:171","msg":"trace[690832704] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"546.008117ms","start":"2026-06-10T10:26:45.051734Z","end":"2026-06-10T10:26:45.597742Z","steps":["trace[690832704] 'process raft request' (duration: 545.797891ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:45.597971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:45.051721Z","time spent":"546.15076ms","remote":"127.0.0.1:53040","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-10T10:26:45.598056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.780013ms","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-10T10:26:45.598085Z","caller":"traceutil/trace.go:171","msg":"trace[1466213325] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1070; }","duration":"489.862624ms","start":"2026-06-10T10:26:45.108213Z","end":"2026-06-10T10:26:45.598076Z","steps":["trace[1466213325] 'agreement among raft nodes before linearized reading' (duration: 489.659249ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:45.598117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:45.108199Z","time spent":"489.908266ms","remote":"127.0.0.1:53040","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-10T10:26:45.70483Z","caller":"traceutil/trace.go:171","msg":"trace[1639828301] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"430.510897ms","start":"2026-06-10T10:26:45.274297Z","end":"2026-06-10T10:26:45.704808Z","steps":["trace[1639828301] 'process raft request' (duration: 419.488646ms)","trace[1639828301] 'compare' (duration: 10.868476ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:26:45.704993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:45.274277Z","time spent":"430.63026ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:26:45.705015Z","caller":"traceutil/trace.go:171","msg":"trace[1961188258] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"379.280754ms","start":"2026-06-10T10:26:45.325706Z","end":"2026-06-10T10:26:45.704987Z","steps":["trace[1961188258] 'process raft request' (duration: 379.065468ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:45.705132Z","caller":"traceutil/trace.go:171","msg":"trace[149168233] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"103.152784ms","start":"2026-06-10T10:26:45.601964Z","end":"2026-06-10T10:26:45.705117Z","steps":["trace[149168233] 'process raft request' (duration: 103.01923ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:45.705148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:45.325681Z","time spent":"379.395558ms","remote":"127.0.0.1:53040","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-10T10:26:45.705187Z","caller":"traceutil/trace.go:171","msg":"trace[1831806414] linearizableReadLoop","detail":"{readStateIndex:1121; appliedIndex:1119; }","duration":"107.288933ms","start":"2026-06-10T10:26:45.597836Z","end":"2026-06-10T10:26:45.705125Z","steps":["trace[1831806414] 'read index received' (duration: 95.863862ms)","trace[1831806414] 'applied index is now lower than readState.Index' (duration: 11.417311ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:26:45.705271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.294538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:26:45.705295Z","caller":"traceutil/trace.go:171","msg":"trace[1302093676] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1073; }","duration":"220.36957ms","start":"2026-06-10T10:26:45.484919Z","end":"2026-06-10T10:26:45.705289Z","steps":["trace[1302093676] 'agreement among raft nodes before linearized reading' (duration: 220.320869ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:45.705343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-10T10:26:45.705351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.600324ms","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-10T10:26:45.705377Z","caller":"traceutil/trace.go:171","msg":"trace[1717831609] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1073; }","duration":"591.291382ms","start":"2026-06-10T10:26:45.114078Z","end":"2026-06-10T10:26:45.705369Z","steps":["trace[1717831609] 'agreement among raft nodes before linearized reading' (duration: 591.194669ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:45.705381Z","caller":"traceutil/trace.go:171","msg":"trace[792164530] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1073; }","duration":"551.693697ms","start":"2026-06-10T10:26:45.15368Z","end":"2026-06-10T10:26:45.705373Z","steps":["trace[792164530] 'agreement among raft nodes before linearized reading' (duration: 551.576324ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:45.705401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:45.11407Z","time spent":"591.325863ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T10:26:45.705402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:45.153666Z","time spent":"551.731378ms","remote":"127.0.0.1:53040","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-10T10:26:47.444414Z","caller":"traceutil/trace.go:171","msg":"trace[1932043423] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"388.98808ms","start":"2026-06-10T10:26:47.055406Z","end":"2026-06-10T10:26:47.444394Z","steps":["trace[1932043423] 'process raft request' (duration: 388.870427ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:47.444544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:47.055388Z","time spent":"389.087713ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:26:47.998649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.215494ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:26:47.99883Z","caller":"traceutil/trace.go:171","msg":"trace[465277345] linearizableReadLoop","detail":"{readStateIndex:1128; appliedIndex:1126; }","duration":"261.364192ms","start":"2026-06-10T10:26:47.737451Z","end":"2026-06-10T10:26:47.998816Z","steps":["trace[465277345] 'read index received' (duration: 23.677295ms)","trace[465277345] 'applied index is now lower than readState.Index' (duration: 237.685947ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:26:47.998907Z","caller":"traceutil/trace.go:171","msg":"trace[1091930016] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"285.393236ms","start":"2026-06-10T10:26:47.713506Z","end":"2026-06-10T10:26:47.998899Z","steps":["trace[1091930016] 'process raft request' (duration: 285.257352ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:47.99891Z","caller":"traceutil/trace.go:171","msg":"trace[257221728] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"288.170139ms","start":"2026-06-10T10:26:47.710704Z","end":"2026-06-10T10:26:47.998874Z","steps":["trace[257221728] 'process raft request' (duration: 50.498193ms)","trace[257221728] 'compare' (duration: 236.974048ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:26:47.999314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.768681ms","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-10T10:26:47.999373Z","caller":"traceutil/trace.go:171","msg":"trace[704284055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1079; }","duration":"228.863584ms","start":"2026-06-10T10:26:47.770495Z","end":"2026-06-10T10:26:47.999358Z","steps":["trace[704284055] 'agreement among raft nodes before linearized reading' (duration: 228.626038ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:47.999496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.103778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:26:47.999537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.092101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-10T10:26:47.999563Z","caller":"traceutil/trace.go:171","msg":"trace[2100796579] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1079; }","duration":"163.215481ms","start":"2026-06-10T10:26:47.836338Z","end":"2026-06-10T10:26:47.999554Z","steps":["trace[2100796579] 'agreement among raft nodes before linearized reading' (duration: 163.127809ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:47.999583Z","caller":"traceutil/trace.go:171","msg":"trace[1640543313] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1079; }","duration":"262.166393ms","start":"2026-06-10T10:26:47.7374Z","end":"2026-06-10T10:26:47.999566Z","steps":["trace[1640543313] 'agreement among raft nodes before linearized reading' (duration: 261.995219ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:47.99963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.023624ms","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-10T10:26:47.999688Z","caller":"traceutil/trace.go:171","msg":"trace[1050414235] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1079; }","duration":"216.123367ms","start":"2026-06-10T10:26:47.783548Z","end":"2026-06-10T10:26:47.999671Z","steps":["trace[1050414235] 'agreement among raft nodes before linearized reading' (duration: 216.023604ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:48.124156Z","caller":"traceutil/trace.go:171","msg":"trace[389122765] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"119.592259ms","start":"2026-06-10T10:26:48.004532Z","end":"2026-06-10T10:26:48.124124Z","steps":["trace[389122765] 'process raft request' (duration: 114.240499ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:48.127985Z","caller":"traceutil/trace.go:171","msg":"trace[1024342159] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"122.855665ms","start":"2026-06-10T10:26:48.005106Z","end":"2026-06-10T10:26:48.127962Z","steps":["trace[1024342159] 'process raft request' (duration: 122.734312ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:48.707776Z","caller":"traceutil/trace.go:171","msg":"trace[962543453] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"497.490497ms","start":"2026-06-10T10:26:48.210241Z","end":"2026-06-10T10:26:48.707732Z","steps":["trace[962543453] 'process raft request' (duration: 412.418459ms)","trace[962543453] 'compare' (duration: 84.846122ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:26:48.708086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:48.210217Z","time spent":"497.671261ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:26:49.166044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.731283ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-10T10:26:49.16618Z","caller":"traceutil/trace.go:171","msg":"trace[452097312] linearizableReadLoop","detail":"{readStateIndex:1132; appliedIndex:1131; }","duration":"220.383019ms","start":"2026-06-10T10:26:48.945776Z","end":"2026-06-10T10:26:49.166159Z","steps":["trace[452097312] 'read index received' (duration: 50.761µs)","trace[452097312] 'applied index is now lower than readState.Index' (duration: 220.330158ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:26:49.16643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.599115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:26:49.166564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.820017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T10:26:49.166597Z","caller":"traceutil/trace.go:171","msg":"trace[1247521691] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1082; }","duration":"220.885632ms","start":"2026-06-10T10:26:48.945672Z","end":"2026-06-10T10:26:49.166558Z","steps":["trace[1247521691] 'agreement among raft nodes before linearized reading' (duration: 220.585135ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:49.166659Z","caller":"traceutil/trace.go:171","msg":"trace[511706924] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1082; }","duration":"101.976841ms","start":"2026-06-10T10:26:49.064662Z","end":"2026-06-10T10:26:49.166639Z","steps":["trace[511706924] 'agreement among raft nodes before linearized reading' (duration: 101.627992ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:50.083901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.871408ms","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-10T10:26:50.084001Z","caller":"traceutil/trace.go:171","msg":"trace[1865299607] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1083; }","duration":"447.063313ms","start":"2026-06-10T10:26:49.636914Z","end":"2026-06-10T10:26:50.083977Z","steps":["trace[1865299607] 'range keys from in-memory index tree' (duration: 446.648312ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:50.084035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:49.636882Z","time spent":"447.146215ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-10T10:26:50.234999Z","caller":"traceutil/trace.go:171","msg":"trace[1500638901] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"100.637115ms","start":"2026-06-10T10:26:50.134332Z","end":"2026-06-10T10:26:50.234969Z","steps":["trace[1500638901] 'process raft request' (duration: 100.43487ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:50.280926Z","caller":"traceutil/trace.go:171","msg":"trace[1989838757] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"145.390549ms","start":"2026-06-10T10:26:50.135499Z","end":"2026-06-10T10:26:50.280889Z","steps":["trace[1989838757] 'process raft request' (duration: 145.209724ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:06.695429Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869987225587282,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T10:27:07.19639Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869987225587282,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T10:27:07.696576Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869987225587282,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T10:27:07.861901Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.698948936s","expected-duration":"1s"} {"level":"info","ts":"2026-06-10T10:27:07.86254Z","caller":"traceutil/trace.go:171","msg":"trace[1731499198] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"1.699708246s","start":"2026-06-10T10:27:06.162802Z","end":"2026-06-10T10:27:07.86251Z","steps":["trace[1731499198] 'process raft request' (duration: 1.69945232s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:07.862725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:06.162772Z","time spent":"1.699851239s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:27:07.919989Z","caller":"traceutil/trace.go:171","msg":"trace[1480972698] linearizableReadLoop","detail":"{readStateIndex:1244; appliedIndex:1242; }","duration":"1.724639744s","start":"2026-06-10T10:27:06.195317Z","end":"2026-06-10T10:27:07.919957Z","steps":["trace[1480972698] 'read index received' (duration: 1.666945021s)","trace[1480972698] 'applied index is now lower than readState.Index' (duration: 57.692973ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:27:07.92016Z","caller":"traceutil/trace.go:171","msg":"trace[1376862450] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"1.616411307s","start":"2026-06-10T10:27:06.303733Z","end":"2026-06-10T10:27:07.920144Z","steps":["trace[1376862450] 'process raft request' (duration: 1.602618443s)","trace[1376862450] 'compare' (duration: 13.449205ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:27:07.920311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:06.303707Z","time spent":"1.616481638s","remote":"127.0.0.1:53040","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-10T10:27:07.920558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.665084ms","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-10T10:27:07.920571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.125085305s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T10:27:07.920627Z","caller":"traceutil/trace.go:171","msg":"trace[511302051] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1189; }","duration":"315.779547ms","start":"2026-06-10T10:27:07.604827Z","end":"2026-06-10T10:27:07.920606Z","steps":["trace[511302051] 'agreement among raft nodes before linearized reading' (duration: 315.608743ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:27:07.920663Z","caller":"traceutil/trace.go:171","msg":"trace[990127753] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1189; }","duration":"1.125240498s","start":"2026-06-10T10:27:06.795406Z","end":"2026-06-10T10:27:07.920646Z","steps":["trace[990127753] 'agreement among raft nodes before linearized reading' (duration: 1.125076354s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:07.920667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:07.604805Z","time spent":"315.853459ms","remote":"127.0.0.1:53040","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-10T10:27:07.920715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.556404053s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-10T10:27:07.92073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:06.795387Z","time spent":"1.125330201s","remote":"127.0.0.1:43676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:27:07.920705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.725346992s","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-10T10:27:07.920775Z","caller":"traceutil/trace.go:171","msg":"trace[384221196] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1189; }","duration":"1.556499745s","start":"2026-06-10T10:27:06.364264Z","end":"2026-06-10T10:27:07.920763Z","steps":["trace[384221196] 'agreement among raft nodes before linearized reading' (duration: 1.556379942s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:07.920811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:06.364241Z","time spent":"1.556561216s","remote":"127.0.0.1:53040","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-10T10:27:07.920816Z","caller":"traceutil/trace.go:171","msg":"trace[1224953499] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1189; }","duration":"1.725522957s","start":"2026-06-10T10:27:06.195263Z","end":"2026-06-10T10:27:07.920786Z","steps":["trace[1224953499] 'agreement among raft nodes before linearized reading' (duration: 1.725168498s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:07.920874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:06.195245Z","time spent":"1.725618899s","remote":"127.0.0.1:53040","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-10T10:27:07.92096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.610336008s","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-10T10:27:07.920991Z","caller":"traceutil/trace.go:171","msg":"trace[1822464188] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1189; }","duration":"1.61041125s","start":"2026-06-10T10:27:06.310569Z","end":"2026-06-10T10:27:07.920981Z","steps":["trace[1822464188] 'agreement among raft nodes before linearized reading' (duration: 1.610337338s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:07.920619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.722578499s","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-10T10:27:07.92101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:06.310552Z","time spent":"1.61045358s","remote":"127.0.0.1:53040","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":"info","ts":"2026-06-10T10:27:07.921032Z","caller":"traceutil/trace.go:171","msg":"trace[271758286] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1189; }","duration":"1.723015441s","start":"2026-06-10T10:27:06.198003Z","end":"2026-06-10T10:27:07.921019Z","steps":["trace[271758286] 'agreement among raft nodes before linearized reading' (duration: 1.722437006s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:07.921064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:06.197989Z","time spent":"1.723065662s","remote":"127.0.0.1:53040","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-10T10:27:07.921088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"979.116211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:27:07.921113Z","caller":"traceutil/trace.go:171","msg":"trace[1506661932] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1189; }","duration":"979.191223ms","start":"2026-06-10T10:27:06.941914Z","end":"2026-06-10T10:27:07.921105Z","steps":["trace[1506661932] 'agreement among raft nodes before linearized reading' (duration: 979.151632ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:07.921129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:06.941886Z","time spent":"979.239794ms","remote":"127.0.0.1:52750","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-10T10:27:08.443099Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869987225587288,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-10T10:27:08.841349Z","caller":"traceutil/trace.go:171","msg":"trace[1981333440] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"915.479021ms","start":"2026-06-10T10:27:07.925844Z","end":"2026-06-10T10:27:08.841323Z","steps":["trace[1981333440] 'process raft request' (duration: 915.278266ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:08.841493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:07.925817Z","time spent":"915.598244ms","remote":"127.0.0.1:53040","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-10T10:27:08.844666Z","caller":"traceutil/trace.go:171","msg":"trace[1324095295] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"917.492415ms","start":"2026-06-10T10:27:07.927158Z","end":"2026-06-10T10:27:08.84465Z","steps":["trace[1324095295] 'process raft request' (duration: 917.426083ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:27:08.844696Z","caller":"traceutil/trace.go:171","msg":"trace[23816496] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"917.70891ms","start":"2026-06-10T10:27:07.926955Z","end":"2026-06-10T10:27:08.844664Z","steps":["trace[23816496] 'process raft request' (duration: 917.503815ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:08.84475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:07.927147Z","time spent":"917.563708ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:27:08.844753Z","caller":"traceutil/trace.go:171","msg":"trace[1218556361] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"917.719031ms","start":"2026-06-10T10:27:07.926994Z","end":"2026-06-10T10:27:08.844713Z","steps":["trace[1218556361] 'process raft request' (duration: 917.553086ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:08.844863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:07.926914Z","time spent":"917.852904ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:27:08.844981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:07.926953Z","time spent":"917.892715ms","remote":"127.0.0.1:53040","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-10T10:27:08.845044Z","caller":"traceutil/trace.go:171","msg":"trace[1758935241] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"917.615179ms","start":"2026-06-10T10:27:07.927416Z","end":"2026-06-10T10:27:08.845031Z","steps":["trace[1758935241] 'process raft request' (duration: 917.199627ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:08.845098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:07.927403Z","time spent":"917.665669ms","remote":"127.0.0.1:53040","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-10T10:27:08.847135Z","caller":"traceutil/trace.go:171","msg":"trace[949343323] linearizableReadLoop","detail":"{readStateIndex:1249; appliedIndex:1245; }","duration":"904.347027ms","start":"2026-06-10T10:27:07.942765Z","end":"2026-06-10T10:27:08.847112Z","steps":["trace[949343323] 'read index received' (duration: 898.999207ms)","trace[949343323] 'applied index is now lower than readState.Index' (duration: 5.34466ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:27:08.847267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.471001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:27:08.847299Z","caller":"traceutil/trace.go:171","msg":"trace[1123323127] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1194; }","duration":"904.567024ms","start":"2026-06-10T10:27:07.942722Z","end":"2026-06-10T10:27:08.847289Z","steps":["trace[1123323127] 'agreement among raft nodes before linearized reading' (duration: 904.474102ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:08.847328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:07.942711Z","time spent":"904.611605ms","remote":"127.0.0.1:52750","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-10T10:27:14.028713Z","caller":"traceutil/trace.go:171","msg":"trace[1194505159] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"139.890573ms","start":"2026-06-10T10:27:13.888805Z","end":"2026-06-10T10:27:14.028695Z","steps":["trace[1194505159] 'process raft request' (duration: 139.77202ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:27:20.161587Z","caller":"traceutil/trace.go:171","msg":"trace[1297145714] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"113.741804ms","start":"2026-06-10T10:27:20.047819Z","end":"2026-06-10T10:27:20.161561Z","steps":["trace[1297145714] 'process raft request' (duration: 113.5839ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:23.733297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.221571ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:27:23.733564Z","caller":"traceutil/trace.go:171","msg":"trace[682675525] linearizableReadLoop","detail":"{readStateIndex:1307; appliedIndex:1302; }","duration":"790.115411ms","start":"2026-06-10T10:27:22.943432Z","end":"2026-06-10T10:27:23.733547Z","steps":["trace[682675525] 'read index received' (duration: 7.042786ms)","trace[682675525] 'applied index is now lower than readState.Index' (duration: 783.071685ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:27:23.733742Z","caller":"traceutil/trace.go:171","msg":"trace[1480240749] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"792.171754ms","start":"2026-06-10T10:27:22.941542Z","end":"2026-06-10T10:27:23.733714Z","steps":["trace[1480240749] 'process raft request' (duration: 791.965699ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:23.733791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"790.355837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:27:23.733837Z","caller":"traceutil/trace.go:171","msg":"trace[502729368] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1249; }","duration":"790.422479ms","start":"2026-06-10T10:27:22.943401Z","end":"2026-06-10T10:27:23.733824Z","steps":["trace[502729368] 'agreement among raft nodes before linearized reading' (duration: 790.348857ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:23.733854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.697093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-10T10:27:23.733848Z","caller":"traceutil/trace.go:171","msg":"trace[179083046] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"792.932145ms","start":"2026-06-10T10:27:22.940885Z","end":"2026-06-10T10:27:23.733817Z","steps":["trace[179083046] 'process raft request' (duration: 792.523705ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:23.733875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:22.943394Z","time spent":"790.47298ms","remote":"127.0.0.1:52750","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-10T10:27:23.733898Z","caller":"traceutil/trace.go:171","msg":"trace[1037220168] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:1249; }","duration":"146.796835ms","start":"2026-06-10T10:27:23.587089Z","end":"2026-06-10T10:27:23.733886Z","steps":["trace[1037220168] 'agreement among raft nodes before linearized reading' (duration: 146.648421ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:23.733906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:22.941535Z","time spent":"792.274627ms","remote":"127.0.0.1:53040","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-10T10:27:23.733949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:22.940881Z","time spent":"793.018867ms","remote":"127.0.0.1:53040","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-10T10:27:23.734013Z","caller":"traceutil/trace.go:171","msg":"trace[1603719453] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"793.154251ms","start":"2026-06-10T10:27:22.940839Z","end":"2026-06-10T10:27:23.733993Z","steps":["trace[1603719453] 'process raft request' (duration: 246.132138ms)","trace[1603719453] 'compare' (duration: 545.923484ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:27:23.734085Z","caller":"traceutil/trace.go:171","msg":"trace[312837747] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"793.12102ms","start":"2026-06-10T10:27:22.940926Z","end":"2026-06-10T10:27:23.734047Z","steps":["trace[312837747] 'process raft request' (duration: 792.547925ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:23.734107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:22.940819Z","time spent":"793.236803ms","remote":"127.0.0.1:53040","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-10T10:27:23.734173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:22.940923Z","time spent":"793.203753ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:27:24.24669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.862646ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-06-10T10:27:24.246806Z","caller":"traceutil/trace.go:171","msg":"trace[1188674428] linearizableReadLoop","detail":"{readStateIndex:1308; appliedIndex:1307; }","duration":"511.465154ms","start":"2026-06-10T10:27:23.735322Z","end":"2026-06-10T10:27:24.246787Z","steps":["trace[1188674428] 'read index received' (duration: 408.488555ms)","trace[1188674428] 'applied index is now lower than readState.Index' (duration: 102.974959ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:27:24.246881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.548146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:27:24.2469Z","caller":"traceutil/trace.go:171","msg":"trace[667985226] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1249; }","duration":"511.603968ms","start":"2026-06-10T10:27:23.735288Z","end":"2026-06-10T10:27:24.246892Z","steps":["trace[667985226] 'agreement among raft nodes before linearized reading' (duration: 511.541046ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:24.246927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:23.735269Z","time spent":"511.651309ms","remote":"127.0.0.1:52764","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-10T10:27:24.246983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:23.735278Z","time spent":"511.69802ms","remote":"127.0.0.1:52790","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-10T10:27:25.540172Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869987225587434,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-10T10:27:25.758263Z","caller":"traceutil/trace.go:171","msg":"trace[304254379] linearizableReadLoop","detail":"{readStateIndex:1314; appliedIndex:1313; }","duration":"718.710996ms","start":"2026-06-10T10:27:25.039472Z","end":"2026-06-10T10:27:25.758183Z","steps":["trace[304254379] 'read index received' (duration: 718.48488ms)","trace[304254379] 'applied index is now lower than readState.Index' (duration: 225.195µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:27:25.758362Z","caller":"traceutil/trace.go:171","msg":"trace[1353987373] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"798.696177ms","start":"2026-06-10T10:27:24.959522Z","end":"2026-06-10T10:27:25.758218Z","steps":["trace[1353987373] 'process raft request' (duration: 798.475342ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:25.758449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:24.959479Z","time spent":"798.927933ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:27:25.758307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.828429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:27:25.758516Z","caller":"traceutil/trace.go:171","msg":"trace[891824012] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1255; }","duration":"719.108505ms","start":"2026-06-10T10:27:25.03939Z","end":"2026-06-10T10:27:25.758499Z","steps":["trace[891824012] 'agreement among raft nodes before linearized reading' (duration: 718.863689ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:25.758579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:25.039353Z","time spent":"719.206318ms","remote":"127.0.0.1:43538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:27:25.759012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.936579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5331"} {"level":"info","ts":"2026-06-10T10:27:25.759058Z","caller":"traceutil/trace.go:171","msg":"trace[1952468032] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1255; }","duration":"275.029671ms","start":"2026-06-10T10:27:25.484017Z","end":"2026-06-10T10:27:25.759046Z","steps":["trace[1952468032] 'agreement among raft nodes before linearized reading' (duration: 274.902638ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:27:25.925478Z","caller":"traceutil/trace.go:171","msg":"trace[1292048467] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"159.224985ms","start":"2026-06-10T10:27:25.766215Z","end":"2026-06-10T10:27:25.92544Z","steps":["trace[1292048467] 'process raft request' (duration: 104.623713ms)","trace[1292048467] 'compare' (duration: 54.352114ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:27:25.925797Z","caller":"traceutil/trace.go:171","msg":"trace[2114426653] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"159.483771ms","start":"2026-06-10T10:27:25.766282Z","end":"2026-06-10T10:27:25.925766Z","steps":["trace[2114426653] 'process raft request' (duration: 159.105191ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:27:25.92604Z","caller":"traceutil/trace.go:171","msg":"trace[884653696] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"158.401823ms","start":"2026-06-10T10:27:25.767622Z","end":"2026-06-10T10:27:25.926024Z","steps":["trace[884653696] 'process raft request' (duration: 158.032733ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:27:25.926109Z","caller":"traceutil/trace.go:171","msg":"trace[779660623] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"156.924893ms","start":"2026-06-10T10:27:25.769175Z","end":"2026-06-10T10:27:25.9261Z","steps":["trace[779660623] 'process raft request' (duration: 156.750098ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:27:26.48978Z","caller":"traceutil/trace.go:171","msg":"trace[1707081060] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"209.927933ms","start":"2026-06-10T10:27:26.279781Z","end":"2026-06-10T10:27:26.489709Z","steps":["trace[1707081060] 'process raft request' (duration: 209.744868ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:39.845091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.894737ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:27:39.8452Z","caller":"traceutil/trace.go:171","msg":"trace[1268396821] linearizableReadLoop","detail":"{readStateIndex:1414; appliedIndex:1413; }","duration":"1.204619534s","start":"2026-06-10T10:27:38.640564Z","end":"2026-06-10T10:27:39.845183Z","steps":["trace[1268396821] 'read index received' (duration: 370.589854ms)","trace[1268396821] 'applied index is now lower than readState.Index' (duration: 834.02851ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:27:39.845539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.204958423s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-06-10T10:27:39.845569Z","caller":"traceutil/trace.go:171","msg":"trace[1009106293] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"1.277827807s","start":"2026-06-10T10:27:38.56768Z","end":"2026-06-10T10:27:39.845508Z","steps":["trace[1009106293] 'process raft request' (duration: 443.407927ms)","trace[1009106293] 'compare' (duration: 833.582638ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:27:39.845628Z","caller":"traceutil/trace.go:171","msg":"trace[1864461700] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1353; }","duration":"1.205118768s","start":"2026-06-10T10:27:38.640486Z","end":"2026-06-10T10:27:39.845604Z","steps":["trace[1864461700] 'agreement among raft nodes before linearized reading' (duration: 1.204845521s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:39.845682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:38.640456Z","time spent":"1.205216259s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":548,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-10T10:27:39.84581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:38.56766Z","time spent":"1.278020882s","remote":"127.0.0.1:53040","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-10T10:27:39.854106Z","caller":"traceutil/trace.go:171","msg":"trace[413534521] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"1.098552684s","start":"2026-06-10T10:27:38.755536Z","end":"2026-06-10T10:27:39.854089Z","steps":["trace[413534521] 'process raft request' (duration: 1.098459061s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:39.854223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:38.755512Z","time spent":"1.098645686s","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:27:40.201478Z","caller":"traceutil/trace.go:171","msg":"trace[1118506562] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"348.203643ms","start":"2026-06-10T10:27:39.853243Z","end":"2026-06-10T10:27:40.201446Z","steps":["trace[1118506562] 'process raft request' (duration: 348.047379ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:27:40.201494Z","caller":"traceutil/trace.go:171","msg":"trace[382163109] linearizableReadLoop","detail":"{readStateIndex:1416; appliedIndex:1415; }","duration":"356.234945ms","start":"2026-06-10T10:27:39.845226Z","end":"2026-06-10T10:27:40.201461Z","steps":["trace[382163109] 'read index received' (duration: 8.849243ms)","trace[382163109] 'applied index is now lower than readState.Index' (duration: 347.384652ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:27:40.201635Z","caller":"traceutil/trace.go:171","msg":"trace[1552776544] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"256.326708ms","start":"2026-06-10T10:27:39.945289Z","end":"2026-06-10T10:27:40.201616Z","steps":["trace[1552776544] 'process raft request' (duration: 256.127482ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:40.201754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.256423833s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:27:40.201815Z","caller":"traceutil/trace.go:171","msg":"trace[1708839068] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1356; }","duration":"1.256580087s","start":"2026-06-10T10:27:38.945218Z","end":"2026-06-10T10:27:40.201798Z","steps":["trace[1708839068] 'agreement among raft nodes before linearized reading' (duration: 1.256405733s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:40.201861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:38.945196Z","time spent":"1.256653328s","remote":"127.0.0.1:52750","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-10T10:27:40.201914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.407671ms","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-10T10:27:40.201945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.055829ms","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-10T10:27:40.201983Z","caller":"traceutil/trace.go:171","msg":"trace[1360933358] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1356; }","duration":"440.10218ms","start":"2026-06-10T10:27:39.76187Z","end":"2026-06-10T10:27:40.201973Z","steps":["trace[1360933358] 'agreement among raft nodes before linearized reading' (duration: 439.662118ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:27:40.201979Z","caller":"traceutil/trace.go:171","msg":"trace[87157627] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1356; }","duration":"339.518304ms","start":"2026-06-10T10:27:39.862444Z","end":"2026-06-10T10:27:40.201962Z","steps":["trace[87157627] 'agreement among raft nodes before linearized reading' (duration: 339.33759ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:40.202005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:39.761798Z","time spent":"440.202443ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-06-10T10:27:40.202018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:39.862429Z","time spent":"339.579875ms","remote":"127.0.0.1:53040","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-10T10:27:40.202024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:39.853218Z","time spent":"348.344476ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":511,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:27:40.202175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.019655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-10T10:27:40.202227Z","caller":"traceutil/trace.go:171","msg":"trace[1051818784] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1356; }","duration":"132.111297ms","start":"2026-06-10T10:27:40.070101Z","end":"2026-06-10T10:27:40.202212Z","steps":["trace[1051818784] 'agreement among raft nodes before linearized reading' (duration: 132.013275ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:40.202348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.839894ms","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-10T10:27:40.20237Z","caller":"traceutil/trace.go:171","msg":"trace[102726113] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1356; }","duration":"197.905945ms","start":"2026-06-10T10:27:40.004457Z","end":"2026-06-10T10:27:40.202363Z","steps":["trace[102726113] 'agreement among raft nodes before linearized reading' (duration: 197.836513ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:40.202385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.217576ms","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-10T10:27:40.202193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.341556ms","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-10T10:27:40.202422Z","caller":"traceutil/trace.go:171","msg":"trace[23728077] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1356; }","duration":"200.290138ms","start":"2026-06-10T10:27:40.00212Z","end":"2026-06-10T10:27:40.20241Z","steps":["trace[23728077] 'agreement among raft nodes before linearized reading' (duration: 200.189536ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:27:40.202439Z","caller":"traceutil/trace.go:171","msg":"trace[138436538] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1356; }","duration":"387.625935ms","start":"2026-06-10T10:27:39.814804Z","end":"2026-06-10T10:27:40.20243Z","steps":["trace[138436538] 'agreement among raft nodes before linearized reading' (duration: 386.70885ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:27:40.202439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.578503ms","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-10T10:27:40.202466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:27:39.814784Z","time spent":"387.673756ms","remote":"127.0.0.1:53040","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-10T10:27:40.20249Z","caller":"traceutil/trace.go:171","msg":"trace[1275653618] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1356; }","duration":"198.654395ms","start":"2026-06-10T10:27:40.003824Z","end":"2026-06-10T10:27:40.202479Z","steps":["trace[1275653618] 'agreement among raft nodes before linearized reading' (duration: 198.487551ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:27:44.338683Z","caller":"traceutil/trace.go:171","msg":"trace[1821942803] transaction","detail":"{read_only:false; response_revision:1375; number_of_response:1; }","duration":"105.429804ms","start":"2026-06-10T10:27:44.233215Z","end":"2026-06-10T10:27:44.338645Z","steps":["trace[1821942803] 'process raft request' (duration: 105.154136ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:27:44.518152Z","caller":"traceutil/trace.go:171","msg":"trace[1896028270] transaction","detail":"{read_only:false; response_revision:1378; number_of_response:1; }","duration":"172.978777ms","start":"2026-06-10T10:27:44.345134Z","end":"2026-06-10T10:27:44.518113Z","steps":["trace[1896028270] 'process raft request' (duration: 161.161845ms)","trace[1896028270] 'compare' (duration: 11.525085ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:27:44.518657Z","caller":"traceutil/trace.go:171","msg":"trace[819988941] transaction","detail":"{read_only:false; response_revision:1379; number_of_response:1; }","duration":"173.276025ms","start":"2026-06-10T10:27:44.345354Z","end":"2026-06-10T10:27:44.51863Z","steps":["trace[819988941] 'process raft request' (duration: 172.649208ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:27:44.519171Z","caller":"traceutil/trace.go:171","msg":"trace[78227740] transaction","detail":"{read_only:false; response_revision:1380; number_of_response:1; }","duration":"173.576383ms","start":"2026-06-10T10:27:44.345492Z","end":"2026-06-10T10:27:44.519069Z","steps":["trace[78227740] 'process raft request' (duration: 173.09222ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:28:02.731149Z","caller":"traceutil/trace.go:171","msg":"trace[892203956] transaction","detail":"{read_only:false; response_revision:1462; number_of_response:1; }","duration":"117.97937ms","start":"2026-06-10T10:28:02.613136Z","end":"2026-06-10T10:28:02.731116Z","steps":["trace[892203956] 'process raft request' (duration: 78.281882ms)","trace[892203956] 'compare' (duration: 39.444481ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:28:02.73132Z","caller":"traceutil/trace.go:171","msg":"trace[1354747793] transaction","detail":"{read_only:false; response_revision:1464; number_of_response:1; }","duration":"115.845012ms","start":"2026-06-10T10:28:02.615429Z","end":"2026-06-10T10:28:02.731274Z","steps":["trace[1354747793] 'process raft request' (duration: 115.598095ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:28:02.731331Z","caller":"traceutil/trace.go:171","msg":"trace[1618704133] transaction","detail":"{read_only:false; response_revision:1463; number_of_response:1; }","duration":"117.6062ms","start":"2026-06-10T10:28:02.613636Z","end":"2026-06-10T10:28:02.731242Z","steps":["trace[1618704133] 'process raft request' (duration: 117.350053ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:28:14.051453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.255291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:28:14.05156Z","caller":"traceutil/trace.go:171","msg":"trace[93455822] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1512; }","duration":"110.442186ms","start":"2026-06-10T10:28:13.941094Z","end":"2026-06-10T10:28:14.051537Z","steps":["trace[93455822] 'range keys from in-memory index tree' (duration: 110.157639ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:28:41.101108Z","caller":"traceutil/trace.go:171","msg":"trace[1699772675] transaction","detail":"{read_only:false; response_revision:1636; number_of_response:1; }","duration":"130.577112ms","start":"2026-06-10T10:28:40.970504Z","end":"2026-06-10T10:28:41.101082Z","steps":["trace[1699772675] 'process raft request' (duration: 130.406828ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:28:42.304149Z","caller":"traceutil/trace.go:171","msg":"trace[792888237] transaction","detail":"{read_only:false; response_revision:1642; number_of_response:1; }","duration":"136.387528ms","start":"2026-06-10T10:28:42.167737Z","end":"2026-06-10T10:28:42.304124Z","steps":["trace[792888237] 'process raft request' (duration: 136.262015ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:28:53.045606Z","caller":"traceutil/trace.go:171","msg":"trace[626593062] linearizableReadLoop","detail":"{readStateIndex:1767; appliedIndex:1766; }","duration":"104.002631ms","start":"2026-06-10T10:28:52.941576Z","end":"2026-06-10T10:28:53.045579Z","steps":["trace[626593062] 'read index received' (duration: 46.020617ms)","trace[626593062] 'applied index is now lower than readState.Index' (duration: 57.980864ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:28:53.045759Z","caller":"traceutil/trace.go:171","msg":"trace[558234686] transaction","detail":"{read_only:false; response_revision:1691; number_of_response:1; }","duration":"125.247542ms","start":"2026-06-10T10:28:52.920495Z","end":"2026-06-10T10:28:53.045743Z","steps":["trace[558234686] 'process raft request' (duration: 67.166317ms)","trace[558234686] 'compare' (duration: 57.793548ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:28:53.045773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.182125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:28:53.045823Z","caller":"traceutil/trace.go:171","msg":"trace[766732952] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1691; }","duration":"104.285079ms","start":"2026-06-10T10:28:52.941525Z","end":"2026-06-10T10:28:53.04581Z","steps":["trace[766732952] 'agreement among raft nodes before linearized reading' (duration: 104.165175ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:29:15.566302Z","caller":"traceutil/trace.go:171","msg":"trace[306290407] transaction","detail":"{read_only:false; response_revision:1795; number_of_response:1; }","duration":"108.239133ms","start":"2026-06-10T10:29:15.458031Z","end":"2026-06-10T10:29:15.56627Z","steps":["trace[306290407] 'process raft request' (duration: 107.947936ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:29:43.860106Z","caller":"traceutil/trace.go:171","msg":"trace[415530084] transaction","detail":"{read_only:false; response_revision:1926; number_of_response:1; }","duration":"117.001046ms","start":"2026-06-10T10:29:43.743063Z","end":"2026-06-10T10:29:43.860064Z","steps":["trace[415530084] 'process raft request' (duration: 116.176004ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:30:28.093865Z","caller":"traceutil/trace.go:171","msg":"trace[480994701] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"142.699033ms","start":"2026-06-10T10:30:27.951142Z","end":"2026-06-10T10:30:28.093841Z","steps":["trace[480994701] 'process raft request' (duration: 96.194581ms)","trace[480994701] 'compare' (duration: 46.173434ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:30:59.222117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.315608ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-10T10:30:59.222874Z","caller":"traceutil/trace.go:171","msg":"trace[1416237849] transaction","detail":"{read_only:false; response_revision:2268; number_of_response:1; }","duration":"207.977981ms","start":"2026-06-10T10:30:59.014851Z","end":"2026-06-10T10:30:59.222829Z","steps":["trace[1416237849] 'process raft request' (duration: 207.436887ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:31:32.60742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.439788ms","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-10T10:31:32.607498Z","caller":"traceutil/trace.go:171","msg":"trace[752606812] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2447; }","duration":"107.53269ms","start":"2026-06-10T10:31:32.499949Z","end":"2026-06-10T10:31:32.607481Z","steps":["trace[752606812] 'range keys from in-memory index tree' (duration: 107.301344ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:31:32.607503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.861202ms","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-10T10:31:32.607572Z","caller":"traceutil/trace.go:171","msg":"trace[1331299533] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:2447; }","duration":"180.970574ms","start":"2026-06-10T10:31:32.426587Z","end":"2026-06-10T10:31:32.607557Z","steps":["trace[1331299533] 'count revisions from in-memory index tree' (duration: 180.82047ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:31:32.607893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.388525ms","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-10T10:31:32.608039Z","caller":"traceutil/trace.go:171","msg":"trace[444714656] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2447; }","duration":"184.617361ms","start":"2026-06-10T10:31:32.423394Z","end":"2026-06-10T10:31:32.608012Z","steps":["trace[444714656] 'range keys from in-memory index tree' (duration: 184.087767ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:31:59.046845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.297219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system::leader-locking-kube-scheduler\" ","response":"range_response_count:1 size:661"} {"level":"info","ts":"2026-06-10T10:31:59.046935Z","caller":"traceutil/trace.go:171","msg":"trace[1552564608] range","detail":"{range_begin:/registry/roles/kube-system/system::leader-locking-kube-scheduler; range_end:; response_count:1; response_revision:2577; }","duration":"111.458554ms","start":"2026-06-10T10:31:58.935457Z","end":"2026-06-10T10:31:59.046915Z","steps":["trace[1552564608] 'range keys from in-memory index tree' (duration: 111.171446ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:31:59.324864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.233693ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-10T10:31:59.325066Z","caller":"traceutil/trace.go:171","msg":"trace[1546493105] transaction","detail":"{read_only:false; response_revision:2578; number_of_response:1; }","duration":"149.657736ms","start":"2026-06-10T10:31:59.175394Z","end":"2026-06-10T10:31:59.325052Z","steps":["trace[1546493105] 'process raft request' (duration: 149.570533ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:31:59.325263Z","caller":"traceutil/trace.go:171","msg":"trace[1427324312] linearizableReadLoop","detail":"{readStateIndex:2693; appliedIndex:2692; }","duration":"200.752329ms","start":"2026-06-10T10:31:59.124504Z","end":"2026-06-10T10:31:59.325257Z","steps":["trace[1427324312] 'read index received' (duration: 54.094014ms)","trace[1427324312] 'applied index is now lower than readState.Index' (duration: 146.657425ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:31:59.401188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.975911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system:controller:bootstrap-signer\" ","response":"range_response_count:1 size:618"} {"level":"info","ts":"2026-06-10T10:31:59.401253Z","caller":"traceutil/trace.go:171","msg":"trace[715246727] range","detail":"{range_begin:/registry/roles/kube-system/system:controller:bootstrap-signer; range_end:; response_count:1; response_revision:2578; }","duration":"271.074084ms","start":"2026-06-10T10:31:59.130162Z","end":"2026-06-10T10:31:59.401236Z","steps":["trace[715246727] 'agreement among raft nodes before linearized reading' (duration: 195.153811ms)","trace[715246727] 'range keys from in-memory index tree' (duration: 75.816239ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:31:59.401282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.749514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system:controller:cloud-provider\" ","response":"range_response_count:1 size:625"} {"level":"info","ts":"2026-06-10T10:31:59.401378Z","caller":"traceutil/trace.go:171","msg":"trace[2010303702] range","detail":"{range_begin:/registry/roles/kube-system/system:controller:cloud-provider; range_end:; response_count:1; response_revision:2578; }","duration":"276.892007ms","start":"2026-06-10T10:31:59.124462Z","end":"2026-06-10T10:31:59.401354Z","steps":["trace[2010303702] 'agreement among raft nodes before linearized reading' (duration: 200.842471ms)","trace[2010303702] 'range keys from in-memory index tree' (duration: 75.892342ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:32:00.558242Z","caller":"traceutil/trace.go:171","msg":"trace[351458944] transaction","detail":"{read_only:false; response_revision:2583; number_of_response:1; }","duration":"160.692596ms","start":"2026-06-10T10:32:00.397498Z","end":"2026-06-10T10:32:00.558191Z","steps":["trace[351458944] 'process raft request' (duration: 160.42461ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:01.095522Z","caller":"traceutil/trace.go:171","msg":"trace[1376544314] linearizableReadLoop","detail":"{readStateIndex:2701; appliedIndex:2700; }","duration":"182.053764ms","start":"2026-06-10T10:32:00.913425Z","end":"2026-06-10T10:32:01.095479Z","steps":["trace[1376544314] 'read index received' (duration: 90.260972ms)","trace[1376544314] 'applied index is now lower than readState.Index' (duration: 91.791822ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:32:01.095659Z","caller":"traceutil/trace.go:171","msg":"trace[1156612223] transaction","detail":"{read_only:false; response_revision:2585; number_of_response:1; }","duration":"188.743911ms","start":"2026-06-10T10:32:00.906901Z","end":"2026-06-10T10:32:01.095645Z","steps":["trace[1156612223] 'process raft request' (duration: 96.852777ms)","trace[1156612223] 'compare' (duration: 91.621246ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:32:01.096001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.060627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"warn","ts":"2026-06-10T10:32:01.096009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.76561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:32:01.096055Z","caller":"traceutil/trace.go:171","msg":"trace[413021749] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2585; }","duration":"138.173811ms","start":"2026-06-10T10:32:00.957867Z","end":"2026-06-10T10:32:01.096041Z","steps":["trace[413021749] 'agreement among raft nodes before linearized reading' (duration: 138.074578ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:01.096057Z","caller":"traceutil/trace.go:171","msg":"trace[572730068] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2585; }","duration":"140.865392ms","start":"2026-06-10T10:32:00.955181Z","end":"2026-06-10T10:32:01.096046Z","steps":["trace[572730068] 'agreement among raft nodes before linearized reading' (duration: 140.77855ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:01.096269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.818344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-10T10:32:01.096343Z","caller":"traceutil/trace.go:171","msg":"trace[1026846152] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2585; }","duration":"182.926776ms","start":"2026-06-10T10:32:00.913395Z","end":"2026-06-10T10:32:01.096322Z","steps":["trace[1026846152] 'agreement among raft nodes before linearized reading' (duration: 182.680619ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:01.096552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.95903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:119 size:91798"} {"level":"info","ts":"2026-06-10T10:32:01.096661Z","caller":"traceutil/trace.go:171","msg":"trace[467269305] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:119; response_revision:2585; }","duration":"154.099453ms","start":"2026-06-10T10:32:00.942538Z","end":"2026-06-10T10:32:01.096638Z","steps":["trace[467269305] 'agreement among raft nodes before linearized reading' (duration: 153.143298ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:01.400567Z","caller":"traceutil/trace.go:171","msg":"trace[1846013893] linearizableReadLoop","detail":"{readStateIndex:2702; appliedIndex:2701; }","duration":"298.439747ms","start":"2026-06-10T10:32:01.102108Z","end":"2026-06-10T10:32:01.400548Z","steps":["trace[1846013893] 'read index received' (duration: 293.160648ms)","trace[1846013893] 'applied index is now lower than readState.Index' (duration: 5.278349ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:32:01.400649Z","caller":"traceutil/trace.go:171","msg":"trace[2092598998] transaction","detail":"{read_only:false; response_revision:2586; number_of_response:1; }","duration":"299.022313ms","start":"2026-06-10T10:32:01.101618Z","end":"2026-06-10T10:32:01.400641Z","steps":["trace[2092598998] 'process raft request' (duration: 293.647761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:01.400771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.656973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-06-10T10:32:01.400791Z","caller":"traceutil/trace.go:171","msg":"trace[278455906] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:2586; }","duration":"298.733775ms","start":"2026-06-10T10:32:01.102051Z","end":"2026-06-10T10:32:01.400785Z","steps":["trace[278455906] 'agreement among raft nodes before linearized reading' (duration: 298.673593ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:01.621028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.754179ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:32:01.621267Z","caller":"traceutil/trace.go:171","msg":"trace[1002570154] linearizableReadLoop","detail":"{readStateIndex:2704; appliedIndex:2702; }","duration":"220.635306ms","start":"2026-06-10T10:32:01.400614Z","end":"2026-06-10T10:32:01.62125Z","steps":["trace[1002570154] 'read index received' (duration: 116.465256ms)","trace[1002570154] 'applied index is now lower than readState.Index' (duration: 104.16881ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:32:01.621333Z","caller":"traceutil/trace.go:171","msg":"trace[1227334049] transaction","detail":"{read_only:false; response_revision:2587; number_of_response:1; }","duration":"518.591231ms","start":"2026-06-10T10:32:01.102709Z","end":"2026-06-10T10:32:01.6213Z","steps":["trace[1227334049] 'process raft request' (duration: 414.466921ms)","trace[1227334049] 'compare' (duration: 103.442131ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:32:01.621471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.461421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/csi-rbd-secret\" ","response":"range_response_count:1 size:880"} {"level":"warn","ts":"2026-06-10T10:32:01.621492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:01.102701Z","time spent":"518.698003ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:32:01.62147Z","caller":"traceutil/trace.go:171","msg":"trace[883886354] transaction","detail":"{read_only:false; response_revision:2588; number_of_response:1; }","duration":"291.009641ms","start":"2026-06-10T10:32:01.330309Z","end":"2026-06-10T10:32:01.621318Z","steps":["trace[883886354] 'process raft request' (duration: 290.833566ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:01.621527Z","caller":"traceutil/trace.go:171","msg":"trace[1373859337] range","detail":"{range_begin:/registry/secrets/kube-system/csi-rbd-secret; range_end:; response_count:1; response_revision:2588; }","duration":"443.577013ms","start":"2026-06-10T10:32:01.177932Z","end":"2026-06-10T10:32:01.621509Z","steps":["trace[1373859337] 'agreement among raft nodes before linearized reading' (duration: 443.415439ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:01.621589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:01.177911Z","time spent":"443.665006ms","remote":"127.0.0.1:52862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":902,"request content":"key:\"/registry/secrets/kube-system/csi-rbd-secret\" "} {"level":"warn","ts":"2026-06-10T10:32:01.621787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.465763ms","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":"warn","ts":"2026-06-10T10:32:01.621916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.809452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:6 size:363682"} {"level":"info","ts":"2026-06-10T10:32:01.622002Z","caller":"traceutil/trace.go:171","msg":"trace[1167390514] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:6; response_revision:2588; }","duration":"217.942026ms","start":"2026-06-10T10:32:01.404045Z","end":"2026-06-10T10:32:01.621987Z","steps":["trace[1167390514] 'agreement among raft nodes before linearized reading' (duration: 217.431602ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:01.621939Z","caller":"traceutil/trace.go:171","msg":"trace[937381871] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:2588; }","duration":"442.67796ms","start":"2026-06-10T10:32:01.179188Z","end":"2026-06-10T10:32:01.621866Z","steps":["trace[937381871] 'agreement among raft nodes before linearized reading' (duration: 442.132465ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:01.622216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:01.179162Z","time spent":"443.002388ms","remote":"127.0.0.1:52862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":11,"response size":29,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"info","ts":"2026-06-10T10:32:02.126449Z","caller":"traceutil/trace.go:171","msg":"trace[807250892] transaction","detail":"{read_only:false; response_revision:2589; number_of_response:1; }","duration":"102.090845ms","start":"2026-06-10T10:32:02.024335Z","end":"2026-06-10T10:32:02.126425Z","steps":["trace[807250892] 'process raft request' (duration: 101.895671ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:03.219145Z","caller":"traceutil/trace.go:171","msg":"trace[1320463097] linearizableReadLoop","detail":"{readStateIndex:2710; appliedIndex:2709; }","duration":"307.816947ms","start":"2026-06-10T10:32:02.911308Z","end":"2026-06-10T10:32:03.219125Z","steps":["trace[1320463097] 'read index received' (duration: 307.709694ms)","trace[1320463097] 'applied index is now lower than readState.Index' (duration: 106.293µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:32:03.219219Z","caller":"traceutil/trace.go:171","msg":"trace[877471218] transaction","detail":"{read_only:false; response_revision:2594; number_of_response:1; }","duration":"308.972337ms","start":"2026-06-10T10:32:02.910214Z","end":"2026-06-10T10:32:03.219187Z","steps":["trace[877471218] 'process raft request' (duration: 308.779182ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:03.21936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:02.910197Z","time spent":"309.09057ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:32:03.219416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.904126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-06-10T10:32:03.219456Z","caller":"traceutil/trace.go:171","msg":"trace[830501378] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:2594; }","duration":"299.942687ms","start":"2026-06-10T10:32:02.919501Z","end":"2026-06-10T10:32:03.219444Z","steps":["trace[830501378] 'agreement among raft nodes before linearized reading' (duration: 299.774703ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:03.219578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.592365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:32:03.21968Z","caller":"traceutil/trace.go:171","msg":"trace[1309068969] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2594; }","duration":"277.734629ms","start":"2026-06-10T10:32:02.941923Z","end":"2026-06-10T10:32:03.219657Z","steps":["trace[1309068969] 'agreement among raft nodes before linearized reading' (duration: 277.518253ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:03.219682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.349911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:6 size:363682"} {"level":"info","ts":"2026-06-10T10:32:03.219726Z","caller":"traceutil/trace.go:171","msg":"trace[2111752900] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:6; response_revision:2594; }","duration":"308.421933ms","start":"2026-06-10T10:32:02.911292Z","end":"2026-06-10T10:32:03.219713Z","steps":["trace[2111752900] 'agreement among raft nodes before linearized reading' (duration: 307.94741ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:03.219762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:02.911284Z","time spent":"308.467344ms","remote":"127.0.0.1:52862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":6,"response size":363704,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 "} {"level":"warn","ts":"2026-06-10T10:32:03.219771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.232686ms","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:533"} {"level":"info","ts":"2026-06-10T10:32:03.219929Z","caller":"traceutil/trace.go:171","msg":"trace[1461882864] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2594; }","duration":"120.446161ms","start":"2026-06-10T10:32:03.09945Z","end":"2026-06-10T10:32:03.219896Z","steps":["trace[1461882864] 'agreement among raft nodes before linearized reading' (duration: 119.918897ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:04.13138Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869987225591644,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T10:32:04.320468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:03.604205Z","time spent":"716.258838ms","remote":"127.0.0.1:52790","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-10T10:32:04.595792Z","caller":"traceutil/trace.go:171","msg":"trace[32895545] linearizableReadLoop","detail":"{readStateIndex:2713; appliedIndex:2712; }","duration":"965.254095ms","start":"2026-06-10T10:32:03.630513Z","end":"2026-06-10T10:32:04.595767Z","steps":["trace[32895545] 'read index received' (duration: 690.018072ms)","trace[32895545] 'applied index is now lower than readState.Index' (duration: 275.235253ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:32:04.595825Z","caller":"traceutil/trace.go:171","msg":"trace[113000674] transaction","detail":"{read_only:false; response_revision:2596; number_of_response:1; }","duration":"966.693694ms","start":"2026-06-10T10:32:03.629104Z","end":"2026-06-10T10:32:04.595797Z","steps":["trace[113000674] 'process raft request' (duration: 959.723719ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:04.595926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.40122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" ","response":"range_response_count:1 size:199"} {"level":"warn","ts":"2026-06-10T10:32:04.595944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:03.629075Z","time spent":"966.799317ms","remote":"127.0.0.1:53040","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-10T10:32:04.595957Z","caller":"traceutil/trace.go:171","msg":"trace[898038083] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/expand-controller; range_end:; response_count:1; response_revision:2596; }","duration":"965.464861ms","start":"2026-06-10T10:32:03.630483Z","end":"2026-06-10T10:32:04.595948Z","steps":["trace[898038083] 'agreement among raft nodes before linearized reading' (duration: 965.39162ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:04.595985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:03.630472Z","time spent":"965.506722ms","remote":"127.0.0.1:52974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":221,"request content":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" "} {"level":"warn","ts":"2026-06-10T10:32:04.600065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"951.500401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-06-10T10:32:04.600138Z","caller":"traceutil/trace.go:171","msg":"trace[1819905411] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:2597; }","duration":"951.610335ms","start":"2026-06-10T10:32:03.648511Z","end":"2026-06-10T10:32:04.600121Z","steps":["trace[1819905411] 'agreement among raft nodes before linearized reading' (duration: 951.473201ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:04.60017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:03.648497Z","time spent":"951.666676ms","remote":"127.0.0.1:52974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":238,"request content":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" "} {"level":"info","ts":"2026-06-10T10:32:04.600376Z","caller":"traceutil/trace.go:171","msg":"trace[713615314] transaction","detail":"{read_only:false; response_revision:2597; number_of_response:1; }","duration":"278.871019ms","start":"2026-06-10T10:32:04.321473Z","end":"2026-06-10T10:32:04.600344Z","steps":["trace[713615314] 'process raft request' (duration: 278.386395ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:04.60042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.817139ms","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-10T10:32:04.600447Z","caller":"traceutil/trace.go:171","msg":"trace[364279488] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2597; }","duration":"426.902462ms","start":"2026-06-10T10:32:04.173537Z","end":"2026-06-10T10:32:04.600439Z","steps":["trace[364279488] 'agreement among raft nodes before linearized reading' (duration: 426.795659ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:04.600465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:04.17352Z","time spent":"426.940672ms","remote":"127.0.0.1:53040","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-10T10:32:04.600544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.780077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:32:04.600625Z","caller":"traceutil/trace.go:171","msg":"trace[646642272] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2597; }","duration":"657.91463ms","start":"2026-06-10T10:32:03.942695Z","end":"2026-06-10T10:32:04.600609Z","steps":["trace[646642272] 'agreement among raft nodes before linearized reading' (duration: 657.769877ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:04.600674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:03.942674Z","time spent":"657.987281ms","remote":"127.0.0.1:52750","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-10T10:32:04.60039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.2195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-06-10T10:32:04.600764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.261259ms","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-10T10:32:04.600779Z","caller":"traceutil/trace.go:171","msg":"trace[1816363741] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2597; }","duration":"170.655562ms","start":"2026-06-10T10:32:04.430114Z","end":"2026-06-10T10:32:04.600769Z","steps":["trace[1816363741] 'agreement among raft nodes before linearized reading' (duration: 169.968544ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:04.600788Z","caller":"traceutil/trace.go:171","msg":"trace[1070137909] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2597; }","duration":"470.28682ms","start":"2026-06-10T10:32:04.130493Z","end":"2026-06-10T10:32:04.60078Z","steps":["trace[1070137909] 'agreement among raft nodes before linearized reading' (duration: 470.183577ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:04.600812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:04.130406Z","time spent":"470.401423ms","remote":"127.0.0.1:53040","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-10T10:32:04.601054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.478419ms","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-10T10:32:04.601111Z","caller":"traceutil/trace.go:171","msg":"trace[2111506548] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2597; }","duration":"161.56ms","start":"2026-06-10T10:32:04.439535Z","end":"2026-06-10T10:32:04.601095Z","steps":["trace[2111506548] 'agreement among raft nodes before linearized reading' (duration: 160.892663ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:04.875823Z","caller":"traceutil/trace.go:171","msg":"trace[221324104] transaction","detail":"{read_only:false; response_revision:2599; number_of_response:1; }","duration":"269.365348ms","start":"2026-06-10T10:32:04.606428Z","end":"2026-06-10T10:32:04.875793Z","steps":["trace[221324104] 'process raft request' (duration: 269.082811ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:04.875902Z","caller":"traceutil/trace.go:171","msg":"trace[1281658472] transaction","detail":"{read_only:false; response_revision:2600; number_of_response:1; }","duration":"269.268845ms","start":"2026-06-10T10:32:04.606624Z","end":"2026-06-10T10:32:04.875893Z","steps":["trace[1281658472] 'process raft request' (duration: 269.04276ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:04.875841Z","caller":"traceutil/trace.go:171","msg":"trace[248373154] transaction","detail":"{read_only:false; response_revision:2601; number_of_response:1; }","duration":"269.018859ms","start":"2026-06-10T10:32:04.606774Z","end":"2026-06-10T10:32:04.875793Z","steps":["trace[248373154] 'process raft request' (duration: 268.942977ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:04.875951Z","caller":"traceutil/trace.go:171","msg":"trace[1887282967] linearizableReadLoop","detail":"{readStateIndex:2719; appliedIndex:2715; }","duration":"228.145307ms","start":"2026-06-10T10:32:04.647765Z","end":"2026-06-10T10:32:04.875911Z","steps":["trace[1887282967] 'read index received' (duration: 227.796127ms)","trace[1887282967] 'applied index is now lower than readState.Index' (duration: 345.69µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:32:04.876048Z","caller":"traceutil/trace.go:171","msg":"trace[1991448430] transaction","detail":"{read_only:false; response_revision:2602; number_of_response:1; }","duration":"268.771093ms","start":"2026-06-10T10:32:04.607262Z","end":"2026-06-10T10:32:04.876033Z","steps":["trace[1991448430] 'process raft request' (duration: 268.487595ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:04.876158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.364242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-10T10:32:04.876203Z","caller":"traceutil/trace.go:171","msg":"trace[151398073] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:2602; }","duration":"228.444884ms","start":"2026-06-10T10:32:04.647745Z","end":"2026-06-10T10:32:04.87619Z","steps":["trace[151398073] 'agreement among raft nodes before linearized reading' (duration: 228.31177ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:04.90426Z","caller":"traceutil/trace.go:171","msg":"trace[424153628] transaction","detail":"{read_only:false; response_revision:2603; number_of_response:1; }","duration":"140.056911ms","start":"2026-06-10T10:32:04.764182Z","end":"2026-06-10T10:32:04.904239Z","steps":["trace[424153628] 'process raft request' (duration: 139.854416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:04.904316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.073018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"warn","ts":"2026-06-10T10:32:04.904246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.799669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" ","response":"range_response_count:1 size:199"} {"level":"info","ts":"2026-06-10T10:32:04.904357Z","caller":"traceutil/trace.go:171","msg":"trace[1263596362] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:2603; }","duration":"210.149469ms","start":"2026-06-10T10:32:04.694194Z","end":"2026-06-10T10:32:04.904343Z","steps":["trace[1263596362] 'agreement among raft nodes before linearized reading' (duration: 210.087608ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:04.904397Z","caller":"traceutil/trace.go:171","msg":"trace[1951810232] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/expand-controller; range_end:; response_count:1; response_revision:2603; }","duration":"212.969264ms","start":"2026-06-10T10:32:04.691399Z","end":"2026-06-10T10:32:04.904369Z","steps":["trace[1951810232] 'agreement among raft nodes before linearized reading' (duration: 212.762699ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:05.416011Z","caller":"traceutil/trace.go:171","msg":"trace[1082577434] linearizableReadLoop","detail":"{readStateIndex:2722; appliedIndex:2721; }","duration":"127.506499ms","start":"2026-06-10T10:32:05.288478Z","end":"2026-06-10T10:32:05.415984Z","steps":["trace[1082577434] 'read index received' (duration: 81.884159ms)","trace[1082577434] 'applied index is now lower than readState.Index' (duration: 45.62112ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:32:05.416089Z","caller":"traceutil/trace.go:171","msg":"trace[1349773354] transaction","detail":"{read_only:false; response_revision:2605; number_of_response:1; }","duration":"155.938772ms","start":"2026-06-10T10:32:05.260114Z","end":"2026-06-10T10:32:05.416052Z","steps":["trace[1349773354] 'process raft request' (duration: 110.20925ms)","trace[1349773354] 'compare' (duration: 45.506187ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:32:05.416179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.868116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:1 size:205"} {"level":"warn","ts":"2026-06-10T10:32:05.416179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.683234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-06-10T10:32:05.416213Z","caller":"traceutil/trace.go:171","msg":"trace[2145258220] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:1; response_revision:2605; }","duration":"105.938998ms","start":"2026-06-10T10:32:05.310265Z","end":"2026-06-10T10:32:05.416204Z","steps":["trace[2145258220] 'agreement among raft nodes before linearized reading' (duration: 105.867886ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:05.41622Z","caller":"traceutil/trace.go:171","msg":"trace[1828679095] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:2605; }","duration":"127.765655ms","start":"2026-06-10T10:32:05.288444Z","end":"2026-06-10T10:32:05.41621Z","steps":["trace[1828679095] 'agreement among raft nodes before linearized reading' (duration: 127.671423ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:06.325941Z","caller":"traceutil/trace.go:171","msg":"trace[1759632644] transaction","detail":"{read_only:false; response_revision:2606; number_of_response:1; }","duration":"105.251762ms","start":"2026-06-10T10:32:06.220642Z","end":"2026-06-10T10:32:06.325894Z","steps":["trace[1759632644] 'process raft request' (duration: 105.016916ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:06.790178Z","caller":"traceutil/trace.go:171","msg":"trace[1169278382] transaction","detail":"{read_only:false; response_revision:2610; number_of_response:1; }","duration":"118.83657ms","start":"2026-06-10T10:32:06.671309Z","end":"2026-06-10T10:32:06.790145Z","steps":["trace[1169278382] 'process raft request' (duration: 81.024885ms)","trace[1169278382] 'compare' (duration: 37.570898ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:32:07.065247Z","caller":"traceutil/trace.go:171","msg":"trace[1355854868] transaction","detail":"{read_only:false; response_revision:2611; number_of_response:1; }","duration":"180.859994ms","start":"2026-06-10T10:32:06.884354Z","end":"2026-06-10T10:32:07.065214Z","steps":["trace[1355854868] 'process raft request' (duration: 180.662698ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:07.123874Z","caller":"traceutil/trace.go:171","msg":"trace[1565353784] linearizableReadLoop","detail":"{readStateIndex:2730; appliedIndex:2727; }","duration":"220.919218ms","start":"2026-06-10T10:32:06.902932Z","end":"2026-06-10T10:32:07.123852Z","steps":["trace[1565353784] 'read index received' (duration: 162.14726ms)","trace[1565353784] 'applied index is now lower than readState.Index' (duration: 58.771008ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:32:07.124015Z","caller":"traceutil/trace.go:171","msg":"trace[304274526] transaction","detail":"{read_only:false; response_revision:2612; number_of_response:1; }","duration":"239.202461ms","start":"2026-06-10T10:32:06.884766Z","end":"2026-06-10T10:32:07.123969Z","steps":["trace[304274526] 'process raft request' (duration: 238.942563ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:07.12402Z","caller":"traceutil/trace.go:171","msg":"trace[69936021] transaction","detail":"{read_only:false; response_revision:2613; number_of_response:1; }","duration":"239.084248ms","start":"2026-06-10T10:32:06.884914Z","end":"2026-06-10T10:32:07.123999Z","steps":["trace[69936021] 'process raft request' (duration: 238.902882ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:07.124291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.268944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:32:07.124359Z","caller":"traceutil/trace.go:171","msg":"trace[893539039] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2613; }","duration":"181.393337ms","start":"2026-06-10T10:32:06.942949Z","end":"2026-06-10T10:32:07.124343Z","steps":["trace[893539039] 'agreement among raft nodes before linearized reading' (duration: 181.289835ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:07.124365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.356527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-06-10T10:32:07.124487Z","caller":"traceutil/trace.go:171","msg":"trace[1545793243] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/statefulset-controller; range_end:; response_count:1; response_revision:2613; }","duration":"181.49862ms","start":"2026-06-10T10:32:06.942937Z","end":"2026-06-10T10:32:07.124435Z","steps":["trace[1545793243] 'agreement among raft nodes before linearized reading' (duration: 181.310296ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:07.124801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.861673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:119 size:91798"} {"level":"info","ts":"2026-06-10T10:32:07.12486Z","caller":"traceutil/trace.go:171","msg":"trace[1266086283] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:119; response_revision:2613; }","duration":"221.956256ms","start":"2026-06-10T10:32:06.902892Z","end":"2026-06-10T10:32:07.124848Z","steps":["trace[1266086283] 'agreement among raft nodes before linearized reading' (duration: 221.177785ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:07.465372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.802184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" ","response":"range_response_count:1 size:224"} {"level":"info","ts":"2026-06-10T10:32:07.465432Z","caller":"traceutil/trace.go:171","msg":"trace[1164545782] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:1; response_revision:2614; }","duration":"111.879636ms","start":"2026-06-10T10:32:07.35354Z","end":"2026-06-10T10:32:07.46542Z","steps":["trace[1164545782] 'range keys from in-memory index tree' (duration: 111.699791ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:07.465515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.734979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/token-cleaner\" ","response":"range_response_count:1 size:191"} {"level":"info","ts":"2026-06-10T10:32:07.465582Z","caller":"traceutil/trace.go:171","msg":"trace[545459739] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/token-cleaner; range_end:; response_count:1; response_revision:2614; }","duration":"153.839292ms","start":"2026-06-10T10:32:07.311727Z","end":"2026-06-10T10:32:07.465566Z","steps":["trace[545459739] 'range keys from in-memory index tree' (duration: 153.646416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:07.725316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.068587ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-06-10T10:32:07.725387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.615828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:6 size:363682"} {"level":"info","ts":"2026-06-10T10:32:07.725486Z","caller":"traceutil/trace.go:171","msg":"trace[1010754398] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:6; response_revision:2615; }","duration":"158.749671ms","start":"2026-06-10T10:32:07.566706Z","end":"2026-06-10T10:32:07.725456Z","steps":["trace[1010754398] 'range keys from in-memory index tree' (duration: 158.37632ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:07.726004Z","caller":"traceutil/trace.go:171","msg":"trace[27808978] transaction","detail":"{read_only:false; response_revision:2616; number_of_response:1; }","duration":"157.893859ms","start":"2026-06-10T10:32:07.56752Z","end":"2026-06-10T10:32:07.725414Z","steps":["trace[27808978] 'process raft request' (duration: 44.636996ms)","trace[27808978] 'compare' (duration: 112.907853ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:32:07.726226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.768418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:6 size:363682"} {"level":"info","ts":"2026-06-10T10:32:07.726442Z","caller":"traceutil/trace.go:171","msg":"trace[454205987] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:6; response_revision:2615; }","duration":"160.190389ms","start":"2026-06-10T10:32:07.566202Z","end":"2026-06-10T10:32:07.726392Z","steps":["trace[454205987] 'range keys from in-memory index tree' (duration: 158.569667ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:09.294777Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869987225591812,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-10T10:32:09.440209Z","caller":"traceutil/trace.go:171","msg":"trace[2011517762] transaction","detail":"{read_only:false; response_revision:2617; number_of_response:1; }","duration":"803.238085ms","start":"2026-06-10T10:32:08.636953Z","end":"2026-06-10T10:32:09.440191Z","steps":["trace[2011517762] 'process raft request' (duration: 803.131702ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:09.440328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:08.636931Z","time spent":"803.331067ms","remote":"127.0.0.1:53040","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-10T10:32:09.535766Z","caller":"traceutil/trace.go:171","msg":"trace[377654814] linearizableReadLoop","detail":"{readStateIndex:2735; appliedIndex:2734; }","duration":"741.574522ms","start":"2026-06-10T10:32:08.794164Z","end":"2026-06-10T10:32:09.535738Z","steps":["trace[377654814] 'read index received' (duration: 646.028905ms)","trace[377654814] 'applied index is now lower than readState.Index' (duration: 95.544137ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:32:09.535961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.474792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:32:09.536005Z","caller":"traceutil/trace.go:171","msg":"trace[196328304] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2617; }","duration":"568.567284ms","start":"2026-06-10T10:32:08.967425Z","end":"2026-06-10T10:32:09.535992Z","steps":["trace[196328304] 'agreement among raft nodes before linearized reading' (duration: 568.463762ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:09.536043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:08.967409Z","time spent":"568.626416ms","remote":"127.0.0.1:52764","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-10T10:32:09.536066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.877179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-06-10T10:32:09.536093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.48279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-10T10:32:09.536192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.871862ms","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-10T10:32:09.536247Z","caller":"traceutil/trace.go:171","msg":"trace[1828129636] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2617; }","duration":"252.667594ms","start":"2026-06-10T10:32:09.283566Z","end":"2026-06-10T10:32:09.536234Z","steps":["trace[1828129636] 'agreement among raft nodes before linearized reading' (duration: 252.400238ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:09.536268Z","caller":"traceutil/trace.go:171","msg":"trace[775271726] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2617; }","duration":"408.004816ms","start":"2026-06-10T10:32:09.128248Z","end":"2026-06-10T10:32:09.536253Z","steps":["trace[775271726] 'agreement among raft nodes before linearized reading' (duration: 407.76726ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:09.536304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:09.128229Z","time spent":"408.068117ms","remote":"127.0.0.1:53040","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-10T10:32:09.53615Z","caller":"traceutil/trace.go:171","msg":"trace[1201250442] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2617; }","duration":"742.002653ms","start":"2026-06-10T10:32:08.794129Z","end":"2026-06-10T10:32:09.536132Z","steps":["trace[1201250442] 'agreement among raft nodes before linearized reading' (duration: 741.724856ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:09.536307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.660564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-06-10T10:32:09.536352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:08.794114Z","time spent":"742.227188ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-10T10:32:09.536362Z","caller":"traceutil/trace.go:171","msg":"trace[134506699] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2617; }","duration":"465.761866ms","start":"2026-06-10T10:32:09.070587Z","end":"2026-06-10T10:32:09.536349Z","steps":["trace[134506699] 'agreement among raft nodes before linearized reading' (duration: 465.554181ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:09.536396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:09.070565Z","time spent":"465.822678ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-10T10:32:09.536115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.910205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:32:09.536492Z","caller":"traceutil/trace.go:171","msg":"trace[777525771] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2617; }","duration":"383.348327ms","start":"2026-06-10T10:32:09.153116Z","end":"2026-06-10T10:32:09.536464Z","steps":["trace[777525771] 'agreement among raft nodes before linearized reading' (duration: 382.831703ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:09.536526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:09.153105Z","time spent":"383.410898ms","remote":"127.0.0.1:43458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:32:09.536201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.843025ms","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-10T10:32:09.536549Z","caller":"traceutil/trace.go:171","msg":"trace[1412988966] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2617; }","duration":"399.213475ms","start":"2026-06-10T10:32:09.137329Z","end":"2026-06-10T10:32:09.536543Z","steps":["trace[1412988966] 'agreement among raft nodes before linearized reading' (duration: 398.829215ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:09.536575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:09.137314Z","time spent":"399.254116ms","remote":"127.0.0.1:53040","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":"info","ts":"2026-06-10T10:32:09.675387Z","caller":"traceutil/trace.go:171","msg":"trace[1852982017] transaction","detail":"{read_only:false; response_revision:2620; number_of_response:1; }","duration":"134.252556ms","start":"2026-06-10T10:32:09.541111Z","end":"2026-06-10T10:32:09.675363Z","steps":["trace[1852982017] 'process raft request' (duration: 134.143624ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:09.675788Z","caller":"traceutil/trace.go:171","msg":"trace[2059798875] transaction","detail":"{read_only:false; response_revision:2621; number_of_response:1; }","duration":"134.629857ms","start":"2026-06-10T10:32:09.541147Z","end":"2026-06-10T10:32:09.675777Z","steps":["trace[2059798875] 'process raft request' (duration: 134.174864ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:09.67539Z","caller":"traceutil/trace.go:171","msg":"trace[1781273861] transaction","detail":"{read_only:false; response_revision:2619; number_of_response:1; }","duration":"134.308858ms","start":"2026-06-10T10:32:09.541024Z","end":"2026-06-10T10:32:09.675333Z","steps":["trace[1781273861] 'process raft request' (duration: 119.938318ms)","trace[1781273861] 'compare' (duration: 14.103083ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:32:09.676239Z","caller":"traceutil/trace.go:171","msg":"trace[1635038654] transaction","detail":"{read_only:false; response_revision:2622; number_of_response:1; }","duration":"135.059898ms","start":"2026-06-10T10:32:09.541169Z","end":"2026-06-10T10:32:09.676229Z","steps":["trace[1635038654] 'process raft request' (duration: 134.537984ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:09.676227Z","caller":"traceutil/trace.go:171","msg":"trace[2065321507] linearizableReadLoop","detail":"{readStateIndex:2740; appliedIndex:2735; }","duration":"109.277708ms","start":"2026-06-10T10:32:09.566927Z","end":"2026-06-10T10:32:09.676204Z","steps":["trace[2065321507] 'read index received' (duration: 51.26848ms)","trace[2065321507] 'applied index is now lower than readState.Index' (duration: 58.007498ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:32:09.676399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.461392ms","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:533"} {"level":"info","ts":"2026-06-10T10:32:09.67664Z","caller":"traceutil/trace.go:171","msg":"trace[1531034595] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2622; }","duration":"109.747241ms","start":"2026-06-10T10:32:09.566883Z","end":"2026-06-10T10:32:09.67663Z","steps":["trace[1531034595] 'agreement among raft nodes before linearized reading' (duration: 109.374451ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:09.868255Z","caller":"traceutil/trace.go:171","msg":"trace[346829040] transaction","detail":"{read_only:false; response_revision:2623; number_of_response:1; }","duration":"187.377564ms","start":"2026-06-10T10:32:09.680855Z","end":"2026-06-10T10:32:09.868233Z","steps":["trace[346829040] 'process raft request' (duration: 184.353465ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:11.911815Z","caller":"traceutil/trace.go:171","msg":"trace[1986806812] transaction","detail":"{read_only:false; response_revision:2629; number_of_response:1; }","duration":"213.680467ms","start":"2026-06-10T10:32:11.698113Z","end":"2026-06-10T10:32:11.911794Z","steps":["trace[1986806812] 'process raft request' (duration: 210.633177ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:11.911987Z","caller":"traceutil/trace.go:171","msg":"trace[2021092755] transaction","detail":"{read_only:false; response_revision:2630; number_of_response:1; }","duration":"213.74476ms","start":"2026-06-10T10:32:11.698216Z","end":"2026-06-10T10:32:11.91196Z","steps":["trace[2021092755] 'process raft request' (duration: 213.544664ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:11.912435Z","caller":"traceutil/trace.go:171","msg":"trace[441744973] linearizableReadLoop","detail":"{readStateIndex:2750; appliedIndex:2746; }","duration":"161.857622ms","start":"2026-06-10T10:32:11.750557Z","end":"2026-06-10T10:32:11.912414Z","steps":["trace[441744973] 'read index received' (duration: 158.204706ms)","trace[441744973] 'applied index is now lower than readState.Index' (duration: 3.651266ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:32:11.912439Z","caller":"traceutil/trace.go:171","msg":"trace[243066307] transaction","detail":"{read_only:false; response_revision:2631; number_of_response:1; }","duration":"164.664487ms","start":"2026-06-10T10:32:11.747759Z","end":"2026-06-10T10:32:11.912424Z","steps":["trace[243066307] 'process raft request' (duration: 164.473952ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:11.912474Z","caller":"traceutil/trace.go:171","msg":"trace[242306334] transaction","detail":"{read_only:false; response_revision:2632; number_of_response:1; }","duration":"162.203682ms","start":"2026-06-10T10:32:11.750258Z","end":"2026-06-10T10:32:11.912462Z","steps":["trace[242306334] 'process raft request' (duration: 162.110049ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:11.912595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.572886ms","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-10T10:32:11.912635Z","caller":"traceutil/trace.go:171","msg":"trace[478164659] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:2632; }","duration":"120.659949ms","start":"2026-06-10T10:32:11.791965Z","end":"2026-06-10T10:32:11.912625Z","steps":["trace[478164659] 'agreement among raft nodes before linearized reading' (duration: 120.582906ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:11.912655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.086089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-gpmn4\" ","response":"range_response_count:1 size:13724"} {"level":"info","ts":"2026-06-10T10:32:11.912696Z","caller":"traceutil/trace.go:171","msg":"trace[520212186] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-gpmn4; range_end:; response_count:1; response_revision:2632; }","duration":"162.170471ms","start":"2026-06-10T10:32:11.750512Z","end":"2026-06-10T10:32:11.912682Z","steps":["trace[520212186] 'agreement among raft nodes before linearized reading' (duration: 162.006296ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:13.737393Z","caller":"traceutil/trace.go:171","msg":"trace[223584821] linearizableReadLoop","detail":"{readStateIndex:2754; appliedIndex:2753; }","duration":"108.328203ms","start":"2026-06-10T10:32:13.62904Z","end":"2026-06-10T10:32:13.737368Z","steps":["trace[223584821] 'read index received' (duration: 16.923715ms)","trace[223584821] 'applied index is now lower than readState.Index' (duration: 91.403068ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:32:13.737939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.854228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6586z\" ","response":"range_response_count:1 size:18525"} {"level":"info","ts":"2026-06-10T10:32:13.737982Z","caller":"traceutil/trace.go:171","msg":"trace[1022399047] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6586z; range_end:; response_count:1; response_revision:2635; }","duration":"108.994271ms","start":"2026-06-10T10:32:13.628978Z","end":"2026-06-10T10:32:13.737972Z","steps":["trace[1022399047] 'agreement among raft nodes before linearized reading' (duration: 108.529588ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:13.938871Z","caller":"traceutil/trace.go:171","msg":"trace[1464135619] linearizableReadLoop","detail":"{readStateIndex:2756; appliedIndex:2754; }","duration":"191.955995ms","start":"2026-06-10T10:32:13.746889Z","end":"2026-06-10T10:32:13.938845Z","steps":["trace[1464135619] 'read index received' (duration: 23.252433ms)","trace[1464135619] 'applied index is now lower than readState.Index' (duration: 168.702262ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:32:13.939197Z","caller":"traceutil/trace.go:171","msg":"trace[1429930520] transaction","detail":"{read_only:false; response_revision:2637; number_of_response:1; }","duration":"197.015089ms","start":"2026-06-10T10:32:13.742162Z","end":"2026-06-10T10:32:13.939177Z","steps":["trace[1429930520] 'process raft request' (duration: 103.784204ms)","trace[1429930520] 'compare' (duration: 92.537516ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:32:13.939656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.23142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6586z\" ","response":"range_response_count:1 size:18525"} {"level":"warn","ts":"2026-06-10T10:32:13.939718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.493409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T10:32:13.939831Z","caller":"traceutil/trace.go:171","msg":"trace[2136342415] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:2637; }","duration":"102.692863ms","start":"2026-06-10T10:32:13.837115Z","end":"2026-06-10T10:32:13.939808Z","steps":["trace[2136342415] 'agreement among raft nodes before linearized reading' (duration: 102.501968ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:13.939738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.237467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"warn","ts":"2026-06-10T10:32:13.939668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.858944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:32:13.939834Z","caller":"traceutil/trace.go:171","msg":"trace[1800541073] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6586z; range_end:; response_count:1; response_revision:2637; }","duration":"190.422515ms","start":"2026-06-10T10:32:13.749356Z","end":"2026-06-10T10:32:13.939778Z","steps":["trace[1800541073] 'agreement among raft nodes before linearized reading' (duration: 190.031675ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:13.940066Z","caller":"traceutil/trace.go:171","msg":"trace[1630352008] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2637; }","duration":"129.276855ms","start":"2026-06-10T10:32:13.810758Z","end":"2026-06-10T10:32:13.940035Z","steps":["trace[1630352008] 'agreement among raft nodes before linearized reading' (duration: 128.781462ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:13.939955Z","caller":"traceutil/trace.go:171","msg":"trace[1894719970] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:2637; }","duration":"166.521525ms","start":"2026-06-10T10:32:13.773419Z","end":"2026-06-10T10:32:13.939941Z","steps":["trace[1894719970] 'agreement among raft nodes before linearized reading' (duration: 166.252388ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:13.940281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.714865ms","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-10T10:32:13.940323Z","caller":"traceutil/trace.go:171","msg":"trace[774027439] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2637; }","duration":"193.477635ms","start":"2026-06-10T10:32:13.746835Z","end":"2026-06-10T10:32:13.940313Z","steps":["trace[774027439] 'agreement among raft nodes before linearized reading' (duration: 192.549901ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:14.293874Z","caller":"traceutil/trace.go:171","msg":"trace[91318450] linearizableReadLoop","detail":"{readStateIndex:2760; appliedIndex:2757; }","duration":"310.067016ms","start":"2026-06-10T10:32:13.98378Z","end":"2026-06-10T10:32:14.293847Z","steps":["trace[91318450] 'read index received' (duration: 16.392201ms)","trace[91318450] 'applied index is now lower than readState.Index' (duration: 293.673715ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:32:14.294028Z","caller":"traceutil/trace.go:171","msg":"trace[93739049] transaction","detail":"{read_only:false; response_revision:2640; number_of_response:1; }","duration":"345.281454ms","start":"2026-06-10T10:32:13.948704Z","end":"2026-06-10T10:32:14.293986Z","steps":["trace[93739049] 'process raft request' (duration: 345.073988ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:14.293935Z","caller":"traceutil/trace.go:171","msg":"trace[2089780351] transaction","detail":"{read_only:false; response_revision:2639; number_of_response:1; }","duration":"346.25179ms","start":"2026-06-10T10:32:13.947637Z","end":"2026-06-10T10:32:14.293889Z","steps":["trace[2089780351] 'process raft request' (duration: 345.916071ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:14.294028Z","caller":"traceutil/trace.go:171","msg":"trace[1009744127] transaction","detail":"{read_only:false; response_revision:2641; number_of_response:1; }","duration":"344.407641ms","start":"2026-06-10T10:32:13.949599Z","end":"2026-06-10T10:32:14.294007Z","steps":["trace[1009744127] 'process raft request' (duration: 344.216716ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:14.294571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.145468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6586z\" ","response":"range_response_count:1 size:18525"} {"level":"info","ts":"2026-06-10T10:32:14.29475Z","caller":"traceutil/trace.go:171","msg":"trace[246488048] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6586z; range_end:; response_count:1; response_revision:2641; }","duration":"242.348063ms","start":"2026-06-10T10:32:14.052375Z","end":"2026-06-10T10:32:14.294723Z","steps":["trace[246488048] 'agreement among raft nodes before linearized reading' (duration: 241.906602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:14.294785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:13.947579Z","time spent":"346.818035ms","remote":"127.0.0.1:53040","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-10T10:32:14.294335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.518179ms","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:533"} {"level":"info","ts":"2026-06-10T10:32:14.29527Z","caller":"traceutil/trace.go:171","msg":"trace[720249915] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2641; }","duration":"311.498584ms","start":"2026-06-10T10:32:13.983742Z","end":"2026-06-10T10:32:14.295241Z","steps":["trace[720249915] 'agreement among raft nodes before linearized reading' (duration: 310.259801ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:14.294659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:13.949593Z","time spent":"344.963516ms","remote":"127.0.0.1:53040","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-10T10:32:14.295387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:13.983724Z","time spent":"311.625258ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-06-10T10:32:14.294212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:13.948696Z","time spent":"345.422497ms","remote":"127.0.0.1:53040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:32:14.615722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.982551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6586z\" ","response":"range_response_count:1 size:18525"} {"level":"info","ts":"2026-06-10T10:32:14.615798Z","caller":"traceutil/trace.go:171","msg":"trace[134495583] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6586z; range_end:; response_count:1; response_revision:2642; }","duration":"128.101394ms","start":"2026-06-10T10:32:14.48768Z","end":"2026-06-10T10:32:14.615782Z","steps":["trace[134495583] 'range keys from in-memory index tree' (duration: 127.861047ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:16.119097Z","caller":"traceutil/trace.go:171","msg":"trace[414169083] linearizableReadLoop","detail":"{readStateIndex:2765; appliedIndex:2764; }","duration":"115.179774ms","start":"2026-06-10T10:32:16.003892Z","end":"2026-06-10T10:32:16.119072Z","steps":["trace[414169083] 'read index received' (duration: 115.0444ms)","trace[414169083] 'applied index is now lower than readState.Index' (duration: 134.064µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:32:16.11916Z","caller":"traceutil/trace.go:171","msg":"trace[302898598] transaction","detail":"{read_only:false; response_revision:2646; number_of_response:1; }","duration":"169.402102ms","start":"2026-06-10T10:32:15.949715Z","end":"2026-06-10T10:32:16.119117Z","steps":["trace[302898598] 'process raft request' (duration: 169.191387ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:16.119501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.604766ms","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-10T10:32:16.119552Z","caller":"traceutil/trace.go:171","msg":"trace[732087215] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2646; }","duration":"115.730858ms","start":"2026-06-10T10:32:16.003809Z","end":"2026-06-10T10:32:16.11954Z","steps":["trace[732087215] 'agreement among raft nodes before linearized reading' (duration: 115.410059ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:16.460212Z","caller":"traceutil/trace.go:171","msg":"trace[279127671] transaction","detail":"{read_only:false; response_revision:2649; number_of_response:1; }","duration":"157.278761ms","start":"2026-06-10T10:32:16.302903Z","end":"2026-06-10T10:32:16.460181Z","steps":["trace[279127671] 'process raft request' (duration: 156.927852ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:16.460279Z","caller":"traceutil/trace.go:171","msg":"trace[609736319] transaction","detail":"{read_only:false; response_revision:2650; number_of_response:1; }","duration":"156.911682ms","start":"2026-06-10T10:32:16.303343Z","end":"2026-06-10T10:32:16.460254Z","steps":["trace[609736319] 'process raft request' (duration: 156.715387ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:16.740326Z","caller":"traceutil/trace.go:171","msg":"trace[148350536] linearizableReadLoop","detail":"{readStateIndex:2771; appliedIndex:2770; }","duration":"149.59169ms","start":"2026-06-10T10:32:16.590707Z","end":"2026-06-10T10:32:16.740299Z","steps":["trace[148350536] 'read index received' (duration: 122.540848ms)","trace[148350536] 'applied index is now lower than readState.Index' (duration: 27.049382ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:32:16.740473Z","caller":"traceutil/trace.go:171","msg":"trace[1812327127] transaction","detail":"{read_only:false; response_revision:2652; number_of_response:1; }","duration":"163.548248ms","start":"2026-06-10T10:32:16.576871Z","end":"2026-06-10T10:32:16.740419Z","steps":["trace[1812327127] 'process raft request' (duration: 136.475934ms)","trace[1812327127] 'compare' (duration: 26.833857ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:32:16.740654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.263158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-cnlb6\" ","response":"range_response_count:1 size:4908"} {"level":"warn","ts":"2026-06-10T10:32:16.740652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.900678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-06-10T10:32:16.740697Z","caller":"traceutil/trace.go:171","msg":"trace[535600106] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-cnlb6; range_end:; response_count:1; response_revision:2652; }","duration":"109.346849ms","start":"2026-06-10T10:32:16.631337Z","end":"2026-06-10T10:32:16.740684Z","steps":["trace[535600106] 'agreement among raft nodes before linearized reading' (duration: 109.150194ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:16.740711Z","caller":"traceutil/trace.go:171","msg":"trace[527837803] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2652; }","duration":"150.030632ms","start":"2026-06-10T10:32:16.590663Z","end":"2026-06-10T10:32:16.740694Z","steps":["trace[527837803] 'agreement among raft nodes before linearized reading' (duration: 149.758955ms)"],"step_count":1}