{"level":"warn","ts":"2026-04-14T10:43:53.7494Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-14T10:43:53.749519Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.43: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.19.213.43:2380","--initial-cluster=instance=https://199.19.213.43:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.43:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.43:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-14T10:43:53.749593Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-14T10:43:53.749602Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.43:2380"]} {"level":"info","ts":"2026-04-14T10:43:53.749627Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-14T10:43:53.751021Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.43:2379"]} {"level":"info","ts":"2026-04-14T10:43:53.751276Z","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.19.213.43:2380"],"listen-peer-urls":["https://199.19.213.43:2380"],"advertise-client-urls":["https://199.19.213.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.43:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-14T10:43:53.757695Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.354439ms"} {"level":"info","ts":"2026-04-14T10:43:53.765188Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a8d0274548ffaee4","cluster-id":"858b677d1d9175b1"} {"level":"info","ts":"2026-04-14T10:43:53.765304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a8d0274548ffaee4 switched to configuration voters=()"} {"level":"info","ts":"2026-04-14T10:43:53.765328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a8d0274548ffaee4 became follower at term 0"} {"level":"info","ts":"2026-04-14T10:43:53.765347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a8d0274548ffaee4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-14T10:43:53.765366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a8d0274548ffaee4 became follower at term 1"} {"level":"info","ts":"2026-04-14T10:43:53.765423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a8d0274548ffaee4 switched to configuration voters=(12164265772058652388)"} {"level":"warn","ts":"2026-04-14T10:43:53.772831Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-14T10:43:53.774395Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-14T10:43:53.776519Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-14T10:43:53.779235Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a8d0274548ffaee4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-14T10:43:53.779429Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a8d0274548ffaee4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-14T10:43:53.781507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a8d0274548ffaee4 switched to configuration voters=(12164265772058652388)"} {"level":"info","ts":"2026-04-14T10:43:53.781672Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"858b677d1d9175b1","local-member-id":"a8d0274548ffaee4","added-peer-id":"a8d0274548ffaee4","added-peer-peer-urls":["https://199.19.213.43:2380"]} {"level":"info","ts":"2026-04-14T10:43:53.781738Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-14T10:43:53.781789Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-14T10:43:53.781805Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-14T10:43:53.78429Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-14T10:43:53.784381Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.43:2380"} {"level":"info","ts":"2026-04-14T10:43:53.784411Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.43:2380"} {"level":"info","ts":"2026-04-14T10:43:53.784727Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a8d0274548ffaee4","initial-advertise-peer-urls":["https://199.19.213.43:2380"],"listen-peer-urls":["https://199.19.213.43:2380"],"advertise-client-urls":["https://199.19.213.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-14T10:43:53.784848Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-14T10:43:54.765808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a8d0274548ffaee4 is starting a new election at term 1"} {"level":"info","ts":"2026-04-14T10:43:54.765874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a8d0274548ffaee4 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-14T10:43:54.76591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a8d0274548ffaee4 received MsgPreVoteResp from a8d0274548ffaee4 at term 1"} {"level":"info","ts":"2026-04-14T10:43:54.765932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a8d0274548ffaee4 became candidate at term 2"} {"level":"info","ts":"2026-04-14T10:43:54.765946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a8d0274548ffaee4 received MsgVoteResp from a8d0274548ffaee4 at term 2"} {"level":"info","ts":"2026-04-14T10:43:54.765962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a8d0274548ffaee4 became leader at term 2"} {"level":"info","ts":"2026-04-14T10:43:54.765976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a8d0274548ffaee4 elected leader a8d0274548ffaee4 at term 2"} {"level":"info","ts":"2026-04-14T10:43:54.884311Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T10:43:54.884283Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a8d0274548ffaee4","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.43:2379]}","request-path":"/0/members/a8d0274548ffaee4/attributes","cluster-id":"858b677d1d9175b1","publish-timeout":"7s"} {"level":"info","ts":"2026-04-14T10:43:54.88449Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T10:43:54.88444Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T10:43:54.88495Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-14T10:43:54.88521Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-14T10:43:54.885892Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"858b677d1d9175b1","local-member-id":"a8d0274548ffaee4","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T10:43:54.886029Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T10:43:54.886119Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T10:43:54.888725Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-14T10:43:54.890686Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.43:2379"} {"level":"info","ts":"2026-04-14T10:43:56.240013Z","caller":"traceutil/trace.go:171","msg":"trace[980999692] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:5; }","duration":"111.191515ms","start":"2026-04-14T10:43:56.1288Z","end":"2026-04-14T10:43:56.239992Z","steps":["trace[980999692] 'read index received' (duration: 38.360536ms)","trace[980999692] 'applied index is now lower than readState.Index' (duration: 72.830009ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:43:56.240042Z","caller":"traceutil/trace.go:171","msg":"trace[447212267] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"119.606826ms","start":"2026-04-14T10:43:56.12041Z","end":"2026-04-14T10:43:56.240017Z","steps":["trace[447212267] 'process raft request' (duration: 119.442354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:43:56.240304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.461778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-14T10:43:56.240356Z","caller":"traceutil/trace.go:171","msg":"trace[177792347] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:0; response_revision:3; }","duration":"111.560908ms","start":"2026-04-14T10:43:56.128784Z","end":"2026-04-14T10:43:56.240345Z","steps":["trace[177792347] 'agreement among raft nodes before linearized reading' (duration: 111.329866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:43:56.248741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.237862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-14T10:43:56.249473Z","caller":"traceutil/trace.go:171","msg":"trace[590278809] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:9; }","duration":"119.97946ms","start":"2026-04-14T10:43:56.129468Z","end":"2026-04-14T10:43:56.249447Z","steps":["trace[590278809] 'agreement among raft nodes before linearized reading' (duration: 119.205392ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:43:58.408436Z","caller":"traceutil/trace.go:171","msg":"trace[1242989051] transaction","detail":"{read_only:false; response_revision:208; number_of_response:1; }","duration":"214.739311ms","start":"2026-04-14T10:43:58.193673Z","end":"2026-04-14T10:43:58.408412Z","steps":["trace[1242989051] 'process raft request' (duration: 148.414193ms)","trace[1242989051] 'compare' (duration: 66.236867ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:43:58.806873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.354901ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:43:58.807169Z","caller":"traceutil/trace.go:171","msg":"trace[1492490005] transaction","detail":"{read_only:false; response_revision:212; number_of_response:1; }","duration":"392.207971ms","start":"2026-04-14T10:43:58.414947Z","end":"2026-04-14T10:43:58.807155Z","steps":["trace[1492490005] 'process raft request' (duration: 392.16332ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:43:58.807256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:43:58.414924Z","time spent":"392.280241ms","remote":"127.0.0.1:54000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":636,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:43:58.807382Z","caller":"traceutil/trace.go:171","msg":"trace[433818126] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"393.353703ms","start":"2026-04-14T10:43:58.414003Z","end":"2026-04-14T10:43:58.807357Z","steps":["trace[433818126] 'process raft request' (duration: 167.87914ms)","trace[433818126] 'compare' (duration: 224.21016ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:43:58.807491Z","caller":"traceutil/trace.go:171","msg":"trace[761796553] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"393.169411ms","start":"2026-04-14T10:43:58.414286Z","end":"2026-04-14T10:43:58.807456Z","steps":["trace[761796553] 'process raft request' (duration: 392.761667ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:43:58.807533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:43:58.414276Z","time spent":"393.236942ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:43:58.807661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:43:58.41398Z","time spent":"393.457474ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:43:58.815187Z","caller":"traceutil/trace.go:171","msg":"trace[20130703] transaction","detail":"{read_only:false; response_revision:213; number_of_response:1; }","duration":"338.296596ms","start":"2026-04-14T10:43:58.476867Z","end":"2026-04-14T10:43:58.815164Z","steps":["trace[20130703] 'process raft request' (duration: 338.104854ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:43:58.815408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:43:58.476835Z","time spent":"338.420887ms","remote":"127.0.0.1:54256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":342,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T10:43:58.993369Z","caller":"traceutil/trace.go:171","msg":"trace[631211360] linearizableReadLoop","detail":"{readStateIndex:223; appliedIndex:222; }","duration":"116.465233ms","start":"2026-04-14T10:43:58.876885Z","end":"2026-04-14T10:43:58.99335Z","steps":["trace[631211360] 'read index received' (duration: 79.004893ms)","trace[631211360] 'applied index is now lower than readState.Index' (duration: 37.45979ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:43:58.993532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.635354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18a633398fde14b7\" ","response":"range_response_count:1 size:651"} {"level":"info","ts":"2026-04-14T10:43:58.993529Z","caller":"traceutil/trace.go:171","msg":"trace[917506016] transaction","detail":"{read_only:false; response_revision:217; number_of_response:1; }","duration":"138.605008ms","start":"2026-04-14T10:43:58.854835Z","end":"2026-04-14T10:43:58.99344Z","steps":["trace[917506016] 'process raft request' (duration: 101.084468ms)","trace[917506016] 'compare' (duration: 37.362159ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:43:58.993563Z","caller":"traceutil/trace.go:171","msg":"trace[1219471340] range","detail":"{range_begin:/registry/events/default/instance.18a633398fde14b7; range_end:; response_count:1; response_revision:217; }","duration":"116.708675ms","start":"2026-04-14T10:43:58.876845Z","end":"2026-04-14T10:43:58.993553Z","steps":["trace[1219471340] 'agreement among raft nodes before linearized reading' (duration: 116.590023ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:43:59.222381Z","caller":"traceutil/trace.go:171","msg":"trace[1820340526] linearizableReadLoop","detail":"{readStateIndex:227; appliedIndex:226; }","duration":"149.177976ms","start":"2026-04-14T10:43:59.073174Z","end":"2026-04-14T10:43:59.222352Z","steps":["trace[1820340526] 'read index received' (duration: 64.866485ms)","trace[1820340526] 'applied index is now lower than readState.Index' (duration: 84.310661ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:43:59.222466Z","caller":"traceutil/trace.go:171","msg":"trace[2036997725] transaction","detail":"{read_only:false; response_revision:221; number_of_response:1; }","duration":"195.020771ms","start":"2026-04-14T10:43:59.02742Z","end":"2026-04-14T10:43:59.222441Z","steps":["trace[2036997725] 'process raft request' (duration: 110.67193ms)","trace[2036997725] 'compare' (duration: 84.154979ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:43:59.222596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.401649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18a633398fde02d3\" ","response":"range_response_count:1 size:653"} {"level":"info","ts":"2026-04-14T10:43:59.22266Z","caller":"traceutil/trace.go:171","msg":"trace[1305488004] range","detail":"{range_begin:/registry/events/default/instance.18a633398fde02d3; range_end:; response_count:1; response_revision:221; }","duration":"149.51254ms","start":"2026-04-14T10:43:59.073131Z","end":"2026-04-14T10:43:59.222643Z","steps":["trace[1305488004] 'agreement among raft nodes before linearized reading' (duration: 149.334418ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:13.064882Z","caller":"traceutil/trace.go:171","msg":"trace[1603647426] linearizableReadLoop","detail":"{readStateIndex:465; appliedIndex:464; }","duration":"166.197578ms","start":"2026-04-14T10:44:12.898662Z","end":"2026-04-14T10:44:13.06486Z","steps":["trace[1603647426] 'read index received' (duration: 88.490548ms)","trace[1603647426] 'applied index is now lower than readState.Index' (duration: 77.70434ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:44:13.064952Z","caller":"traceutil/trace.go:171","msg":"trace[373524990] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"303.851585ms","start":"2026-04-14T10:44:12.761073Z","end":"2026-04-14T10:44:13.064924Z","steps":["trace[373524990] 'process raft request' (duration: 226.098304ms)","trace[373524990] 'compare' (duration: 77.567949ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:44:13.065047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.37567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-14T10:44:13.065081Z","caller":"traceutil/trace.go:171","msg":"trace[1166081705] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:451; }","duration":"166.450271ms","start":"2026-04-14T10:44:12.898621Z","end":"2026-04-14T10:44:13.065072Z","steps":["trace[1166081705] 'agreement among raft nodes before linearized reading' (duration: 166.373701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:13.06508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:12.761058Z","time spent":"303.948766ms","remote":"127.0.0.1:54120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6946,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:44:13.065191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.330026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-14T10:44:13.065292Z","caller":"traceutil/trace.go:171","msg":"trace[881348016] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:451; }","duration":"145.467908ms","start":"2026-04-14T10:44:12.919804Z","end":"2026-04-14T10:44:13.065272Z","steps":["trace[881348016] 'agreement among raft nodes before linearized reading' (duration: 145.284086ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:13.284016Z","caller":"traceutil/trace.go:171","msg":"trace[2064317365] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"123.901906ms","start":"2026-04-14T10:44:13.160093Z","end":"2026-04-14T10:44:13.283995Z","steps":["trace[2064317365] 'process raft request' (duration: 122.867056ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:15.663734Z","caller":"traceutil/trace.go:171","msg":"trace[1741945747] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"172.936211ms","start":"2026-04-14T10:44:15.490779Z","end":"2026-04-14T10:44:15.663715Z","steps":["trace[1741945747] 'process raft request' (duration: 172.80388ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:17.284369Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12602370880151824636,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-14T10:44:17.378008Z","caller":"traceutil/trace.go:171","msg":"trace[1993405214] linearizableReadLoop","detail":"{readStateIndex:476; appliedIndex:475; }","duration":"594.092805ms","start":"2026-04-14T10:44:16.783885Z","end":"2026-04-14T10:44:17.377978Z","steps":["trace[1993405214] 'read index received' (duration: 593.899083ms)","trace[1993405214] 'applied index is now lower than readState.Index' (duration: 193.062µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:44:17.378097Z","caller":"traceutil/trace.go:171","msg":"trace[1537548705] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"750.6072ms","start":"2026-04-14T10:44:16.627468Z","end":"2026-04-14T10:44:17.378075Z","steps":["trace[1537548705] 'process raft request' (duration: 750.384198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:17.378201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.303757ms","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-04-14T10:44:17.378223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.700054ms","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-04-14T10:44:17.37831Z","caller":"traceutil/trace.go:171","msg":"trace[1016161970] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:461; }","duration":"242.822755ms","start":"2026-04-14T10:44:17.135473Z","end":"2026-04-14T10:44:17.378296Z","steps":["trace[1016161970] 'agreement among raft nodes before linearized reading' (duration: 242.699463ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:17.378249Z","caller":"traceutil/trace.go:171","msg":"trace[605143239] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:461; }","duration":"594.354127ms","start":"2026-04-14T10:44:16.78388Z","end":"2026-04-14T10:44:17.378234Z","steps":["trace[605143239] 'agreement among raft nodes before linearized reading' (duration: 594.264916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:17.378243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:16.62744Z","time spent":"750.705971ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:44:17.378491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:16.783837Z","time spent":"594.609179ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-14T10:44:17.378363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.921622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-14T10:44:17.378622Z","caller":"traceutil/trace.go:171","msg":"trace[1268271896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:461; }","duration":"214.214675ms","start":"2026-04-14T10:44:17.164389Z","end":"2026-04-14T10:44:17.378604Z","steps":["trace[1268271896] 'agreement among raft nodes before linearized reading' (duration: 213.891101ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:17.527261Z","caller":"traceutil/trace.go:171","msg":"trace[1599643288] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"145.104841ms","start":"2026-04-14T10:44:17.382132Z","end":"2026-04-14T10:44:17.527237Z","steps":["trace[1599643288] 'process raft request' (duration: 85.760531ms)","trace[1599643288] 'compare' (duration: 59.203389ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:44:17.527603Z","caller":"traceutil/trace.go:171","msg":"trace[1659198678] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"142.493207ms","start":"2026-04-14T10:44:17.385089Z","end":"2026-04-14T10:44:17.527582Z","steps":["trace[1659198678] 'process raft request' (duration: 142.368806ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:17.527606Z","caller":"traceutil/trace.go:171","msg":"trace[1252698552] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"144.304914ms","start":"2026-04-14T10:44:17.38327Z","end":"2026-04-14T10:44:17.527575Z","steps":["trace[1252698552] 'process raft request' (duration: 143.93119ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:17.824424Z","caller":"traceutil/trace.go:171","msg":"trace[1265225392] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"147.550844ms","start":"2026-04-14T10:44:17.676849Z","end":"2026-04-14T10:44:17.8244Z","steps":["trace[1265225392] 'process raft request' (duration: 147.422933ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:19.680485Z","caller":"traceutil/trace.go:171","msg":"trace[1146015163] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"143.740066ms","start":"2026-04-14T10:44:19.536722Z","end":"2026-04-14T10:44:19.680462Z","steps":["trace[1146015163] 'process raft request' (duration: 143.686155ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:19.680547Z","caller":"traceutil/trace.go:171","msg":"trace[1000025521] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"143.819976ms","start":"2026-04-14T10:44:19.536694Z","end":"2026-04-14T10:44:19.680514Z","steps":["trace[1000025521] 'process raft request' (duration: 62.030301ms)","trace[1000025521] 'compare' (duration: 81.567223ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:44:21.100148Z","caller":"traceutil/trace.go:171","msg":"trace[1098922840] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"118.682671ms","start":"2026-04-14T10:44:20.981446Z","end":"2026-04-14T10:44:21.100128Z","steps":["trace[1098922840] 'process raft request' (duration: 118.56546ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:23.50253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.808357ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"warn","ts":"2026-04-14T10:44:24.146088Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12602370880151824680,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T10:44:24.646421Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12602370880151824680,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T10:44:24.781945Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.198617255s","expected-duration":"1s"} {"level":"info","ts":"2026-04-14T10:44:24.782416Z","caller":"traceutil/trace.go:171","msg":"trace[751244656] linearizableReadLoop","detail":"{readStateIndex:493; appliedIndex:492; }","duration":"1.137094069s","start":"2026-04-14T10:44:23.645296Z","end":"2026-04-14T10:44:24.78239Z","steps":["trace[751244656] 'read index received' (duration: 1.136824997s)","trace[751244656] 'applied index is now lower than readState.Index' (duration: 267.902µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:44:24.782519Z","caller":"traceutil/trace.go:171","msg":"trace[287153268] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"1.199247641s","start":"2026-04-14T10:44:23.583241Z","end":"2026-04-14T10:44:24.782489Z","steps":["trace[287153268] 'process raft request' (duration: 1.198997079s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:24.78261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.137284371s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12669"} {"level":"warn","ts":"2026-04-14T10:44:24.782636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.065918384s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-14T10:44:24.782671Z","caller":"traceutil/trace.go:171","msg":"trace[769736579] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:476; }","duration":"1.137420462s","start":"2026-04-14T10:44:23.645236Z","end":"2026-04-14T10:44:24.782656Z","steps":["trace[769736579] 'agreement among raft nodes before linearized reading' (duration: 1.13725136s)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:24.782676Z","caller":"traceutil/trace.go:171","msg":"trace[1720208671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:476; }","duration":"1.066005356s","start":"2026-04-14T10:44:23.716658Z","end":"2026-04-14T10:44:24.782663Z","steps":["trace[1720208671] 'agreement among raft nodes before linearized reading' (duration: 1.065904045s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:24.782713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:23.645215Z","time spent":"1.137488633s","remote":"127.0.0.1:54026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":3,"response size":12693,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"warn","ts":"2026-04-14T10:44:24.782743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:23.716636Z","time spent":"1.066095796s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T10:44:24.782794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"839.177179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-14T10:44:24.782814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.003192468s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-14T10:44:24.782838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.348916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T10:44:24.782667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:23.583225Z","time spent":"1.199360322s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:44:24.782908Z","caller":"traceutil/trace.go:171","msg":"trace[1473322333] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:476; }","duration":"1.003336139s","start":"2026-04-14T10:44:23.77955Z","end":"2026-04-14T10:44:24.782886Z","steps":["trace[1473322333] 'agreement among raft nodes before linearized reading' (duration: 1.003158167s)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:24.782848Z","caller":"traceutil/trace.go:171","msg":"trace[17716676] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:476; }","duration":"839.27157ms","start":"2026-04-14T10:44:23.943562Z","end":"2026-04-14T10:44:24.782834Z","steps":["trace[17716676] 'agreement among raft nodes before linearized reading' (duration: 839.135099ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:24.782958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:23.779508Z","time spent":"1.003440849s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-14T10:44:24.782962Z","caller":"traceutil/trace.go:171","msg":"trace[505997028] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:476; }","duration":"473.609009ms","start":"2026-04-14T10:44:24.309297Z","end":"2026-04-14T10:44:24.782906Z","steps":["trace[505997028] 'agreement among raft nodes before linearized reading' (duration: 473.327446ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:24.782983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:23.94354Z","time spent":"839.434732ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-14T10:44:24.783003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:24.309275Z","time spent":"473.71798ms","remote":"127.0.0.1:53914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-14T10:44:24.991444Z","caller":"traceutil/trace.go:171","msg":"trace[980485353] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"204.375512ms","start":"2026-04-14T10:44:24.787045Z","end":"2026-04-14T10:44:24.99142Z","steps":["trace[980485353] 'process raft request' (duration: 204.2311ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:24.993059Z","caller":"traceutil/trace.go:171","msg":"trace[2020646848] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"205.717135ms","start":"2026-04-14T10:44:24.787323Z","end":"2026-04-14T10:44:24.99304Z","steps":["trace[2020646848] 'process raft request' (duration: 205.588243ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:24.993119Z","caller":"traceutil/trace.go:171","msg":"trace[501340119] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"205.780695ms","start":"2026-04-14T10:44:24.787307Z","end":"2026-04-14T10:44:24.993088Z","steps":["trace[501340119] 'process raft request' (duration: 205.679904ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:25.885499Z","caller":"traceutil/trace.go:171","msg":"trace[325750052] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"131.464419ms","start":"2026-04-14T10:44:25.754014Z","end":"2026-04-14T10:44:25.885478Z","steps":["trace[325750052] 'process raft request' (duration: 131.202665ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:26.413061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.126308ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:44:26.413492Z","caller":"traceutil/trace.go:171","msg":"trace[19521452] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"499.736004ms","start":"2026-04-14T10:44:25.913732Z","end":"2026-04-14T10:44:26.413468Z","steps":["trace[19521452] 'process raft request' (duration: 499.478996ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:26.413524Z","caller":"traceutil/trace.go:171","msg":"trace[733377012] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"499.903928ms","start":"2026-04-14T10:44:25.913581Z","end":"2026-04-14T10:44:26.413485Z","steps":["trace[733377012] 'process raft request' (duration: 136.248203ms)","trace[733377012] 'compare' (duration: 362.894303ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:44:26.413646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:25.913711Z","time spent":"499.842009ms","remote":"127.0.0.1:54138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":505,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T10:44:26.413683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:25.913556Z","time spent":"500.040915ms","remote":"127.0.0.1:54138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T10:44:26.413738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.369938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:44:26.41386Z","caller":"traceutil/trace.go:171","msg":"trace[626039148] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:482; }","duration":"105.514677ms","start":"2026-04-14T10:44:26.308302Z","end":"2026-04-14T10:44:26.413817Z","steps":["trace[626039148] 'agreement among raft nodes before linearized reading' (duration: 105.311283ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:26.413809Z","caller":"traceutil/trace.go:171","msg":"trace[1556631572] linearizableReadLoop","detail":"{readStateIndex:499; appliedIndex:497; }","duration":"104.989891ms","start":"2026-04-14T10:44:26.308343Z","end":"2026-04-14T10:44:26.413333Z","steps":["trace[1556631572] 'read index received' (duration: 44.003µs)","trace[1556631572] 'applied index is now lower than readState.Index' (duration: 104.940488ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:44:26.914532Z","caller":"traceutil/trace.go:171","msg":"trace[2008171061] linearizableReadLoop","detail":"{readStateIndex:500; appliedIndex:499; }","duration":"126.647512ms","start":"2026-04-14T10:44:26.787854Z","end":"2026-04-14T10:44:26.914502Z","steps":["trace[2008171061] 'read index received' (duration: 110.318548ms)","trace[2008171061] 'applied index is now lower than readState.Index' (duration: 16.327444ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:44:26.91473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.864866ms","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-04-14T10:44:26.914887Z","caller":"traceutil/trace.go:171","msg":"trace[1452906737] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"492.3319ms","start":"2026-04-14T10:44:26.422473Z","end":"2026-04-14T10:44:26.914805Z","steps":["trace[1452906737] 'process raft request' (duration: 475.791102ms)","trace[1452906737] 'compare' (duration: 15.615336ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:44:26.914789Z","caller":"traceutil/trace.go:171","msg":"trace[1515843147] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:483; }","duration":"126.988876ms","start":"2026-04-14T10:44:26.787788Z","end":"2026-04-14T10:44:26.914777Z","steps":["trace[1515843147] 'agreement among raft nodes before linearized reading' (duration: 126.817194ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:26.915082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:26.422455Z","time spent":"492.527364ms","remote":"127.0.0.1:54028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6516,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T10:44:29.575462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.154271ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:44:29.575789Z","caller":"traceutil/trace.go:171","msg":"trace[640793594] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"685.436568ms","start":"2026-04-14T10:44:28.890311Z","end":"2026-04-14T10:44:29.575747Z","steps":["trace[640793594] 'process raft request' (duration: 333.904812ms)","trace[640793594] 'compare' (duration: 351.001432ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:44:29.575898Z","caller":"traceutil/trace.go:171","msg":"trace[1654156528] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"640.182875ms","start":"2026-04-14T10:44:28.93566Z","end":"2026-04-14T10:44:29.575843Z","steps":["trace[1654156528] 'process raft request' (duration: 640.014884ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:29.575986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:28.890303Z","time spent":"685.599658ms","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T10:44:29.576095Z","caller":"traceutil/trace.go:171","msg":"trace[916564183] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"641.471309ms","start":"2026-04-14T10:44:28.934572Z","end":"2026-04-14T10:44:29.576043Z","steps":["trace[916564183] 'process raft request' (duration: 641.01887ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:29.576241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.814392ms","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-04-14T10:44:29.576184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:28.935651Z","time spent":"640.42208ms","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T10:44:29.576285Z","caller":"traceutil/trace.go:171","msg":"trace[583578160] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:529; }","duration":"636.900208ms","start":"2026-04-14T10:44:28.939375Z","end":"2026-04-14T10:44:29.576275Z","steps":["trace[583578160] 'agreement among raft nodes before linearized reading' (duration: 636.792461ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:29.576325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:28.939361Z","time spent":"636.954752ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-14T10:44:29.576258Z","caller":"traceutil/trace.go:171","msg":"trace[1083440137] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"634.217581ms","start":"2026-04-14T10:44:28.942022Z","end":"2026-04-14T10:44:29.57624Z","steps":["trace[1083440137] 'process raft request' (duration: 633.795164ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:29.576375Z","caller":"traceutil/trace.go:171","msg":"trace[1082497038] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"638.851187ms","start":"2026-04-14T10:44:28.93751Z","end":"2026-04-14T10:44:29.576361Z","steps":["trace[1082497038] 'process raft request' (duration: 638.213015ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:29.576435Z","caller":"traceutil/trace.go:171","msg":"trace[1298418932] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"632.894234ms","start":"2026-04-14T10:44:28.943532Z","end":"2026-04-14T10:44:29.576426Z","steps":["trace[1298418932] 'process raft request' (duration: 632.348799ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:29.576452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:28.937502Z","time spent":"638.926411ms","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T10:44:29.576488Z","caller":"traceutil/trace.go:171","msg":"trace[496085195] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"614.220333ms","start":"2026-04-14T10:44:28.962251Z","end":"2026-04-14T10:44:29.576472Z","steps":["trace[496085195] 'process raft request' (duration: 613.812537ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:29.576526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:28.942013Z","time spent":"634.405814ms","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T10:44:29.576342Z","caller":"traceutil/trace.go:171","msg":"trace[1177490559] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"621.784952ms","start":"2026-04-14T10:44:28.954502Z","end":"2026-04-14T10:44:29.576287Z","steps":["trace[1177490559] 'process raft request' (duration: 621.420518ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:29.576643Z","caller":"traceutil/trace.go:171","msg":"trace[713108404] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"634.731125ms","start":"2026-04-14T10:44:28.9419Z","end":"2026-04-14T10:44:29.576631Z","steps":["trace[713108404] 'process raft request' (duration: 633.859778ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:29.576312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:28.934558Z","time spent":"641.658662ms","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T10:44:29.576708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:28.941886Z","time spent":"634.794659ms","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T10:44:29.576582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:28.962244Z","time spent":"614.295909ms","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T10:44:29.576656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:28.954492Z","time spent":"622.147355ms","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T10:44:29.576589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:28.943507Z","time spent":"632.98082ms","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T10:44:29.576133Z","caller":"traceutil/trace.go:171","msg":"trace[29298943] linearizableReadLoop","detail":"{readStateIndex:542; appliedIndex:538; }","duration":"636.693245ms","start":"2026-04-14T10:44:28.939417Z","end":"2026-04-14T10:44:29.57611Z","steps":["trace[29298943] 'read index received' (duration: 26.755133ms)","trace[29298943] 'applied index is now lower than readState.Index' (duration: 609.936972ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:44:30.13908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.945671ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:44:30.139365Z","caller":"traceutil/trace.go:171","msg":"trace[1638041185] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"1.167691863s","start":"2026-04-14T10:44:28.971635Z","end":"2026-04-14T10:44:30.139327Z","steps":["trace[1638041185] 'process raft request' (duration: 1.02640033s)","trace[1638041185] 'compare' (duration: 140.734728ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:44:30.139537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:28.971604Z","time spent":"1.167850454s","remote":"127.0.0.1:54434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T10:44:30.139577Z","caller":"traceutil/trace.go:171","msg":"trace[1306486308] transaction","detail":"{read_only:false; number_of_response:1; response_revision:531; }","duration":"1.162445707s","start":"2026-04-14T10:44:28.977091Z","end":"2026-04-14T10:44:30.139537Z","steps":["trace[1306486308] 'process raft request' (duration: 1.162192711s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:30.14088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:28.977071Z","time spent":"1.163678196s","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7367,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:44:30.139645Z","caller":"traceutil/trace.go:171","msg":"trace[506940798] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"1.147358062s","start":"2026-04-14T10:44:28.992266Z","end":"2026-04-14T10:44:30.139624Z","steps":["trace[506940798] 'process raft request' (duration: 1.14717054s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:30.141715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:28.992249Z","time spent":"1.149301837s","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T10:44:30.142152Z","caller":"traceutil/trace.go:171","msg":"trace[1348459761] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"1.165101228s","start":"2026-04-14T10:44:28.977032Z","end":"2026-04-14T10:44:30.142134Z","steps":["trace[1348459761] 'process raft request' (duration: 1.16217422s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:30.142304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:28.977018Z","time spent":"1.165208735s","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:44:30.144643Z","caller":"traceutil/trace.go:171","msg":"trace[775914059] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"560.211122ms","start":"2026-04-14T10:44:29.584401Z","end":"2026-04-14T10:44:30.144612Z","steps":["trace[775914059] 'process raft request' (duration: 559.235689ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:30.144645Z","caller":"traceutil/trace.go:171","msg":"trace[267378489] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"551.006683ms","start":"2026-04-14T10:44:29.593609Z","end":"2026-04-14T10:44:30.144616Z","steps":["trace[267378489] 'process raft request' (duration: 550.179029ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:30.144983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:29.593582Z","time spent":"551.325093ms","remote":"127.0.0.1:54434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T10:44:30.145394Z","caller":"traceutil/trace.go:171","msg":"trace[974333630] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"1.058478691s","start":"2026-04-14T10:44:29.086264Z","end":"2026-04-14T10:44:30.144743Z","steps":["trace[974333630] 'process raft request' (duration: 1.054023264s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:30.14571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:29.086246Z","time spent":"1.0592478s","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T10:44:30.146486Z","caller":"traceutil/trace.go:171","msg":"trace[2105539072] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"560.152748ms","start":"2026-04-14T10:44:29.584568Z","end":"2026-04-14T10:44:30.144721Z","steps":["trace[2105539072] 'process raft request' (duration: 559.166945ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:30.146587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:29.584558Z","time spent":"561.994347ms","remote":"127.0.0.1:54434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T10:44:30.146641Z","caller":"traceutil/trace.go:171","msg":"trace[771642653] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"548.306877ms","start":"2026-04-14T10:44:29.5964Z","end":"2026-04-14T10:44:30.144707Z","steps":["trace[771642653] 'process raft request' (duration: 547.57845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:30.146699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:29.596383Z","time spent":"550.289205ms","remote":"127.0.0.1:54434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T10:44:30.146748Z","caller":"traceutil/trace.go:171","msg":"trace[934594579] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"549.080358ms","start":"2026-04-14T10:44:29.595647Z","end":"2026-04-14T10:44:30.144728Z","steps":["trace[934594579] 'process raft request' (duration: 548.194501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:30.146858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:29.595636Z","time spent":"551.164931ms","remote":"127.0.0.1:54434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T10:44:30.147107Z","caller":"traceutil/trace.go:171","msg":"trace[1417755184] linearizableReadLoop","detail":"{readStateIndex:552; appliedIndex:547; }","duration":"570.075483ms","start":"2026-04-14T10:44:29.576906Z","end":"2026-04-14T10:44:30.146981Z","steps":["trace[1417755184] 'read index received' (duration: 421.17092ms)","trace[1417755184] 'applied index is now lower than readState.Index' (duration: 146.672659ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:44:30.14748Z","caller":"traceutil/trace.go:171","msg":"trace[99523533] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"551.187092ms","start":"2026-04-14T10:44:29.595987Z","end":"2026-04-14T10:44:30.147174Z","steps":["trace[99523533] 'process raft request' (duration: 547.903161ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:30.147729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:29.595969Z","time spent":"551.694445ms","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:44:30.14798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:29.584378Z","time spent":"560.348971ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:44:30.150798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.010078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:44:30.150833Z","caller":"traceutil/trace.go:171","msg":"trace[1763376637] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:539; }","duration":"843.087644ms","start":"2026-04-14T10:44:29.307735Z","end":"2026-04-14T10:44:30.150823Z","steps":["trace[1763376637] 'agreement among raft nodes before linearized reading' (duration: 837.024204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:30.150864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:29.307714Z","time spent":"843.145377ms","remote":"127.0.0.1:53914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-14T10:44:30.151255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.074599915s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-14T10:44:30.151277Z","caller":"traceutil/trace.go:171","msg":"trace[430420786] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:539; }","duration":"1.074630686s","start":"2026-04-14T10:44:29.076641Z","end":"2026-04-14T10:44:30.151272Z","steps":["trace[430420786] 'agreement among raft nodes before linearized reading' (duration: 1.068124118s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:30.151291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:29.076638Z","time spent":"1.074649698s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-14T10:44:30.151463Z","caller":"traceutil/trace.go:171","msg":"trace[550864857] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"548.44326ms","start":"2026-04-14T10:44:29.603013Z","end":"2026-04-14T10:44:30.151456Z","steps":["trace[550864857] 'process raft request' (duration: 541.034554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:30.151514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:29.602993Z","time spent":"548.485743ms","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:44:30.151676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.074920316s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-14T10:44:30.151693Z","caller":"traceutil/trace.go:171","msg":"trace[185021308] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:540; }","duration":"1.074956858s","start":"2026-04-14T10:44:29.076732Z","end":"2026-04-14T10:44:30.151689Z","steps":["trace[185021308] 'agreement among raft nodes before linearized reading' (duration: 1.068030083s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:30.151706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:29.076728Z","time spent":"1.074974849s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-14T10:44:30.15178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.07515051s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-14T10:44:30.151797Z","caller":"traceutil/trace.go:171","msg":"trace[731831975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:540; }","duration":"1.075190073s","start":"2026-04-14T10:44:29.076603Z","end":"2026-04-14T10:44:30.151793Z","steps":["trace[731831975] 'agreement among raft nodes before linearized reading' (duration: 1.06815293s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:30.151808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:29.076593Z","time spent":"1.075212275s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-14T10:44:30.151961Z","caller":"traceutil/trace.go:171","msg":"trace[330592258] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"545.543622ms","start":"2026-04-14T10:44:29.606413Z","end":"2026-04-14T10:44:30.151956Z","steps":["trace[330592258] 'process raft request' (duration: 545.499849ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:30.151994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:29.6064Z","time spent":"545.576803ms","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:44:30.152072Z","caller":"traceutil/trace.go:171","msg":"trace[1535965954] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"548.951773ms","start":"2026-04-14T10:44:29.603115Z","end":"2026-04-14T10:44:30.152067Z","steps":["trace[1535965954] 'process raft request' (duration: 548.300611ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:30.152101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:29.603107Z","time spent":"548.978525ms","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:44:30.781676Z","caller":"traceutil/trace.go:171","msg":"trace[403331449] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"298.07609ms","start":"2026-04-14T10:44:30.483567Z","end":"2026-04-14T10:44:30.781643Z","steps":["trace[403331449] 'process raft request' (duration: 232.558547ms)","trace[403331449] 'compare' (duration: 65.30823ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:44:30.783241Z","caller":"traceutil/trace.go:171","msg":"trace[2106050549] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"279.456883ms","start":"2026-04-14T10:44:30.503762Z","end":"2026-04-14T10:44:30.783219Z","steps":["trace[2106050549] 'process raft request' (duration: 279.379298ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:30.783293Z","caller":"traceutil/trace.go:171","msg":"trace[1466638251] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"296.9745ms","start":"2026-04-14T10:44:30.486297Z","end":"2026-04-14T10:44:30.783271Z","steps":["trace[1466638251] 'process raft request' (duration: 296.729624ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:31.396855Z","caller":"traceutil/trace.go:171","msg":"trace[1006263831] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"391.207777ms","start":"2026-04-14T10:44:31.005622Z","end":"2026-04-14T10:44:31.39683Z","steps":["trace[1006263831] 'process raft request' (duration: 389.20853ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:31.397081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:31.005594Z","time spent":"391.40388ms","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18032,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:44:31.407309Z","caller":"traceutil/trace.go:171","msg":"trace[596989163] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:601; }","duration":"100.319454ms","start":"2026-04-14T10:44:31.30697Z","end":"2026-04-14T10:44:31.40729Z","steps":["trace[596989163] 'read index received' (duration: 87.83013ms)","trace[596989163] 'applied index is now lower than readState.Index' (duration: 12.488644ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:44:31.40743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.440451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:44:31.407454Z","caller":"traceutil/trace.go:171","msg":"trace[1747305766] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:582; }","duration":"100.515137ms","start":"2026-04-14T10:44:31.30693Z","end":"2026-04-14T10:44:31.407445Z","steps":["trace[1747305766] 'agreement among raft nodes before linearized reading' (duration: 100.446972ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:31.408127Z","caller":"traceutil/trace.go:171","msg":"trace[38963379] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"353.281096ms","start":"2026-04-14T10:44:31.054838Z","end":"2026-04-14T10:44:31.408119Z","steps":["trace[38963379] 'process raft request' (duration: 351.634592ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:31.408196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:31.05482Z","time spent":"353.327579ms","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:44:31.408351Z","caller":"traceutil/trace.go:171","msg":"trace[107868875] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"166.775387ms","start":"2026-04-14T10:44:31.24155Z","end":"2026-04-14T10:44:31.408326Z","steps":["trace[107868875] 'process raft request' (duration: 165.359787ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:32.615821Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.12118123s","expected-duration":"1s"} {"level":"info","ts":"2026-04-14T10:44:32.629934Z","caller":"traceutil/trace.go:171","msg":"trace[1014684585] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"1.135427374s","start":"2026-04-14T10:44:31.494482Z","end":"2026-04-14T10:44:32.62991Z","steps":["trace[1014684585] 'process raft request' (duration: 1.121563604s)","trace[1014684585] 'compare' (duration: 13.69825ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:44:32.630294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:31.494465Z","time spent":"1.13553277s","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":74745,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:44:32.633465Z","caller":"traceutil/trace.go:171","msg":"trace[828141020] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:608; }","duration":"479.268095ms","start":"2026-04-14T10:44:32.154124Z","end":"2026-04-14T10:44:32.633392Z","steps":["trace[828141020] 'read index received' (duration: 461.933316ms)","trace[828141020] 'applied index is now lower than readState.Index' (duration: 17.332979ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:44:32.633923Z","caller":"traceutil/trace.go:171","msg":"trace[5470882] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"1.135274761s","start":"2026-04-14T10:44:31.49862Z","end":"2026-04-14T10:44:32.633895Z","steps":["trace[5470882] 'process raft request' (duration: 1.134439879s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:32.634022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.888404ms","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-04-14T10:44:32.634069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.3763ms","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-04-14T10:44:32.63411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:31.498597Z","time spent":"1.13540559s","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T10:44:32.634145Z","caller":"traceutil/trace.go:171","msg":"trace[104378086] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:588; }","duration":"432.504748ms","start":"2026-04-14T10:44:32.201616Z","end":"2026-04-14T10:44:32.63412Z","steps":["trace[104378086] 'agreement among raft nodes before linearized reading' (duration: 432.291775ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:32.634148Z","caller":"traceutil/trace.go:171","msg":"trace[248471431] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:588; }","duration":"480.050034ms","start":"2026-04-14T10:44:32.154064Z","end":"2026-04-14T10:44:32.634114Z","steps":["trace[248471431] 'agreement among raft nodes before linearized reading' (duration: 479.816359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:32.634147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.905237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-14T10:44:32.634182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:32.201599Z","time spent":"432.575913ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-14T10:44:32.634029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.938697ms","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-04-14T10:44:32.634224Z","caller":"traceutil/trace.go:171","msg":"trace[56047907] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:588; }","duration":"434.020503ms","start":"2026-04-14T10:44:32.20018Z","end":"2026-04-14T10:44:32.634201Z","steps":["trace[56047907] 'agreement among raft nodes before linearized reading' (duration: 433.717034ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:32.634288Z","caller":"traceutil/trace.go:171","msg":"trace[2131423702] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"1.108601607s","start":"2026-04-14T10:44:31.525667Z","end":"2026-04-14T10:44:32.634269Z","steps":["trace[2131423702] 'process raft request' (duration: 1.107581123s)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:32.63429Z","caller":"traceutil/trace.go:171","msg":"trace[636176122] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:588; }","duration":"430.221636ms","start":"2026-04-14T10:44:32.204046Z","end":"2026-04-14T10:44:32.634267Z","steps":["trace[636176122] 'agreement among raft nodes before linearized reading' (duration: 429.855513ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:32.634372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:32.204035Z","time spent":"430.316762ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T10:44:32.634425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:31.525645Z","time spent":"1.108699832s","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98698,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:44:32.634216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:32.154028Z","time spent":"480.169741ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-14T10:44:32.634291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:32.200161Z","time spent":"434.11452ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-14T10:44:32.634988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.90539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:44:32.635206Z","caller":"traceutil/trace.go:171","msg":"trace[1593808117] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:588; }","duration":"327.015637ms","start":"2026-04-14T10:44:32.308027Z","end":"2026-04-14T10:44:32.635042Z","steps":["trace[1593808117] 'agreement among raft nodes before linearized reading' (duration: 326.321754ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:32.635364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:32.308006Z","time spent":"327.252742ms","remote":"127.0.0.1:53914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-14T10:44:35.251496Z","caller":"traceutil/trace.go:171","msg":"trace[811223378] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"168.774039ms","start":"2026-04-14T10:44:35.082683Z","end":"2026-04-14T10:44:35.251457Z","steps":["trace[811223378] 'read index received' (duration: 167.778889ms)","trace[811223378] 'applied index is now lower than readState.Index' (duration: 994.19µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:44:35.251515Z","caller":"traceutil/trace.go:171","msg":"trace[599541375] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"215.954406ms","start":"2026-04-14T10:44:35.035538Z","end":"2026-04-14T10:44:35.251493Z","steps":["trace[599541375] 'process raft request' (duration: 215.258594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:35.252971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.2609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:44:35.253036Z","caller":"traceutil/trace.go:171","msg":"trace[1664583233] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:611; }","duration":"170.366886ms","start":"2026-04-14T10:44:35.082658Z","end":"2026-04-14T10:44:35.253025Z","steps":["trace[1664583233] 'agreement among raft nodes before linearized reading' (duration: 168.93653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:35.253061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.443869ms","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":"warn","ts":"2026-04-14T10:44:35.253182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.332418ms","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:5"} {"level":"info","ts":"2026-04-14T10:44:35.253265Z","caller":"traceutil/trace.go:171","msg":"trace[595406986] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:611; }","duration":"106.414293ms","start":"2026-04-14T10:44:35.146806Z","end":"2026-04-14T10:44:35.25322Z","steps":["trace[595406986] 'agreement among raft nodes before linearized reading' (duration: 106.094954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:35.253371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.236213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:44:35.253413Z","caller":"traceutil/trace.go:171","msg":"trace[1116978697] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:611; }","duration":"124.299297ms","start":"2026-04-14T10:44:35.129096Z","end":"2026-04-14T10:44:35.253395Z","steps":["trace[1116978697] 'agreement among raft nodes before linearized reading' (duration: 124.227882ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:35.253479Z","caller":"traceutil/trace.go:171","msg":"trace[850417214] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:611; }","duration":"148.8102ms","start":"2026-04-14T10:44:35.104563Z","end":"2026-04-14T10:44:35.253373Z","steps":["trace[850417214] 'agreement among raft nodes before linearized reading' (duration: 148.365093ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:35.253459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.227792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:44:35.253632Z","caller":"traceutil/trace.go:171","msg":"trace[650199627] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:611; }","duration":"124.410973ms","start":"2026-04-14T10:44:35.129162Z","end":"2026-04-14T10:44:35.253573Z","steps":["trace[650199627] 'agreement among raft nodes before linearized reading' (duration: 124.054182ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:35.253775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.324708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:44:35.253818Z","caller":"traceutil/trace.go:171","msg":"trace[1205099868] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:611; }","duration":"124.36678ms","start":"2026-04-14T10:44:35.129431Z","end":"2026-04-14T10:44:35.253798Z","steps":["trace[1205099868] 'agreement among raft nodes before linearized reading' (duration: 124.316307ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:35.254555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.5108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:44:35.254602Z","caller":"traceutil/trace.go:171","msg":"trace[78046348] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:611; }","duration":"107.602155ms","start":"2026-04-14T10:44:35.146987Z","end":"2026-04-14T10:44:35.254589Z","steps":["trace[78046348] 'agreement among raft nodes before linearized reading' (duration: 107.52799ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:35.254783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.10954ms","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":"info","ts":"2026-04-14T10:44:35.255936Z","caller":"traceutil/trace.go:171","msg":"trace[1727241334] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:611; }","duration":"152.27304ms","start":"2026-04-14T10:44:35.103644Z","end":"2026-04-14T10:44:35.255917Z","steps":["trace[1727241334] 'agreement among raft nodes before linearized reading' (duration: 151.073748ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:35.254867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.44855ms","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-04-14T10:44:35.256159Z","caller":"traceutil/trace.go:171","msg":"trace[922695958] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:611; }","duration":"151.765799ms","start":"2026-04-14T10:44:35.10438Z","end":"2026-04-14T10:44:35.256146Z","steps":["trace[922695958] 'agreement among raft nodes before linearized reading' (duration: 150.441299ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:35.254941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.065369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:44:35.256383Z","caller":"traceutil/trace.go:171","msg":"trace[1717755036] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:611; }","duration":"173.502476ms","start":"2026-04-14T10:44:35.082859Z","end":"2026-04-14T10:44:35.256361Z","steps":["trace[1717755036] 'agreement among raft nodes before linearized reading' (duration: 172.041328ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:35.25502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.282032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:44:35.256651Z","caller":"traceutil/trace.go:171","msg":"trace[2112356980] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:611; }","duration":"173.919441ms","start":"2026-04-14T10:44:35.082718Z","end":"2026-04-14T10:44:35.256637Z","steps":["trace[2112356980] 'agreement among raft nodes before linearized reading' (duration: 168.927679ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:40.18472Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.177127201s","expected-duration":"1s"} {"level":"info","ts":"2026-04-14T10:44:40.185205Z","caller":"traceutil/trace.go:171","msg":"trace[1308248708] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"1.177678343s","start":"2026-04-14T10:44:39.007501Z","end":"2026-04-14T10:44:40.185179Z","steps":["trace[1308248708] 'process raft request' (duration: 1.177472461s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:40.185349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:39.007477Z","time spent":"1.177780229s","remote":"127.0.0.1:54170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T10:44:41.648577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"875.147641ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:44:41.648771Z","caller":"traceutil/trace.go:171","msg":"trace[1798327681] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"1.445059786s","start":"2026-04-14T10:44:40.203663Z","end":"2026-04-14T10:44:41.648723Z","steps":["trace[1798327681] 'process raft request' (duration: 569.664572ms)","trace[1798327681] 'compare' (duration: 874.232629ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:44:41.64889Z","caller":"traceutil/trace.go:171","msg":"trace[1882338044] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:664; }","duration":"1.329185903s","start":"2026-04-14T10:44:40.31968Z","end":"2026-04-14T10:44:41.648866Z","steps":["trace[1882338044] 'read index received' (duration: 453.652091ms)","trace[1882338044] 'applied index is now lower than readState.Index' (duration: 875.531342ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:44:41.648933Z","caller":"traceutil/trace.go:171","msg":"trace[253864260] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"207.96148ms","start":"2026-04-14T10:44:41.440942Z","end":"2026-04-14T10:44:41.648904Z","steps":["trace[253864260] 'process raft request' (duration: 207.790141ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:41.648961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:40.203651Z","time spent":"1.445225165s","remote":"127.0.0.1:54120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T10:44:41.649087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.329395074s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:44:41.649133Z","caller":"traceutil/trace.go:171","msg":"trace[1999660234] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"1.329454268s","start":"2026-04-14T10:44:40.319668Z","end":"2026-04-14T10:44:41.649122Z","steps":["trace[1999660234] 'agreement among raft nodes before linearized reading' (duration: 1.329358942s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:41.649166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:40.319617Z","time spent":"1.329542113s","remote":"127.0.0.1:53914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-14T10:44:41.649231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.098274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-14T10:44:41.649281Z","caller":"traceutil/trace.go:171","msg":"trace[1292993837] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:641; }","duration":"965.20586ms","start":"2026-04-14T10:44:40.684063Z","end":"2026-04-14T10:44:41.649269Z","steps":["trace[1292993837] 'agreement among raft nodes before linearized reading' (duration: 965.038601ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:41.649315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:40.68404Z","time spent":"965.265783ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T10:44:41.649326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"970.089699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-14T10:44:41.649415Z","caller":"traceutil/trace.go:171","msg":"trace[997585500] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:641; }","duration":"970.236927ms","start":"2026-04-14T10:44:40.679155Z","end":"2026-04-14T10:44:41.649392Z","steps":["trace[997585500] 'agreement among raft nodes before linearized reading' (duration: 969.93349ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:41.649468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:40.679135Z","time spent":"970.324372ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-14T10:44:41.649487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.822615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-14T10:44:41.649526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.012839ms","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-04-14T10:44:41.649788Z","caller":"traceutil/trace.go:171","msg":"trace[1257407450] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:641; }","duration":"965.264382ms","start":"2026-04-14T10:44:40.684489Z","end":"2026-04-14T10:44:41.649753Z","steps":["trace[1257407450] 'agreement among raft nodes before linearized reading' (duration: 964.87184ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:41.649848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:40.684481Z","time spent":"965.352138ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-14T10:44:41.650205Z","caller":"traceutil/trace.go:171","msg":"trace[1996339581] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:641; }","duration":"965.999314ms","start":"2026-04-14T10:44:40.683597Z","end":"2026-04-14T10:44:41.649596Z","steps":["trace[1996339581] 'agreement among raft nodes before linearized reading' (duration: 965.729639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:41.650257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:40.683568Z","time spent":"966.675103ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-14T10:44:43.038565Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.352685698s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-14T10:44:43.149965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.111384ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:44:43.150169Z","caller":"traceutil/trace.go:171","msg":"trace[1353984159] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"1.495369481s","start":"2026-04-14T10:44:41.654779Z","end":"2026-04-14T10:44:43.150149Z","steps":["trace[1353984159] 'process raft request' (duration: 1.384015044s)","trace[1353984159] 'compare' (duration: 110.67349ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:44:43.150284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:41.65476Z","time spent":"1.495458906s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:44:43.150328Z","caller":"traceutil/trace.go:171","msg":"trace[1198479297] linearizableReadLoop","detail":"{readStateIndex:673; appliedIndex:666; }","duration":"1.490358118s","start":"2026-04-14T10:44:41.659953Z","end":"2026-04-14T10:44:43.150311Z","steps":["trace[1198479297] 'read index received' (duration: 25.858958ms)","trace[1198479297] 'applied index is now lower than readState.Index' (duration: 1.46449828s)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:44:43.150406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.490452764s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:44:43.150433Z","caller":"traceutil/trace.go:171","msg":"trace[1688026944] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:649; }","duration":"1.490504056s","start":"2026-04-14T10:44:41.65992Z","end":"2026-04-14T10:44:43.150424Z","steps":["trace[1688026944] 'agreement among raft nodes before linearized reading' (duration: 1.490442293s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:43.150462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:41.659912Z","time spent":"1.490542208s","remote":"127.0.0.1:53914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-14T10:44:43.15053Z","caller":"traceutil/trace.go:171","msg":"trace[41436338] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"1.49570234s","start":"2026-04-14T10:44:41.654823Z","end":"2026-04-14T10:44:43.150525Z","steps":["trace[41436338] 'process raft request' (duration: 1.495240684s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:43.150563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:41.654804Z","time spent":"1.495740962s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:44:43.150631Z","caller":"traceutil/trace.go:171","msg":"trace[1337086463] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"1.494802888s","start":"2026-04-14T10:44:41.655823Z","end":"2026-04-14T10:44:43.150626Z","steps":["trace[1337086463] 'process raft request' (duration: 1.494303601s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:43.150657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:41.655811Z","time spent":"1.49483006s","remote":"127.0.0.1:54000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T10:44:43.150715Z","caller":"traceutil/trace.go:171","msg":"trace[1763613963] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"1.492999807s","start":"2026-04-14T10:44:41.657704Z","end":"2026-04-14T10:44:43.150703Z","steps":["trace[1763613963] 'process raft request' (duration: 1.49252332s)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:43.150742Z","caller":"traceutil/trace.go:171","msg":"trace[356206044] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"1.494894334s","start":"2026-04-14T10:44:41.655842Z","end":"2026-04-14T10:44:43.150736Z","steps":["trace[356206044] 'process raft request' (duration: 1.494319602s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:43.15078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:41.655833Z","time spent":"1.494931326s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:44:43.150466Z","caller":"traceutil/trace.go:171","msg":"trace[765505725] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"1.493114893s","start":"2026-04-14T10:44:41.657344Z","end":"2026-04-14T10:44:43.150459Z","steps":["trace[765505725] 'process raft request' (duration: 1.492852669s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:43.150906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:41.657315Z","time spent":"1.493574639s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:44:43.150775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:41.657696Z","time spent":"1.49304669s","remote":"127.0.0.1:54120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:44:43.150936Z","caller":"traceutil/trace.go:171","msg":"trace[724449398] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"1.489195202s","start":"2026-04-14T10:44:41.661731Z","end":"2026-04-14T10:44:43.150927Z","steps":["trace[724449398] 'process raft request' (duration: 1.488542816s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:43.151005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:41.661722Z","time spent":"1.489256395s","remote":"127.0.0.1:54170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:44:45.189758Z","caller":"traceutil/trace.go:171","msg":"trace[1514657550] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"262.735229ms","start":"2026-04-14T10:44:44.926984Z","end":"2026-04-14T10:44:45.189719Z","steps":["trace[1514657550] 'process raft request' (duration: 262.55806ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:45.732031Z","caller":"traceutil/trace.go:171","msg":"trace[1099827916] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"536.565617ms","start":"2026-04-14T10:44:45.195439Z","end":"2026-04-14T10:44:45.732004Z","steps":["trace[1099827916] 'process raft request' (duration: 536.484773ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:45.73219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:45.195431Z","time spent":"536.679313ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:44:45.732263Z","caller":"traceutil/trace.go:171","msg":"trace[846846077] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"537.044473ms","start":"2026-04-14T10:44:45.195195Z","end":"2026-04-14T10:44:45.73224Z","steps":["trace[846846077] 'process raft request' (duration: 476.605288ms)","trace[846846077] 'compare' (duration: 59.78824ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:44:45.732383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:45.195188Z","time spent":"537.131407ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:44:45.732474Z","caller":"traceutil/trace.go:171","msg":"trace[1754317804] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"536.857733ms","start":"2026-04-14T10:44:45.195326Z","end":"2026-04-14T10:44:45.732183Z","steps":["trace[1754317804] 'process raft request' (duration: 536.507954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:45.732689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:45.195286Z","time spent":"537.287626ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:44:47.26686Z","caller":"traceutil/trace.go:171","msg":"trace[1953060150] linearizableReadLoop","detail":"{readStateIndex:683; appliedIndex:682; }","duration":"341.918208ms","start":"2026-04-14T10:44:46.92491Z","end":"2026-04-14T10:44:47.266828Z","steps":["trace[1953060150] 'read index received' (duration: 341.689496ms)","trace[1953060150] 'applied index is now lower than readState.Index' (duration: 226.602µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:44:47.266875Z","caller":"traceutil/trace.go:171","msg":"trace[1172837358] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"685.752514ms","start":"2026-04-14T10:44:46.581095Z","end":"2026-04-14T10:44:47.266848Z","steps":["trace[1172837358] 'process raft request' (duration: 685.539503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:47.267086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:46.581067Z","time spent":"685.952895ms","remote":"127.0.0.1:54000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":700,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T10:44:47.267207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.271046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-c5gkf\" ","response":"range_response_count:1 size:17243"} {"level":"info","ts":"2026-04-14T10:44:47.267266Z","caller":"traceutil/trace.go:171","msg":"trace[398858901] range","detail":"{range_begin:/registry/pods/kube-system/cilium-c5gkf; range_end:; response_count:1; response_revision:657; }","duration":"342.384712ms","start":"2026-04-14T10:44:46.924867Z","end":"2026-04-14T10:44:47.267251Z","steps":["trace[398858901] 'agreement among raft nodes before linearized reading' (duration: 342.089656ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:47.267303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:46.924845Z","time spent":"342.450655ms","remote":"127.0.0.1:54120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17267,"request content":"key:\"/registry/pods/kube-system/cilium-c5gkf\" "} {"level":"info","ts":"2026-04-14T10:44:51.517056Z","caller":"traceutil/trace.go:171","msg":"trace[1312726206] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"354.309118ms","start":"2026-04-14T10:44:51.162728Z","end":"2026-04-14T10:44:51.517037Z","steps":["trace[1312726206] 'process raft request' (duration: 354.142329ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:51.517183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:51.162703Z","time spent":"354.421993ms","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T10:44:51.522744Z","caller":"traceutil/trace.go:171","msg":"trace[1685258132] linearizableReadLoop","detail":"{readStateIndex:754; appliedIndex:752; }","duration":"214.660441ms","start":"2026-04-14T10:44:51.308065Z","end":"2026-04-14T10:44:51.522725Z","steps":["trace[1685258132] 'read index received' (duration: 208.942073ms)","trace[1685258132] 'applied index is now lower than readState.Index' (duration: 5.717668ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:44:51.522784Z","caller":"traceutil/trace.go:171","msg":"trace[1208508776] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"355.497248ms","start":"2026-04-14T10:44:51.167274Z","end":"2026-04-14T10:44:51.522771Z","steps":["trace[1208508776] 'process raft request' (duration: 355.269777ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:51.522857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.788738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T10:44:51.522865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:51.167249Z","time spent":"355.563601ms","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188480,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:44:51.522895Z","caller":"traceutil/trace.go:171","msg":"trace[1442870867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:727; }","duration":"214.892773ms","start":"2026-04-14T10:44:51.307994Z","end":"2026-04-14T10:44:51.522887Z","steps":["trace[1442870867] 'agreement among raft nodes before linearized reading' (duration: 214.82766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:51.523125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.089711ms","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-04-14T10:44:51.52317Z","caller":"traceutil/trace.go:171","msg":"trace[1908871998] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:727; }","duration":"211.165746ms","start":"2026-04-14T10:44:51.311994Z","end":"2026-04-14T10:44:51.52316Z","steps":["trace[1908871998] 'agreement among raft nodes before linearized reading' (duration: 211.011718ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:51.523284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.359637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-04-14T10:44:51.523355Z","caller":"traceutil/trace.go:171","msg":"trace[460503380] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:727; }","duration":"188.454992ms","start":"2026-04-14T10:44:51.33488Z","end":"2026-04-14T10:44:51.523335Z","steps":["trace[460503380] 'agreement among raft nodes before linearized reading' (duration: 188.180479ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:45:04.086766Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12602370880151825376,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T10:45:04.397904Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.360433525s","expected-duration":"1s"} {"level":"info","ts":"2026-04-14T10:45:04.398289Z","caller":"traceutil/trace.go:171","msg":"trace[22485443] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"1.360899666s","start":"2026-04-14T10:45:03.037373Z","end":"2026-04-14T10:45:04.398273Z","steps":["trace[22485443] 'process raft request' (duration: 1.360756299s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:45:04.398408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:45:03.037357Z","time spent":"1.36098978s","remote":"127.0.0.1:54120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:45:04.401112Z","caller":"traceutil/trace.go:171","msg":"trace[798858490] linearizableReadLoop","detail":"{readStateIndex:847; appliedIndex:845; }","duration":"815.179191ms","start":"2026-04-14T10:45:03.585909Z","end":"2026-04-14T10:45:04.401088Z","steps":["trace[798858490] 'read index received' (duration: 812.300465ms)","trace[798858490] 'applied index is now lower than readState.Index' (duration: 2.877256ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:45:04.401372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.448893ms","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-04-14T10:45:04.401405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.634195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-14T10:45:04.401462Z","caller":"traceutil/trace.go:171","msg":"trace[1150012848] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:815; }","duration":"780.714179ms","start":"2026-04-14T10:45:03.620735Z","end":"2026-04-14T10:45:04.401449Z","steps":["trace[1150012848] 'agreement among raft nodes before linearized reading' (duration: 780.550521ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:45:04.401466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.028245ms","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-04-14T10:45:04.401509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:45:03.620723Z","time spent":"780.774211ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-14T10:45:04.401562Z","caller":"traceutil/trace.go:171","msg":"trace[1782462937] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:815; }","duration":"585.182702ms","start":"2026-04-14T10:45:03.816346Z","end":"2026-04-14T10:45:04.401528Z","steps":["trace[1782462937] 'agreement among raft nodes before linearized reading' (duration: 584.966073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:45:04.401479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.168954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-14T10:45:04.401647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:45:03.816335Z","time spent":"585.274876ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-14T10:45:04.401651Z","caller":"traceutil/trace.go:171","msg":"trace[1693520546] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:815; }","duration":"588.388803ms","start":"2026-04-14T10:45:03.813233Z","end":"2026-04-14T10:45:04.401622Z","steps":["trace[1693520546] 'agreement among raft nodes before linearized reading' (duration: 588.141742ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:45:04.401723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:45:03.81322Z","time spent":"588.487478ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-14T10:45:04.40141Z","caller":"traceutil/trace.go:171","msg":"trace[223825099] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:815; }","duration":"815.551207ms","start":"2026-04-14T10:45:03.58585Z","end":"2026-04-14T10:45:04.401401Z","steps":["trace[223825099] 'agreement among raft nodes before linearized reading' (duration: 815.37479ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:45:04.402358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:45:03.585825Z","time spent":"816.51464ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-14T10:45:04.402017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.823241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-14T10:45:04.40325Z","caller":"traceutil/trace.go:171","msg":"trace[1042807656] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:815; }","duration":"592.099037ms","start":"2026-04-14T10:45:03.811123Z","end":"2026-04-14T10:45:04.403222Z","steps":["trace[1042807656] 'agreement among raft nodes before linearized reading' (duration: 590.816931ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:45:04.403331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:45:03.811105Z","time spent":"592.200012ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-14T10:45:13.321219Z","caller":"traceutil/trace.go:171","msg":"trace[1294666946] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"259.268005ms","start":"2026-04-14T10:45:13.061919Z","end":"2026-04-14T10:45:13.321187Z","steps":["trace[1294666946] 'process raft request' (duration: 259.088488ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:45:24.772142Z","caller":"traceutil/trace.go:171","msg":"trace[2117167262] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"110.533242ms","start":"2026-04-14T10:45:24.661585Z","end":"2026-04-14T10:45:24.772118Z","steps":["trace[2117167262] 'process raft request' (duration: 110.479321ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:45:24.772145Z","caller":"traceutil/trace.go:171","msg":"trace[1396332419] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"113.860771ms","start":"2026-04-14T10:45:24.658253Z","end":"2026-04-14T10:45:24.772113Z","steps":["trace[1396332419] 'process raft request' (duration: 52.440179ms)","trace[1396332419] 'compare' (duration: 61.232286ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:45:24.772331Z","caller":"traceutil/trace.go:171","msg":"trace[646267470] linearizableReadLoop","detail":"{readStateIndex:1045; appliedIndex:1044; }","duration":"113.749308ms","start":"2026-04-14T10:45:24.658571Z","end":"2026-04-14T10:45:24.77232Z","steps":["trace[646267470] 'read index received' (duration: 52.17086ms)","trace[646267470] 'applied index is now lower than readState.Index' (duration: 61.577278ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:45:24.772512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.171134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-14T10:45:24.772552Z","caller":"traceutil/trace.go:171","msg":"trace[1956444482] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1009; }","duration":"109.236536ms","start":"2026-04-14T10:45:24.663305Z","end":"2026-04-14T10:45:24.772541Z","steps":["trace[1956444482] 'agreement among raft nodes before linearized reading' (duration: 109.103041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:45:24.772527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.930324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-14T10:45:24.77297Z","caller":"traceutil/trace.go:171","msg":"trace[2098712987] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1009; }","duration":"114.39551ms","start":"2026-04-14T10:45:24.658554Z","end":"2026-04-14T10:45:24.77295Z","steps":["trace[2098712987] 'agreement among raft nodes before linearized reading' (duration: 113.82011ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:46:13.258159Z","caller":"traceutil/trace.go:171","msg":"trace[1124201326] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"135.002667ms","start":"2026-04-14T10:46:13.123126Z","end":"2026-04-14T10:46:13.258128Z","steps":["trace[1124201326] 'process raft request' (duration: 134.838743ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:46:35.327711Z","caller":"traceutil/trace.go:171","msg":"trace[1097271508] linearizableReadLoop","detail":"{readStateIndex:1295; appliedIndex:1294; }","duration":"112.304781ms","start":"2026-04-14T10:46:35.215384Z","end":"2026-04-14T10:46:35.327689Z","steps":["trace[1097271508] 'read index received' (duration: 112.164608ms)","trace[1097271508] 'applied index is now lower than readState.Index' (duration: 139.213µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:46:35.327909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.499965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-14T10:46:35.327989Z","caller":"traceutil/trace.go:171","msg":"trace[841795005] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1244; }","duration":"112.608927ms","start":"2026-04-14T10:46:35.215364Z","end":"2026-04-14T10:46:35.327972Z","steps":["trace[841795005] 'agreement among raft nodes before linearized reading' (duration: 112.439403ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:46:35.327916Z","caller":"traceutil/trace.go:171","msg":"trace[1032707793] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"113.999787ms","start":"2026-04-14T10:46:35.213891Z","end":"2026-04-14T10:46:35.327891Z","steps":["trace[1032707793] 'process raft request' (duration: 113.65548ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:46:43.847355Z","caller":"traceutil/trace.go:171","msg":"trace[1921198787] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"390.111575ms","start":"2026-04-14T10:46:43.457211Z","end":"2026-04-14T10:46:43.847323Z","steps":["trace[1921198787] 'process raft request' (duration: 383.433627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:43.847532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:43.457183Z","time spent":"390.253809ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:46:43.848176Z","caller":"traceutil/trace.go:171","msg":"trace[125208352] linearizableReadLoop","detail":"{readStateIndex:1343; appliedIndex:1341; }","duration":"378.877353ms","start":"2026-04-14T10:46:43.469278Z","end":"2026-04-14T10:46:43.848155Z","steps":["trace[125208352] 'read index received' (duration: 371.391348ms)","trace[125208352] 'applied index is now lower than readState.Index' (duration: 7.484285ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:46:43.848314Z","caller":"traceutil/trace.go:171","msg":"trace[2022839642] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"390.630216ms","start":"2026-04-14T10:46:43.4576Z","end":"2026-04-14T10:46:43.84823Z","steps":["trace[2022839642] 'process raft request' (duration: 389.671676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:43.848376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.103328ms","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-04-14T10:46:43.848504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.703368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:46:43.848559Z","caller":"traceutil/trace.go:171","msg":"trace[171750945] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1290; }","duration":"379.336723ms","start":"2026-04-14T10:46:43.469204Z","end":"2026-04-14T10:46:43.848541Z","steps":["trace[171750945] 'agreement among raft nodes before linearized reading' (duration: 379.015196ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:46:43.848564Z","caller":"traceutil/trace.go:171","msg":"trace[722297793] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1290; }","duration":"101.78819ms","start":"2026-04-14T10:46:43.74676Z","end":"2026-04-14T10:46:43.848548Z","steps":["trace[722297793] 'agreement among raft nodes before linearized reading' (duration: 101.669337ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:43.848603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:43.469179Z","time spent":"379.412684ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T10:46:43.84859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:43.457578Z","time spent":"390.865372ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:46:43.849034Z","caller":"traceutil/trace.go:171","msg":"trace[2100721997] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"178.789866ms","start":"2026-04-14T10:46:43.670137Z","end":"2026-04-14T10:46:43.848926Z","steps":["trace[2100721997] 'process raft request' (duration: 177.950338ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:46:44.012886Z","caller":"traceutil/trace.go:171","msg":"trace[352517124] linearizableReadLoop","detail":"{readStateIndex:1345; appliedIndex:1344; }","duration":"113.370449ms","start":"2026-04-14T10:46:43.899483Z","end":"2026-04-14T10:46:44.012854Z","steps":["trace[352517124] 'read index received' (duration: 112.115903ms)","trace[352517124] 'applied index is now lower than readState.Index' (duration: 1.253136ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:46:44.01303Z","caller":"traceutil/trace.go:171","msg":"trace[1941641447] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"160.137919ms","start":"2026-04-14T10:46:43.852849Z","end":"2026-04-14T10:46:44.012987Z","steps":["trace[1941641447] 'process raft request' (duration: 158.648328ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:44.01314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.624184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T10:46:44.013211Z","caller":"traceutil/trace.go:171","msg":"trace[1681223035] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1291; }","duration":"113.767227ms","start":"2026-04-14T10:46:43.899429Z","end":"2026-04-14T10:46:44.013196Z","steps":["trace[1681223035] 'agreement among raft nodes before linearized reading' (duration: 113.623034ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:44.065016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.152947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/local-path-storage/helper-pod-create-pvc-b517d96e-9697-4336-8e92-55f8bab86b1f\" ","response":"range_response_count:1 size:2243"} {"level":"info","ts":"2026-04-14T10:46:44.065136Z","caller":"traceutil/trace.go:171","msg":"trace[1168362576] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/local-path-storage/helper-pod-create-pvc-b517d96e-9697-4336-8e92-55f8bab86b1f; range_end:; response_count:1; response_revision:1292; }","duration":"165.315791ms","start":"2026-04-14T10:46:43.899795Z","end":"2026-04-14T10:46:44.065111Z","steps":["trace[1168362576] 'agreement among raft nodes before linearized reading' (duration: 164.981884ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:46:48.051861Z","caller":"traceutil/trace.go:171","msg":"trace[1373046460] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"189.010993ms","start":"2026-04-14T10:46:47.862826Z","end":"2026-04-14T10:46:48.051837Z","steps":["trace[1373046460] 'process raft request' (duration: 188.84652ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:46:48.052962Z","caller":"traceutil/trace.go:171","msg":"trace[391619307] linearizableReadLoop","detail":"{readStateIndex:1372; appliedIndex:1370; }","duration":"126.496781ms","start":"2026-04-14T10:46:47.926445Z","end":"2026-04-14T10:46:48.052941Z","steps":["trace[391619307] 'read index received' (duration: 125.306537ms)","trace[391619307] 'applied index is now lower than readState.Index' (duration: 1.189174ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:46:48.053186Z","caller":"traceutil/trace.go:171","msg":"trace[658604247] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"187.055303ms","start":"2026-04-14T10:46:47.866099Z","end":"2026-04-14T10:46:48.053154Z","steps":["trace[658604247] 'process raft request' (duration: 186.733197ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:48.053417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.95533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:46:48.053465Z","caller":"traceutil/trace.go:171","msg":"trace[1806777371] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1317; }","duration":"127.038441ms","start":"2026-04-14T10:46:47.926413Z","end":"2026-04-14T10:46:48.053451Z","steps":["trace[1806777371] 'agreement among raft nodes before linearized reading' (duration: 126.948729ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:53.60995Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12602370880151826626,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T10:46:54.161266Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12602370880151826626,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T10:46:54.662686Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12602370880151826626,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T10:46:54.893629Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.854288149s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-14T10:46:55.094128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.254739ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-14T10:46:55.094421Z","caller":"traceutil/trace.go:171","msg":"trace[431931840] transaction","detail":"{read_only:false; response_revision:1340; number_of_response:1; }","duration":"1.002258332s","start":"2026-04-14T10:46:54.092145Z","end":"2026-04-14T10:46:55.094403Z","steps":["trace[431931840] 'process raft request' (duration: 1.002089688s)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:46:55.094574Z","caller":"traceutil/trace.go:171","msg":"trace[269640800] linearizableReadLoop","detail":"{readStateIndex:1398; appliedIndex:1395; }","duration":"1.984814404s","start":"2026-04-14T10:46:53.109735Z","end":"2026-04-14T10:46:55.09455Z","steps":["trace[269640800] 'read index received' (duration: 1.784090086s)","trace[269640800] 'applied index is now lower than readState.Index' (duration: 200.722488ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:46:55.094641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:54.092134Z","time spent":"1.002375265s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:46:55.094728Z","caller":"traceutil/trace.go:171","msg":"trace[2043694858] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"888.973894ms","start":"2026-04-14T10:46:54.205698Z","end":"2026-04-14T10:46:55.094671Z","steps":["trace[2043694858] 'process raft request' (duration: 888.655578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:55.09498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:54.205674Z","time spent":"889.152598ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:46:55.095029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.985289944s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-14T10:46:55.095136Z","caller":"traceutil/trace.go:171","msg":"trace[187456360] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1341; }","duration":"1.985442047s","start":"2026-04-14T10:46:53.109682Z","end":"2026-04-14T10:46:55.095124Z","steps":["trace[187456360] 'agreement among raft nodes before linearized reading' (duration: 1.985203402s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:55.09522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:53.109659Z","time spent":"1.985496338s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-14T10:46:55.095377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.588077105s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-14T10:46:55.095403Z","caller":"traceutil/trace.go:171","msg":"trace[1667188350] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1341; }","duration":"1.588130416s","start":"2026-04-14T10:46:53.507265Z","end":"2026-04-14T10:46:55.095395Z","steps":["trace[1667188350] 'agreement among raft nodes before linearized reading' (duration: 1.588054505s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:55.095411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"994.427847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-14T10:46:55.095421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:53.50725Z","time spent":"1.588167246s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-14T10:46:55.095449Z","caller":"traceutil/trace.go:171","msg":"trace[1614626296] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1341; }","duration":"994.487349ms","start":"2026-04-14T10:46:54.100952Z","end":"2026-04-14T10:46:55.095439Z","steps":["trace[1614626296] 'agreement among raft nodes before linearized reading' (duration: 994.370357ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:55.095432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.007380993s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-14T10:46:55.095486Z","caller":"traceutil/trace.go:171","msg":"trace[654799164] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1341; }","duration":"1.007462195s","start":"2026-04-14T10:46:54.08801Z","end":"2026-04-14T10:46:55.095472Z","steps":["trace[654799164] 'agreement among raft nodes before linearized reading' (duration: 1.00725215s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:55.095474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:54.100942Z","time spent":"994.527529ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T10:46:55.095501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.008939885s","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-04-14T10:46:55.095526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:54.088002Z","time spent":"1.007514595s","remote":"127.0.0.1:54190","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":"info","ts":"2026-04-14T10:46:55.095583Z","caller":"traceutil/trace.go:171","msg":"trace[515920579] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1341; }","duration":"1.009062586s","start":"2026-04-14T10:46:54.086501Z","end":"2026-04-14T10:46:55.095563Z","steps":["trace[515920579] 'agreement among raft nodes before linearized reading' (duration: 1.008812231s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:55.09563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:54.086488Z","time spent":"1.009132967s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-14T10:46:55.09583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.789127153s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:46:55.09587Z","caller":"traceutil/trace.go:171","msg":"trace[251013283] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1341; }","duration":"1.789201084s","start":"2026-04-14T10:46:53.306657Z","end":"2026-04-14T10:46:55.095859Z","steps":["trace[251013283] 'agreement among raft nodes before linearized reading' (duration: 1.788576952s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:55.095895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:53.306641Z","time spent":"1.789248926s","remote":"127.0.0.1:53914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-14T10:46:56.314898Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.155289433s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-14T10:46:57.045223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"730.100483ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:46:57.04571Z","caller":"traceutil/trace.go:171","msg":"trace[1462984567] linearizableReadLoop","detail":"{readStateIndex:1403; appliedIndex:1398; }","duration":"1.940849167s","start":"2026-04-14T10:46:55.104842Z","end":"2026-04-14T10:46:57.045691Z","steps":["trace[1462984567] 'read index received' (duration: 54.777127ms)","trace[1462984567] 'applied index is now lower than readState.Index' (duration: 1.88607099s)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:46:57.045955Z","caller":"traceutil/trace.go:171","msg":"trace[1395956120] transaction","detail":"{read_only:false; response_revision:1343; number_of_response:1; }","duration":"1.945516878s","start":"2026-04-14T10:46:55.100418Z","end":"2026-04-14T10:46:57.045935Z","steps":["trace[1395956120] 'process raft request' (duration: 1.2146301s)","trace[1395956120] 'compare' (duration: 729.849878ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:46:57.046119Z","caller":"traceutil/trace.go:171","msg":"trace[1780806285] transaction","detail":"{read_only:false; response_revision:1346; number_of_response:1; }","duration":"1.945008118s","start":"2026-04-14T10:46:55.101079Z","end":"2026-04-14T10:46:57.046087Z","steps":["trace[1780806285] 'process raft request' (duration: 1.94457398s)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:46:57.046205Z","caller":"traceutil/trace.go:171","msg":"trace[222466863] transaction","detail":"{read_only:false; response_revision:1345; number_of_response:1; }","duration":"1.945342565s","start":"2026-04-14T10:46:55.100828Z","end":"2026-04-14T10:46:57.04617Z","steps":["trace[222466863] 'process raft request' (duration: 1.944777404s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:57.046204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:55.100397Z","time spent":"1.945612701s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:46:57.046361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"915.061927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:500 ","response":"range_response_count:6 size:2185"} {"level":"warn","ts":"2026-04-14T10:46:57.046363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:55.101071Z","time spent":"1.945175291s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:46:57.046396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:55.100817Z","time spent":"1.945477797s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:46:57.046433Z","caller":"traceutil/trace.go:171","msg":"trace[523622979] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:6; response_revision:1346; }","duration":"915.18983ms","start":"2026-04-14T10:46:56.131225Z","end":"2026-04-14T10:46:57.046414Z","steps":["trace[523622979] 'agreement among raft nodes before linearized reading' (duration: 914.922035ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:57.046496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:56.131198Z","time spent":"915.281161ms","remote":"127.0.0.1:54038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":6,"response size":2209,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:500 "} {"level":"info","ts":"2026-04-14T10:46:57.046207Z","caller":"traceutil/trace.go:171","msg":"trace[1746511992] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"1.945753583s","start":"2026-04-14T10:46:55.100416Z","end":"2026-04-14T10:46:57.04617Z","steps":["trace[1746511992] 'process raft request' (duration: 1.944910467s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:57.046585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:55.100392Z","time spent":"1.946152671s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:46:57.046705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.895809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-04-14T10:46:57.046822Z","caller":"traceutil/trace.go:171","msg":"trace[1381469131] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1346; }","duration":"804.069532ms","start":"2026-04-14T10:46:56.242734Z","end":"2026-04-14T10:46:57.046803Z","steps":["trace[1381469131] 'agreement among raft nodes before linearized reading' (duration: 803.783017ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:57.04693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"877.670154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:101716"} {"level":"info","ts":"2026-04-14T10:46:57.046995Z","caller":"traceutil/trace.go:171","msg":"trace[693714966] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1346; }","duration":"877.854448ms","start":"2026-04-14T10:46:56.169125Z","end":"2026-04-14T10:46:57.04698Z","steps":["trace[693714966] 'agreement among raft nodes before linearized reading' (duration: 877.602643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:57.046832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.941988589s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T10:46:57.047046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:56.169101Z","time spent":"877.93328ms","remote":"127.0.0.1:53976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":101740,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-04-14T10:46:57.047106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:56.242701Z","time spent":"804.265707ms","remote":"127.0.0.1:53984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":142,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"info","ts":"2026-04-14T10:46:57.047077Z","caller":"traceutil/trace.go:171","msg":"trace[853516870] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1346; }","duration":"1.942249914s","start":"2026-04-14T10:46:55.104808Z","end":"2026-04-14T10:46:57.047058Z","steps":["trace[853516870] 'agreement among raft nodes before linearized reading' (duration: 1.941980279s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:57.04729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:55.104794Z","time spent":"1.942480249s","remote":"127.0.0.1:53914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-14T10:46:57.729702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.47408ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:46:57.729822Z","caller":"traceutil/trace.go:171","msg":"trace[1033995639] linearizableReadLoop","detail":"{readStateIndex:1404; appliedIndex:1403; }","duration":"606.18916ms","start":"2026-04-14T10:46:57.123608Z","end":"2026-04-14T10:46:57.729797Z","steps":["trace[1033995639] 'read index received' (duration: 234.421964ms)","trace[1033995639] 'applied index is now lower than readState.Index' (duration: 371.764395ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:46:57.729938Z","caller":"traceutil/trace.go:171","msg":"trace[1074732099] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"624.677561ms","start":"2026-04-14T10:46:57.105248Z","end":"2026-04-14T10:46:57.729926Z","steps":["trace[1074732099] 'process raft request' (duration: 252.883935ms)","trace[1074732099] 'compare' (duration: 371.169874ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:46:57.730012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:57.105225Z","time spent":"624.748822ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:46:57.730402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.797592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/default/\" range_end:\"/registry/secrets/default0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:46:57.730431Z","caller":"traceutil/trace.go:171","msg":"trace[19751490] range","detail":"{range_begin:/registry/secrets/default/; range_end:/registry/secrets/default0; response_count:0; response_revision:1347; }","duration":"606.855933ms","start":"2026-04-14T10:46:57.123567Z","end":"2026-04-14T10:46:57.730423Z","steps":["trace[19751490] 'agreement among raft nodes before linearized reading' (duration: 606.804142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:57.730456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:57.12355Z","time spent":"606.898084ms","remote":"127.0.0.1:54026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/secrets/default/\" range_end:\"/registry/secrets/default0\" "} {"level":"warn","ts":"2026-04-14T10:46:57.731178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.012255ms","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-04-14T10:46:57.731428Z","caller":"traceutil/trace.go:171","msg":"trace[1640500408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1347; }","duration":"568.307171ms","start":"2026-04-14T10:46:57.163101Z","end":"2026-04-14T10:46:57.731409Z","steps":["trace[1640500408] 'agreement among raft nodes before linearized reading' (duration: 567.650668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:57.73159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:57.163083Z","time spent":"568.490744ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T10:46:58.032602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.75199ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:46:58.032762Z","caller":"traceutil/trace.go:171","msg":"trace[644627439] linearizableReadLoop","detail":"{readStateIndex:1405; appliedIndex:1404; }","duration":"252.816112ms","start":"2026-04-14T10:46:57.779918Z","end":"2026-04-14T10:46:58.032734Z","steps":["trace[644627439] 'read index received' (duration: 81.800366ms)","trace[644627439] 'applied index is now lower than readState.Index' (duration: 171.014086ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:46:58.032799Z","caller":"traceutil/trace.go:171","msg":"trace[217777335] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"297.036965ms","start":"2026-04-14T10:46:57.735722Z","end":"2026-04-14T10:46:58.032759Z","steps":["trace[217777335] 'process raft request' (duration: 125.972899ms)","trace[217777335] 'compare' (duration: 170.549076ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:46:58.032927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.438906ms","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-04-14T10:46:58.032975Z","caller":"traceutil/trace.go:171","msg":"trace[135214844] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1348; }","duration":"248.514598ms","start":"2026-04-14T10:46:57.784446Z","end":"2026-04-14T10:46:58.03296Z","steps":["trace[135214844] 'agreement among raft nodes before linearized reading' (duration: 248.426356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:58.033687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.751751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050260"} {"level":"info","ts":"2026-04-14T10:46:58.033771Z","caller":"traceutil/trace.go:171","msg":"trace[27701718] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:1348; }","duration":"253.878862ms","start":"2026-04-14T10:46:57.779869Z","end":"2026-04-14T10:46:58.033748Z","steps":["trace[27701718] 'agreement among raft nodes before linearized reading' (duration: 252.975555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:46:58.760925Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12602370880151826652,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T10:47:00.307358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999965255s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-14T10:47:00.307446Z","caller":"traceutil/trace.go:171","msg":"trace[1267302641] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000109198s","start":"2026-04-14T10:46:58.307318Z","end":"2026-04-14T10:47:00.307427Z","steps":["trace[1267302641] 'agreement among raft nodes before linearized reading' (duration: 1.999999146s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:00.307497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:58.307297Z","time spent":"2.00019064s","remote":"127.0.0.1:53914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/14 10:47:00 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-14T10:47:00.965294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.7876458s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:47:00.965418Z","caller":"traceutil/trace.go:171","msg":"trace[1076571301] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1348; }","duration":"2.787781703s","start":"2026-04-14T10:46:58.177618Z","end":"2026-04-14T10:47:00.9654Z","steps":["trace[1076571301] 'range keys from in-memory index tree' (duration: 2.7876311s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:00.966435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.024962703s","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-04-14T10:47:00.96657Z","caller":"traceutil/trace.go:171","msg":"trace[1406143354] linearizableReadLoop","detail":"{readStateIndex:1406; appliedIndex:1405; }","duration":"2.706005353s","start":"2026-04-14T10:46:58.260542Z","end":"2026-04-14T10:47:00.966547Z","steps":["trace[1406143354] 'read index received' (duration: 680.904636ms)","trace[1406143354] 'applied index is now lower than readState.Index' (duration: 2.025098827s)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:47:00.966692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:58.034112Z","time spent":"2.932572887s","remote":"127.0.0.1:53946","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-14T10:47:00.967375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.706801798s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050260"} {"level":"info","ts":"2026-04-14T10:47:00.967475Z","caller":"traceutil/trace.go:171","msg":"trace[1759705548] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:1348; }","duration":"2.706943s","start":"2026-04-14T10:46:58.260513Z","end":"2026-04-14T10:47:00.967456Z","steps":["trace[1759705548] 'agreement among raft nodes before linearized reading' (duration: 2.706261987s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:00.967521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:58.260499Z","time spent":"2.707010322s","remote":"127.0.0.1:54026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":5,"response size":1050284,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-04-14T10:47:01.201448Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.466711398s","expected-duration":"1s"} {"level":"info","ts":"2026-04-14T10:47:01.201972Z","caller":"traceutil/trace.go:171","msg":"trace[1854685037] linearizableReadLoop","detail":"{readStateIndex:1407; appliedIndex:1406; }","duration":"235.358905ms","start":"2026-04-14T10:47:00.966598Z","end":"2026-04-14T10:47:01.201957Z","steps":["trace[1854685037] 'read index received' (duration: 235.230103ms)","trace[1854685037] 'applied index is now lower than readState.Index' (duration: 127.962µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:47:01.202405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.151597789s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-14T10:47:01.202451Z","caller":"traceutil/trace.go:171","msg":"trace[924362050] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1349; }","duration":"2.151713412s","start":"2026-04-14T10:46:59.05073Z","end":"2026-04-14T10:47:01.202443Z","steps":["trace[924362050] 'agreement among raft nodes before linearized reading' (duration: 2.151513018s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:01.202413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.522011176s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-14T10:47:01.202473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:59.050706Z","time spent":"2.151761223s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-14T10:47:01.20247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.194750022s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T10:47:01.202507Z","caller":"traceutil/trace.go:171","msg":"trace[12131387] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1349; }","duration":"2.522168419s","start":"2026-04-14T10:46:58.680316Z","end":"2026-04-14T10:47:01.202484Z","steps":["trace[12131387] 'agreement among raft nodes before linearized reading' (duration: 2.521970176s)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:01.202537Z","caller":"traceutil/trace.go:171","msg":"trace[1601837525] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1349; }","duration":"1.194863454s","start":"2026-04-14T10:47:00.007658Z","end":"2026-04-14T10:47:01.202521Z","steps":["trace[1601837525] 'agreement among raft nodes before linearized reading' (duration: 1.194734502s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:01.202569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:00.00764Z","time spent":"1.194922255s","remote":"127.0.0.1:54316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":31,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"info","ts":"2026-04-14T10:47:01.202582Z","caller":"traceutil/trace.go:171","msg":"trace[1251576299] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"1.467990293s","start":"2026-04-14T10:46:59.734582Z","end":"2026-04-14T10:47:01.202573Z","steps":["trace[1251576299] 'process raft request' (duration: 1.467211198s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:01.202577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:58.680292Z","time spent":"2.522271521s","remote":"127.0.0.1:54038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":6,"response size":31,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-04-14T10:47:01.202647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:59.734558Z","time spent":"1.468046564s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:47:01.202699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.15163559s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-14T10:47:01.202718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"895.087502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:47:01.202728Z","caller":"traceutil/trace.go:171","msg":"trace[1293351384] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1349; }","duration":"2.151676791s","start":"2026-04-14T10:46:59.051044Z","end":"2026-04-14T10:47:01.202721Z","steps":["trace[1293351384] 'agreement among raft nodes before linearized reading' (duration: 2.15160881s)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:01.202732Z","caller":"traceutil/trace.go:171","msg":"trace[1805045606] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1349; }","duration":"895.146193ms","start":"2026-04-14T10:47:00.307582Z","end":"2026-04-14T10:47:01.202728Z","steps":["trace[1805045606] 'agreement among raft nodes before linearized reading' (duration: 895.119693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:01.202748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:00.307545Z","time spent":"895.200463ms","remote":"127.0.0.1:53922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-14T10:47:01.202537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.166354154s","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-04-14T10:47:01.202773Z","caller":"traceutil/trace.go:171","msg":"trace[126030151] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1349; }","duration":"1.16665781s","start":"2026-04-14T10:47:00.036106Z","end":"2026-04-14T10:47:01.202764Z","steps":["trace[126030151] 'agreement among raft nodes before linearized reading' (duration: 1.166255332s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:01.202791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.151803483s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-14T10:47:01.202809Z","caller":"traceutil/trace.go:171","msg":"trace[1388333658] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1349; }","duration":"2.151879274s","start":"2026-04-14T10:46:59.050925Z","end":"2026-04-14T10:47:01.202804Z","steps":["trace[1388333658] 'agreement among raft nodes before linearized reading' (duration: 2.151832824s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:01.202812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:00.036086Z","time spent":"1.166716421s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T10:47:01.202746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:59.051037Z","time spent":"2.151705841s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-14T10:47:01.202826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:59.050896Z","time spent":"2.151926036s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-14T10:47:01.202953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.609128956s","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-04-14T10:47:01.202978Z","caller":"traceutil/trace.go:171","msg":"trace[886661447] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1349; }","duration":"1.609191668s","start":"2026-04-14T10:46:59.59378Z","end":"2026-04-14T10:47:01.202971Z","steps":["trace[886661447] 'agreement among raft nodes before linearized reading' (duration: 1.609153997s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:01.202996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:59.593758Z","time spent":"1.609232958s","remote":"127.0.0.1:44020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-04-14T10:47:01.203201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.151773423s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-14T10:47:01.203603Z","caller":"traceutil/trace.go:171","msg":"trace[771331603] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1349; }","duration":"2.152216001s","start":"2026-04-14T10:46:59.051352Z","end":"2026-04-14T10:47:01.203568Z","steps":["trace[771331603] 'agreement among raft nodes before linearized reading' (duration: 2.150882186s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:01.203868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:46:59.051349Z","time spent":"2.152430625s","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-14T10:47:01.452799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.972819ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:47:01.453013Z","caller":"traceutil/trace.go:171","msg":"trace[214581246] linearizableReadLoop","detail":"{readStateIndex:1409; appliedIndex:1407; }","duration":"250.978863ms","start":"2026-04-14T10:47:01.202019Z","end":"2026-04-14T10:47:01.452998Z","steps":["trace[214581246] 'read index received' (duration: 135.7772ms)","trace[214581246] 'applied index is now lower than readState.Index' (duration: 115.200823ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:01.453043Z","caller":"traceutil/trace.go:171","msg":"trace[1118092141] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"484.805379ms","start":"2026-04-14T10:47:00.968193Z","end":"2026-04-14T10:47:01.452998Z","steps":["trace[1118092141] 'process raft request' (duration: 369.579085ms)","trace[1118092141] 'compare' (duration: 114.708624ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:01.453039Z","caller":"traceutil/trace.go:171","msg":"trace[1232265126] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"356.232535ms","start":"2026-04-14T10:47:01.096781Z","end":"2026-04-14T10:47:01.453013Z","steps":["trace[1232265126] 'process raft request' (duration: 356.133254ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:01.453124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:00.968175Z","time spent":"484.903511ms","remote":"127.0.0.1:53946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:47:01.453173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:01.096755Z","time spent":"356.348277ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:47:01.45369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.23079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050260"} {"level":"info","ts":"2026-04-14T10:47:01.453731Z","caller":"traceutil/trace.go:171","msg":"trace[2066945264] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:1351; }","duration":"261.311231ms","start":"2026-04-14T10:47:01.192408Z","end":"2026-04-14T10:47:01.453719Z","steps":["trace[2066945264] 'agreement among raft nodes before linearized reading' (duration: 260.656378ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:01.475478Z","caller":"traceutil/trace.go:171","msg":"trace[1960800518] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"266.534442ms","start":"2026-04-14T10:47:01.208917Z","end":"2026-04-14T10:47:01.475451Z","steps":["trace[1960800518] 'process raft request' (duration: 266.313567ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:01.475513Z","caller":"traceutil/trace.go:171","msg":"trace[144817377] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"266.364058ms","start":"2026-04-14T10:47:01.209123Z","end":"2026-04-14T10:47:01.475487Z","steps":["trace[144817377] 'process raft request' (duration: 266.301757ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:01.475665Z","caller":"traceutil/trace.go:171","msg":"trace[1914172122] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"266.274357ms","start":"2026-04-14T10:47:01.209378Z","end":"2026-04-14T10:47:01.475653Z","steps":["trace[1914172122] 'process raft request' (duration: 266.079923ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:01.475693Z","caller":"traceutil/trace.go:171","msg":"trace[1677084994] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"266.624613ms","start":"2026-04-14T10:47:01.20906Z","end":"2026-04-14T10:47:01.475685Z","steps":["trace[1677084994] 'process raft request' (duration: 266.290617ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:01.475752Z","caller":"traceutil/trace.go:171","msg":"trace[969440160] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"266.630753ms","start":"2026-04-14T10:47:01.209115Z","end":"2026-04-14T10:47:01.475745Z","steps":["trace[969440160] 'process raft request' (duration: 266.267346ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:01.475894Z","caller":"traceutil/trace.go:171","msg":"trace[1728875870] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"265.269958ms","start":"2026-04-14T10:47:01.210618Z","end":"2026-04-14T10:47:01.475888Z","steps":["trace[1728875870] 'process raft request' (duration: 265.001753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:01.475946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.295997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:47:01.475978Z","caller":"traceutil/trace.go:171","msg":"trace[284626026] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1357; }","duration":"266.363489ms","start":"2026-04-14T10:47:01.209605Z","end":"2026-04-14T10:47:01.475969Z","steps":["trace[284626026] 'agreement among raft nodes before linearized reading' (duration: 266.287287ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:01.861241Z","caller":"traceutil/trace.go:171","msg":"trace[1053107403] linearizableReadLoop","detail":"{readStateIndex:1417; appliedIndex:1416; }","duration":"102.290375ms","start":"2026-04-14T10:47:01.758923Z","end":"2026-04-14T10:47:01.861214Z","steps":["trace[1053107403] 'read index received' (duration: 85.783878ms)","trace[1053107403] 'applied index is now lower than readState.Index' (duration: 16.504987ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:01.86131Z","caller":"traceutil/trace.go:171","msg":"trace[1937240533] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"139.168875ms","start":"2026-04-14T10:47:01.722115Z","end":"2026-04-14T10:47:01.861284Z","steps":["trace[1937240533] 'process raft request' (duration: 122.736919ms)","trace[1937240533] 'compare' (duration: 16.241532ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:47:01.86156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.619342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"} {"level":"info","ts":"2026-04-14T10:47:01.861615Z","caller":"traceutil/trace.go:171","msg":"trace[1057110401] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1359; }","duration":"102.714574ms","start":"2026-04-14T10:47:01.758886Z","end":"2026-04-14T10:47:01.8616Z","steps":["trace[1057110401] 'agreement among raft nodes before linearized reading' (duration: 102.435359ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:03.629228Z","caller":"traceutil/trace.go:171","msg":"trace[1643404551] linearizableReadLoop","detail":"{readStateIndex:1422; appliedIndex:1421; }","duration":"149.548473ms","start":"2026-04-14T10:47:03.479394Z","end":"2026-04-14T10:47:03.628942Z","steps":["trace[1643404551] 'read index received' (duration: 85.939749ms)","trace[1643404551] 'applied index is now lower than readState.Index' (duration: 63.607354ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:47:03.629335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.92458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-14T10:47:03.62938Z","caller":"traceutil/trace.go:171","msg":"trace[289079855] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1362; }","duration":"150.013802ms","start":"2026-04-14T10:47:03.479355Z","end":"2026-04-14T10:47:03.629368Z","steps":["trace[289079855] 'agreement among raft nodes before linearized reading' (duration: 149.798708ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:03.629492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.783627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-14T10:47:03.629682Z","caller":"traceutil/trace.go:171","msg":"trace[1278610422] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1362; }","duration":"149.98967ms","start":"2026-04-14T10:47:03.479676Z","end":"2026-04-14T10:47:03.629666Z","steps":["trace[1278610422] 'agreement among raft nodes before linearized reading' (duration: 149.756316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:03.629531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.627474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-14T10:47:03.62981Z","caller":"traceutil/trace.go:171","msg":"trace[1560408547] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1362; }","duration":"149.94735ms","start":"2026-04-14T10:47:03.47985Z","end":"2026-04-14T10:47:03.629797Z","steps":["trace[1560408547] 'agreement among raft nodes before linearized reading' (duration: 149.555792ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:03.62957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.97225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-14T10:47:03.629914Z","caller":"traceutil/trace.go:171","msg":"trace[977172693] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1362; }","duration":"150.329777ms","start":"2026-04-14T10:47:03.479572Z","end":"2026-04-14T10:47:03.629902Z","steps":["trace[977172693] 'agreement among raft nodes before linearized reading' (duration: 149.94996ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:03.630392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.910548ms","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-04-14T10:47:03.630476Z","caller":"traceutil/trace.go:171","msg":"trace[1516973455] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1362; }","duration":"151.026591ms","start":"2026-04-14T10:47:03.479432Z","end":"2026-04-14T10:47:03.630458Z","steps":["trace[1516973455] 'agreement among raft nodes before linearized reading' (duration: 150.730425ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:05.525509Z","caller":"traceutil/trace.go:171","msg":"trace[726679125] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"296.427763ms","start":"2026-04-14T10:47:05.229058Z","end":"2026-04-14T10:47:05.525485Z","steps":["trace[726679125] 'process raft request' (duration: 296.30664ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:05.803986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.688125ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:47:05.804156Z","caller":"traceutil/trace.go:171","msg":"trace[1509492525] linearizableReadLoop","detail":"{readStateIndex:1429; appliedIndex:1427; }","duration":"499.785213ms","start":"2026-04-14T10:47:05.304352Z","end":"2026-04-14T10:47:05.804138Z","steps":["trace[1509492525] 'read index received' (duration: 221.041885ms)","trace[1509492525] 'applied index is now lower than readState.Index' (duration: 278.741788ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:05.80427Z","caller":"traceutil/trace.go:171","msg":"trace[1828628138] transaction","detail":"{read_only:false; response_revision:1369; number_of_response:1; }","duration":"574.783794ms","start":"2026-04-14T10:47:05.229454Z","end":"2026-04-14T10:47:05.804238Z","steps":["trace[1828628138] 'process raft request' (duration: 425.762102ms)","trace[1828628138] 'compare' (duration: 148.579903ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:47:05.804333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:05.22944Z","time spent":"574.861075ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:47:05.804388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.022528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:47:05.804412Z","caller":"traceutil/trace.go:171","msg":"trace[713092786] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"455.142328ms","start":"2026-04-14T10:47:05.349233Z","end":"2026-04-14T10:47:05.804375Z","steps":["trace[713092786] 'process raft request' (duration: 454.847143ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:05.804447Z","caller":"traceutil/trace.go:171","msg":"trace[625118674] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1370; }","duration":"500.10601ms","start":"2026-04-14T10:47:05.304326Z","end":"2026-04-14T10:47:05.804432Z","steps":["trace[625118674] 'agreement among raft nodes before linearized reading' (duration: 500.003938ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:05.804482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:05.304314Z","time spent":"500.16118ms","remote":"127.0.0.1:53922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-14T10:47:05.804534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:05.349215Z","time spent":"455.24837ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:47:05.804614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.163447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-14T10:47:05.804655Z","caller":"traceutil/trace.go:171","msg":"trace[359364918] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1370; }","duration":"109.204068ms","start":"2026-04-14T10:47:05.695441Z","end":"2026-04-14T10:47:05.804645Z","steps":["trace[359364918] 'agreement among raft nodes before linearized reading' (duration: 109.067535ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:05.804729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.665398ms","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-04-14T10:47:05.804758Z","caller":"traceutil/trace.go:171","msg":"trace[357963882] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1370; }","duration":"108.702969ms","start":"2026-04-14T10:47:05.696048Z","end":"2026-04-14T10:47:05.804751Z","steps":["trace[357963882] 'agreement among raft nodes before linearized reading' (duration: 108.585676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:05.804659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.000252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:1 size:1930"} {"level":"info","ts":"2026-04-14T10:47:05.804816Z","caller":"traceutil/trace.go:171","msg":"trace[1565832085] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:1; response_revision:1370; }","duration":"487.184215ms","start":"2026-04-14T10:47:05.317618Z","end":"2026-04-14T10:47:05.804802Z","steps":["trace[1565832085] 'agreement among raft nodes before linearized reading' (duration: 486.877749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:05.804877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.839638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:auth-delegator\" ","response":"range_response_count:1 size:651"} {"level":"info","ts":"2026-04-14T10:47:05.804891Z","caller":"traceutil/trace.go:171","msg":"trace[322442223] range","detail":"{range_begin:/registry/clusterroles/system:auth-delegator; range_end:; response_count:1; response_revision:1370; }","duration":"486.862088ms","start":"2026-04-14T10:47:05.318024Z","end":"2026-04-14T10:47:05.804887Z","steps":["trace[322442223] 'agreement among raft nodes before linearized reading' (duration: 486.831558ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:05.804903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:05.31802Z","time spent":"486.881208ms","remote":"127.0.0.1:54274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":675,"request content":"key:\"/registry/clusterroles/system:auth-delegator\" "} {"level":"warn","ts":"2026-04-14T10:47:05.804914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.423803ms","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-04-14T10:47:05.804901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:05.317603Z","time spent":"487.285146ms","remote":"127.0.0.1:54274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":1954,"request content":"key:\"/registry/clusterroles/system:aggregate-to-view\" "} {"level":"info","ts":"2026-04-14T10:47:05.804961Z","caller":"traceutil/trace.go:171","msg":"trace[1535705272] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1370; }","duration":"164.505284ms","start":"2026-04-14T10:47:05.640444Z","end":"2026-04-14T10:47:05.80495Z","steps":["trace[1535705272] 'agreement among raft nodes before linearized reading' (duration: 164.382502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:05.804828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.28832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-14T10:47:05.804987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.006175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-14T10:47:05.805048Z","caller":"traceutil/trace.go:171","msg":"trace[1857763286] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1370; }","duration":"109.531914ms","start":"2026-04-14T10:47:05.695499Z","end":"2026-04-14T10:47:05.805031Z","steps":["trace[1857763286] 'agreement among raft nodes before linearized reading' (duration: 109.257859ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:05.805078Z","caller":"traceutil/trace.go:171","msg":"trace[1913791123] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1370; }","duration":"109.120737ms","start":"2026-04-14T10:47:05.695944Z","end":"2026-04-14T10:47:05.805065Z","steps":["trace[1913791123] 'agreement among raft nodes before linearized reading' (duration: 108.604767ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:05.804841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.287311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:47:05.805157Z","caller":"traceutil/trace.go:171","msg":"trace[1422993562] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1370; }","duration":"473.619298ms","start":"2026-04-14T10:47:05.331526Z","end":"2026-04-14T10:47:05.805145Z","steps":["trace[1422993562] 'agreement among raft nodes before linearized reading' (duration: 473.294642ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:05.805198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:05.331516Z","time spent":"473.667969ms","remote":"127.0.0.1:36590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-14T10:47:06.040913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.036255ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:47:06.041069Z","caller":"traceutil/trace.go:171","msg":"trace[1702592392] transaction","detail":"{read_only:false; response_revision:1371; number_of_response:1; }","duration":"231.323338ms","start":"2026-04-14T10:47:05.809725Z","end":"2026-04-14T10:47:06.041048Z","steps":["trace[1702592392] 'process raft request' (duration: 115.073949ms)","trace[1702592392] 'compare' (duration: 115.808241ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:06.041531Z","caller":"traceutil/trace.go:171","msg":"trace[1920210188] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"231.742676ms","start":"2026-04-14T10:47:05.809771Z","end":"2026-04-14T10:47:06.041514Z","steps":["trace[1920210188] 'process raft request' (duration: 231.232766ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:06.041581Z","caller":"traceutil/trace.go:171","msg":"trace[1459961075] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"231.150785ms","start":"2026-04-14T10:47:05.810411Z","end":"2026-04-14T10:47:06.041561Z","steps":["trace[1459961075] 'process raft request' (duration: 231.093084ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:06.04159Z","caller":"traceutil/trace.go:171","msg":"trace[186281031] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"231.262447ms","start":"2026-04-14T10:47:05.810301Z","end":"2026-04-14T10:47:06.041563Z","steps":["trace[186281031] 'process raft request' (duration: 231.124684ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:06.042193Z","caller":"traceutil/trace.go:171","msg":"trace[1143568533] linearizableReadLoop","detail":"{readStateIndex:1435; appliedIndex:1430; }","duration":"166.317277ms","start":"2026-04-14T10:47:05.875861Z","end":"2026-04-14T10:47:06.042178Z","steps":["trace[1143568533] 'read index received' (duration: 48.954927ms)","trace[1143568533] 'applied index is now lower than readState.Index' (duration: 117.36126ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:06.042313Z","caller":"traceutil/trace.go:171","msg":"trace[956550842] transaction","detail":"{read_only:false; response_revision:1375; number_of_response:1; }","duration":"231.725116ms","start":"2026-04-14T10:47:05.810576Z","end":"2026-04-14T10:47:06.042301Z","steps":["trace[956550842] 'process raft request' (duration: 230.960461ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:06.042393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.391244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:basic-user\" ","response":"range_response_count:1 size:678"} {"level":"info","ts":"2026-04-14T10:47:06.042433Z","caller":"traceutil/trace.go:171","msg":"trace[1537930175] range","detail":"{range_begin:/registry/clusterroles/system:basic-user; range_end:; response_count:1; response_revision:1375; }","duration":"142.460965ms","start":"2026-04-14T10:47:05.899963Z","end":"2026-04-14T10:47:06.042424Z","steps":["trace[1537930175] 'agreement among raft nodes before linearized reading' (duration: 142.372263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:06.042638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.763146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:auth-delegator\" ","response":"range_response_count:1 size:651"} {"level":"info","ts":"2026-04-14T10:47:06.042703Z","caller":"traceutil/trace.go:171","msg":"trace[1073389034] range","detail":"{range_begin:/registry/clusterroles/system:auth-delegator; range_end:; response_count:1; response_revision:1375; }","duration":"166.870567ms","start":"2026-04-14T10:47:05.875824Z","end":"2026-04-14T10:47:06.042695Z","steps":["trace[1073389034] 'agreement among raft nodes before linearized reading' (duration: 166.748075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:08.089536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.728623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:namespace-controller\" ","response":"range_response_count:1 size:723"} {"level":"info","ts":"2026-04-14T10:47:08.089255Z","caller":"traceutil/trace.go:171","msg":"trace[1334127077] linearizableReadLoop","detail":"{readStateIndex:1437; appliedIndex:1436; }","duration":"104.436238ms","start":"2026-04-14T10:47:07.984797Z","end":"2026-04-14T10:47:08.089233Z","steps":["trace[1334127077] 'read index received' (duration: 98.568188ms)","trace[1334127077] 'applied index is now lower than readState.Index' (duration: 5.86694ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:08.089595Z","caller":"traceutil/trace.go:171","msg":"trace[740068170] range","detail":"{range_begin:/registry/clusterroles/system:controller:namespace-controller; range_end:; response_count:1; response_revision:1376; }","duration":"104.820765ms","start":"2026-04-14T10:47:07.98476Z","end":"2026-04-14T10:47:08.089581Z","steps":["trace[740068170] 'agreement among raft nodes before linearized reading' (duration: 104.705123ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:10.134805Z","caller":"traceutil/trace.go:171","msg":"trace[1414055006] linearizableReadLoop","detail":"{readStateIndex:1444; appliedIndex:1443; }","duration":"171.990933ms","start":"2026-04-14T10:47:09.96279Z","end":"2026-04-14T10:47:10.134781Z","steps":["trace[1414055006] 'read index received' (duration: 171.738278ms)","trace[1414055006] 'applied index is now lower than readState.Index' (duration: 251.505µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:47:10.135019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.212018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:kube-aggregator\" ","response":"range_response_count:1 size:595"} {"level":"info","ts":"2026-04-14T10:47:10.135087Z","caller":"traceutil/trace.go:171","msg":"trace[1019127123] range","detail":"{range_begin:/registry/clusterroles/system:kube-aggregator; range_end:; response_count:1; response_revision:1383; }","duration":"172.294779ms","start":"2026-04-14T10:47:09.962778Z","end":"2026-04-14T10:47:10.135073Z","steps":["trace[1019127123] 'agreement among raft nodes before linearized reading' (duration: 172.148096ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:10.135082Z","caller":"traceutil/trace.go:171","msg":"trace[382852862] transaction","detail":"{read_only:false; response_revision:1383; number_of_response:1; }","duration":"221.028498ms","start":"2026-04-14T10:47:09.914027Z","end":"2026-04-14T10:47:10.135055Z","steps":["trace[382852862] 'process raft request' (duration: 220.61643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:10.135392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.622589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/cilium-operator\" ","response":"range_response_count:1 size:785"} {"level":"info","ts":"2026-04-14T10:47:10.135598Z","caller":"traceutil/trace.go:171","msg":"trace[2145992542] range","detail":"{range_begin:/registry/clusterrolebindings/cilium-operator; range_end:; response_count:1; response_revision:1383; }","duration":"169.881373ms","start":"2026-04-14T10:47:09.96569Z","end":"2026-04-14T10:47:10.135571Z","steps":["trace[2145992542] 'agreement among raft nodes before linearized reading' (duration: 169.338933ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:10.320534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.352987ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:47:10.320812Z","caller":"traceutil/trace.go:171","msg":"trace[290380910] linearizableReadLoop","detail":"{readStateIndex:1449; appliedIndex:1444; }","duration":"113.497352ms","start":"2026-04-14T10:47:10.207295Z","end":"2026-04-14T10:47:10.320792Z","steps":["trace[290380910] 'read index received' (duration: 12.812108ms)","trace[290380910] 'applied index is now lower than readState.Index' (duration: 100.683854ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:10.320815Z","caller":"traceutil/trace.go:171","msg":"trace[267214739] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"127.746737ms","start":"2026-04-14T10:47:10.193039Z","end":"2026-04-14T10:47:10.320786Z","steps":["trace[267214739] 'process raft request' (duration: 27.047173ms)","trace[267214739] 'compare' (duration: 100.160584ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:10.320857Z","caller":"traceutil/trace.go:171","msg":"trace[2025157077] transaction","detail":"{read_only:false; response_revision:1387; number_of_response:1; }","duration":"126.28406ms","start":"2026-04-14T10:47:10.194551Z","end":"2026-04-14T10:47:10.320835Z","steps":["trace[2025157077] 'process raft request' (duration: 126.178748ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:10.320832Z","caller":"traceutil/trace.go:171","msg":"trace[1732795605] transaction","detail":"{read_only:false; response_revision:1385; number_of_response:1; }","duration":"126.937002ms","start":"2026-04-14T10:47:10.193856Z","end":"2026-04-14T10:47:10.320793Z","steps":["trace[1732795605] 'process raft request' (duration: 126.782319ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:10.320907Z","caller":"traceutil/trace.go:171","msg":"trace[1501193934] transaction","detail":"{read_only:false; response_revision:1388; number_of_response:1; }","duration":"115.924997ms","start":"2026-04-14T10:47:10.204972Z","end":"2026-04-14T10:47:10.320897Z","steps":["trace[1501193934] 'process raft request' (duration: 115.786044ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:10.320953Z","caller":"traceutil/trace.go:171","msg":"trace[1073017218] transaction","detail":"{read_only:false; response_revision:1386; number_of_response:1; }","duration":"126.442382ms","start":"2026-04-14T10:47:10.194486Z","end":"2026-04-14T10:47:10.320929Z","steps":["trace[1073017218] 'process raft request' (duration: 126.215068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:10.321073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.761057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:kube-aggregator\" ","response":"range_response_count:1 size:595"} {"level":"info","ts":"2026-04-14T10:47:10.321108Z","caller":"traceutil/trace.go:171","msg":"trace[305128074] range","detail":"{range_begin:/registry/clusterroles/system:kube-aggregator; range_end:; response_count:1; response_revision:1388; }","duration":"113.840439ms","start":"2026-04-14T10:47:10.207258Z","end":"2026-04-14T10:47:10.321098Z","steps":["trace[305128074] 'agreement among raft nodes before linearized reading' (duration: 113.755087ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:11.995478Z","caller":"traceutil/trace.go:171","msg":"trace[1413894266] linearizableReadLoop","detail":"{readStateIndex:1450; appliedIndex:1449; }","duration":"152.925406ms","start":"2026-04-14T10:47:11.842527Z","end":"2026-04-14T10:47:11.995452Z","steps":["trace[1413894266] 'read index received' (duration: 152.62607ms)","trace[1413894266] 'applied index is now lower than readState.Index' (duration: 298.376µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:47:11.995608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.064528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:attachdetach-controller\" ","response":"range_response_count:1 size:767"} {"level":"info","ts":"2026-04-14T10:47:11.995647Z","caller":"traceutil/trace.go:171","msg":"trace[827354039] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:attachdetach-controller; range_end:; response_count:1; response_revision:1389; }","duration":"153.14872ms","start":"2026-04-14T10:47:11.842482Z","end":"2026-04-14T10:47:11.995631Z","steps":["trace[827354039] 'agreement among raft nodes before linearized reading' (duration: 153.072229ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:11.99566Z","caller":"traceutil/trace.go:171","msg":"trace[1243502643] transaction","detail":"{read_only:false; response_revision:1389; number_of_response:1; }","duration":"156.675785ms","start":"2026-04-14T10:47:11.838965Z","end":"2026-04-14T10:47:11.995641Z","steps":["trace[1243502643] 'process raft request' (duration: 156.312199ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:12.418551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.172447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:811"} {"level":"info","ts":"2026-04-14T10:47:12.418665Z","caller":"traceutil/trace.go:171","msg":"trace[2017669487] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:1390; }","duration":"162.32459ms","start":"2026-04-14T10:47:12.256313Z","end":"2026-04-14T10:47:12.418637Z","steps":["trace[2017669487] 'range keys from in-memory index tree' (duration: 162.051106ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:12.41869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.948717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T10:47:12.418766Z","caller":"traceutil/trace.go:171","msg":"trace[75979673] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1390; }","duration":"120.065879ms","start":"2026-04-14T10:47:12.29868Z","end":"2026-04-14T10:47:12.418746Z","steps":["trace[75979673] 'count revisions from in-memory index tree' (duration: 119.878666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:12.419366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.090767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:daemon-set-controller\" ","response":"range_response_count:1 size:759"} {"level":"info","ts":"2026-04-14T10:47:12.419448Z","caller":"traceutil/trace.go:171","msg":"trace[1558529515] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:daemon-set-controller; range_end:; response_count:1; response_revision:1390; }","duration":"102.217359ms","start":"2026-04-14T10:47:12.317211Z","end":"2026-04-14T10:47:12.419428Z","steps":["trace[1558529515] 'range keys from in-memory index tree' (duration: 101.383554ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:12.686122Z","caller":"traceutil/trace.go:171","msg":"trace[205921473] transaction","detail":"{read_only:false; response_revision:1392; number_of_response:1; }","duration":"262.612914ms","start":"2026-04-14T10:47:12.423483Z","end":"2026-04-14T10:47:12.686095Z","steps":["trace[205921473] 'process raft request' (duration: 262.199016ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:12.686431Z","caller":"traceutil/trace.go:171","msg":"trace[340292130] transaction","detail":"{read_only:false; response_revision:1393; number_of_response:1; }","duration":"262.558073ms","start":"2026-04-14T10:47:12.42386Z","end":"2026-04-14T10:47:12.686418Z","steps":["trace[340292130] 'process raft request' (duration: 261.982422ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:12.686508Z","caller":"traceutil/trace.go:171","msg":"trace[548340131] linearizableReadLoop","detail":"{readStateIndex:1455; appliedIndex:1451; }","duration":"262.315528ms","start":"2026-04-14T10:47:12.424168Z","end":"2026-04-14T10:47:12.686484Z","steps":["trace[548340131] 'read index received' (duration: 95.346322ms)","trace[548340131] 'applied index is now lower than readState.Index' (duration: 166.968236ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:12.686592Z","caller":"traceutil/trace.go:171","msg":"trace[802503405] transaction","detail":"{read_only:false; response_revision:1394; number_of_response:1; }","duration":"262.40553ms","start":"2026-04-14T10:47:12.424129Z","end":"2026-04-14T10:47:12.686535Z","steps":["trace[802503405] 'process raft request' (duration: 262.170746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:12.686699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.999737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:daemon-set-controller\" ","response":"range_response_count:1 size:759"} {"level":"warn","ts":"2026-04-14T10:47:12.686688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.496071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:811"} {"level":"info","ts":"2026-04-14T10:47:12.686739Z","caller":"traceutil/trace.go:171","msg":"trace[2027700382] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:daemon-set-controller; range_end:; response_count:1; response_revision:1395; }","duration":"147.1143ms","start":"2026-04-14T10:47:12.539613Z","end":"2026-04-14T10:47:12.686728Z","steps":["trace[2027700382] 'agreement among raft nodes before linearized reading' (duration: 147.018478ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:12.686761Z","caller":"traceutil/trace.go:171","msg":"trace[1481647703] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:1395; }","duration":"262.606344ms","start":"2026-04-14T10:47:12.424134Z","end":"2026-04-14T10:47:12.686741Z","steps":["trace[1481647703] 'agreement among raft nodes before linearized reading' (duration: 262.486832ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:12.686885Z","caller":"traceutil/trace.go:171","msg":"trace[1824852903] transaction","detail":"{read_only:false; response_revision:1395; number_of_response:1; }","duration":"262.290528ms","start":"2026-04-14T10:47:12.424584Z","end":"2026-04-14T10:47:12.686875Z","steps":["trace[1824852903] 'process raft request' (duration: 261.85661ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:12.686893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.879046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T10:47:12.686936Z","caller":"traceutil/trace.go:171","msg":"trace[2041728387] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1395; }","duration":"112.937137ms","start":"2026-04-14T10:47:12.573987Z","end":"2026-04-14T10:47:12.686924Z","steps":["trace[2041728387] 'agreement among raft nodes before linearized reading' (duration: 112.850846ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:14.631509Z","caller":"traceutil/trace.go:171","msg":"trace[1709342753] transaction","detail":"{read_only:false; response_revision:1397; number_of_response:1; }","duration":"104.620151ms","start":"2026-04-14T10:47:14.526864Z","end":"2026-04-14T10:47:14.631484Z","steps":["trace[1709342753] 'process raft request' (duration: 104.422027ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:15.036643Z","caller":"traceutil/trace.go:171","msg":"trace[2091618848] linearizableReadLoop","detail":"{readStateIndex:1463; appliedIndex:1459; }","duration":"314.600655ms","start":"2026-04-14T10:47:14.722023Z","end":"2026-04-14T10:47:15.036623Z","steps":["trace[2091618848] 'read index received' (duration: 47.992952ms)","trace[2091618848] 'applied index is now lower than readState.Index' (duration: 266.606813ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:47:15.036932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.633917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:pvc-protection-controller\" ","response":"range_response_count:1 size:775"} {"level":"info","ts":"2026-04-14T10:47:15.036924Z","caller":"traceutil/trace.go:171","msg":"trace[1701862574] transaction","detail":"{read_only:false; response_revision:1400; number_of_response:1; }","duration":"328.257005ms","start":"2026-04-14T10:47:14.708643Z","end":"2026-04-14T10:47:15.0369Z","steps":["trace[1701862574] 'process raft request' (duration: 327.905349ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:15.036978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.940091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:pv-protection-controller\" ","response":"range_response_count:1 size:771"} {"level":"info","ts":"2026-04-14T10:47:15.037025Z","caller":"traceutil/trace.go:171","msg":"trace[1575971316] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:pv-protection-controller; range_end:; response_count:1; response_revision:1401; }","duration":"315.032532ms","start":"2026-04-14T10:47:14.721978Z","end":"2026-04-14T10:47:15.037011Z","steps":["trace[1575971316] 'agreement among raft nodes before linearized reading' (duration: 314.89013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:15.037055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:14.721962Z","time spent":"315.084214ms","remote":"127.0.0.1:54278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":795,"request content":"key:\"/registry/clusterrolebindings/system:controller:pv-protection-controller\" "} {"level":"warn","ts":"2026-04-14T10:47:15.037068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:14.708638Z","time spent":"328.372757ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:47:15.037083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.035212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T10:47:15.037115Z","caller":"traceutil/trace.go:171","msg":"trace[155432441] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1401; }","duration":"145.107172ms","start":"2026-04-14T10:47:14.892001Z","end":"2026-04-14T10:47:15.037108Z","steps":["trace[155432441] 'agreement among raft nodes before linearized reading' (duration: 145.050011ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:15.037245Z","caller":"traceutil/trace.go:171","msg":"trace[1642939220] transaction","detail":"{read_only:false; response_revision:1401; number_of_response:1; }","duration":"328.566972ms","start":"2026-04-14T10:47:14.708667Z","end":"2026-04-14T10:47:15.037234Z","steps":["trace[1642939220] 'process raft request' (duration: 327.91917ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:15.037304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:14.708664Z","time spent":"328.607932ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:47:15.037341Z","caller":"traceutil/trace.go:171","msg":"trace[2100074969] transaction","detail":"{read_only:false; response_revision:1399; number_of_response:1; }","duration":"328.731404ms","start":"2026-04-14T10:47:14.708596Z","end":"2026-04-14T10:47:15.037328Z","steps":["trace[2100074969] 'process raft request' (duration: 308.872691ms)","trace[2100074969] 'compare' (duration: 18.974207ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:15.036977Z","caller":"traceutil/trace.go:171","msg":"trace[1064625739] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:pvc-protection-controller; range_end:; response_count:1; response_revision:1401; }","duration":"307.705979ms","start":"2026-04-14T10:47:14.72926Z","end":"2026-04-14T10:47:15.036966Z","steps":["trace[1064625739] 'agreement among raft nodes before linearized reading' (duration: 307.619507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:15.03794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:14.708579Z","time spent":"329.298394ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:47:15.037994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:14.729251Z","time spent":"308.722947ms","remote":"127.0.0.1:54278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":799,"request content":"key:\"/registry/clusterrolebindings/system:controller:pvc-protection-controller\" "} {"level":"warn","ts":"2026-04-14T10:47:15.381106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.93027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:replicaset-controller\" ","response":"range_response_count:1 size:759"} {"level":"info","ts":"2026-04-14T10:47:15.381184Z","caller":"traceutil/trace.go:171","msg":"trace[1391845804] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:replicaset-controller; range_end:; response_count:1; response_revision:1401; }","duration":"182.040782ms","start":"2026-04-14T10:47:15.199126Z","end":"2026-04-14T10:47:15.381167Z","steps":["trace[1391845804] 'range keys from in-memory index tree' (duration: 181.768138ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:15.381311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.302891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:replication-controller\" ","response":"range_response_count:1 size:763"} {"level":"info","ts":"2026-04-14T10:47:15.381363Z","caller":"traceutil/trace.go:171","msg":"trace[1589414956] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:replication-controller; range_end:; response_count:1; response_revision:1401; }","duration":"191.355412ms","start":"2026-04-14T10:47:15.189995Z","end":"2026-04-14T10:47:15.38135Z","steps":["trace[1589414956] 'range keys from in-memory index tree' (duration: 191.187809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:17.187646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.337311ms","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-04-14T10:47:17.187718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.300632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-14T10:47:17.187752Z","caller":"traceutil/trace.go:171","msg":"trace[68640992] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1404; }","duration":"146.515214ms","start":"2026-04-14T10:47:17.041212Z","end":"2026-04-14T10:47:17.187728Z","steps":["trace[68640992] 'range keys from in-memory index tree' (duration: 146.133687ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:17.187799Z","caller":"traceutil/trace.go:171","msg":"trace[1724791505] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1404; }","duration":"383.400594ms","start":"2026-04-14T10:47:16.804377Z","end":"2026-04-14T10:47:17.187777Z","steps":["trace[1724791505] 'range keys from in-memory index tree' (duration: 383.15179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:17.187825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.473451ms","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-04-14T10:47:17.187871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:16.804358Z","time spent":"383.498266ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-14T10:47:17.187908Z","caller":"traceutil/trace.go:171","msg":"trace[768354261] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1404; }","duration":"147.576193ms","start":"2026-04-14T10:47:17.040313Z","end":"2026-04-14T10:47:17.18789Z","steps":["trace[768354261] 'range keys from in-memory index tree' (duration: 147.215157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:17.188116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.486053ms","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-04-14T10:47:17.187661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.440554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:node\" ","response":"range_response_count:1 size:603"} {"level":"warn","ts":"2026-04-14T10:47:17.188204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:16.804521Z","time spent":"383.675219ms","remote":"127.0.0.1:45798","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-14T10:47:17.188215Z","caller":"traceutil/trace.go:171","msg":"trace[1945093056] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1404; }","duration":"146.620836ms","start":"2026-04-14T10:47:17.041573Z","end":"2026-04-14T10:47:17.188194Z","steps":["trace[1945093056] 'range keys from in-memory index tree' (duration: 146.322221ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:17.188244Z","caller":"traceutil/trace.go:171","msg":"trace[2143638701] range","detail":"{range_begin:/registry/clusterrolebindings/system:node; range_end:; response_count:1; response_revision:1404; }","duration":"379.053405ms","start":"2026-04-14T10:47:16.809173Z","end":"2026-04-14T10:47:17.188227Z","steps":["trace[2143638701] 'range keys from in-memory index tree' (duration: 378.343332ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:17.188303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:16.809168Z","time spent":"379.118916ms","remote":"127.0.0.1:54278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":627,"request content":"key:\"/registry/clusterrolebindings/system:node\" "} {"level":"warn","ts":"2026-04-14T10:47:17.188718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.392409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:monitoring\" ","response":"range_response_count:1 size:694"} {"level":"info","ts":"2026-04-14T10:47:17.188822Z","caller":"traceutil/trace.go:171","msg":"trace[22889022] range","detail":"{range_begin:/registry/clusterrolebindings/system:monitoring; range_end:; response_count:1; response_revision:1404; }","duration":"380.563172ms","start":"2026-04-14T10:47:16.808241Z","end":"2026-04-14T10:47:17.188804Z","steps":["trace[22889022] 'range keys from in-memory index tree' (duration: 380.020272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:17.189495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:16.808212Z","time spent":"381.242494ms","remote":"127.0.0.1:54278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":718,"request content":"key:\"/registry/clusterrolebindings/system:monitoring\" "} {"level":"info","ts":"2026-04-14T10:47:17.32119Z","caller":"traceutil/trace.go:171","msg":"trace[21299660] transaction","detail":"{read_only:false; response_revision:1405; number_of_response:1; }","duration":"127.440918ms","start":"2026-04-14T10:47:17.19372Z","end":"2026-04-14T10:47:17.321161Z","steps":["trace[21299660] 'process raft request' (duration: 127.272455ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:17.577072Z","caller":"traceutil/trace.go:171","msg":"trace[1514804333] linearizableReadLoop","detail":"{readStateIndex:1469; appliedIndex:1466; }","duration":"383.22298ms","start":"2026-04-14T10:47:17.193823Z","end":"2026-04-14T10:47:17.577046Z","steps":["trace[1514804333] 'read index received' (duration: 127.244754ms)","trace[1514804333] 'applied index is now lower than readState.Index' (duration: 255.976806ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:17.577227Z","caller":"traceutil/trace.go:171","msg":"trace[1137407288] transaction","detail":"{read_only:false; response_revision:1408; number_of_response:1; }","duration":"381.274715ms","start":"2026-04-14T10:47:17.195929Z","end":"2026-04-14T10:47:17.577204Z","steps":["trace[1137407288] 'process raft request' (duration: 381.072312ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:17.577218Z","caller":"traceutil/trace.go:171","msg":"trace[1834702508] transaction","detail":"{read_only:false; response_revision:1407; number_of_response:1; }","duration":"383.430345ms","start":"2026-04-14T10:47:17.193759Z","end":"2026-04-14T10:47:17.577189Z","steps":["trace[1834702508] 'process raft request' (duration: 383.109089ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:17.577269Z","caller":"traceutil/trace.go:171","msg":"trace[1077988050] transaction","detail":"{read_only:false; response_revision:1406; number_of_response:1; }","duration":"383.523196ms","start":"2026-04-14T10:47:17.193728Z","end":"2026-04-14T10:47:17.577251Z","steps":["trace[1077988050] 'process raft request' (duration: 381.759814ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:17.577335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.889954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:node\" ","response":"range_response_count:1 size:603"} {"level":"warn","ts":"2026-04-14T10:47:17.577336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:17.195914Z","time spent":"381.355966ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:47:17.57737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:17.193696Z","time spent":"383.613038ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:47:17.577371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:17.193718Z","time spent":"383.573417ms","remote":"127.0.0.1:54190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:47:17.577378Z","caller":"traceutil/trace.go:171","msg":"trace[477313962] range","detail":"{range_begin:/registry/clusterrolebindings/system:node; range_end:; response_count:1; response_revision:1408; }","duration":"311.972294ms","start":"2026-04-14T10:47:17.265393Z","end":"2026-04-14T10:47:17.577365Z","steps":["trace[477313962] 'agreement among raft nodes before linearized reading' (duration: 311.918003ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:17.577515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:17.265376Z","time spent":"312.124978ms","remote":"127.0.0.1:54278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":627,"request content":"key:\"/registry/clusterrolebindings/system:node\" "} {"level":"warn","ts":"2026-04-14T10:47:17.577546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.016753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T10:47:17.577617Z","caller":"traceutil/trace.go:171","msg":"trace[722532546] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1408; }","duration":"164.129166ms","start":"2026-04-14T10:47:17.413476Z","end":"2026-04-14T10:47:17.577605Z","steps":["trace[722532546] 'agreement among raft nodes before linearized reading' (duration: 164.021544ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:17.57727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.427095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:monitoring\" ","response":"range_response_count:1 size:694"} {"level":"info","ts":"2026-04-14T10:47:17.57776Z","caller":"traceutil/trace.go:171","msg":"trace[1081711723] range","detail":"{range_begin:/registry/clusterrolebindings/system:monitoring; range_end:; response_count:1; response_revision:1408; }","duration":"383.950474ms","start":"2026-04-14T10:47:17.193791Z","end":"2026-04-14T10:47:17.577742Z","steps":["trace[1081711723] 'agreement among raft nodes before linearized reading' (duration: 383.414234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:17.577814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:17.193771Z","time spent":"384.027475ms","remote":"127.0.0.1:54278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":718,"request content":"key:\"/registry/clusterrolebindings/system:monitoring\" "} {"level":"warn","ts":"2026-04-14T10:47:18.31223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.547551ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:47:18.312427Z","caller":"traceutil/trace.go:171","msg":"trace[219106032] linearizableReadLoop","detail":"{readStateIndex:1473; appliedIndex:1471; }","duration":"122.248797ms","start":"2026-04-14T10:47:18.19016Z","end":"2026-04-14T10:47:18.312409Z","steps":["trace[219106032] 'read index received' (duration: 14.449303ms)","trace[219106032] 'applied index is now lower than readState.Index' (duration: 107.798544ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:18.312565Z","caller":"traceutil/trace.go:171","msg":"trace[647046216] transaction","detail":"{read_only:false; response_revision:1409; number_of_response:1; }","duration":"205.6688ms","start":"2026-04-14T10:47:18.10688Z","end":"2026-04-14T10:47:18.312548Z","steps":["trace[647046216] 'process raft request' (duration: 97.723652ms)","trace[647046216] 'compare' (duration: 107.422218ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:18.312913Z","caller":"traceutil/trace.go:171","msg":"trace[47992461] transaction","detail":"{read_only:false; response_revision:1410; number_of_response:1; }","duration":"127.293578ms","start":"2026-04-14T10:47:18.185608Z","end":"2026-04-14T10:47:18.312902Z","steps":["trace[47992461] 'process raft request' (duration: 126.736088ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:18.312892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.705636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:1 size:339"} {"level":"warn","ts":"2026-04-14T10:47:18.312936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.126515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-04-14T10:47:18.313058Z","caller":"traceutil/trace.go:171","msg":"trace[1997014444] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:1410; }","duration":"122.264067ms","start":"2026-04-14T10:47:18.19078Z","end":"2026-04-14T10:47:18.313044Z","steps":["trace[1997014444] 'agreement among raft nodes before linearized reading' (duration: 122.042583ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:18.313023Z","caller":"traceutil/trace.go:171","msg":"trace[132763840] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:1; response_revision:1410; }","duration":"122.832447ms","start":"2026-04-14T10:47:18.190126Z","end":"2026-04-14T10:47:18.312959Z","steps":["trace[132763840] 'agreement among raft nodes before linearized reading' (duration: 122.617643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:18.935186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.678518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/local-path-storage\" ","response":"range_response_count:1 size:404"} {"level":"info","ts":"2026-04-14T10:47:18.935267Z","caller":"traceutil/trace.go:171","msg":"trace[449708173] range","detail":"{range_begin:/registry/namespaces/local-path-storage; range_end:; response_count:1; response_revision:1411; }","duration":"104.79622ms","start":"2026-04-14T10:47:18.830451Z","end":"2026-04-14T10:47:18.935247Z","steps":["trace[449708173] 'range keys from in-memory index tree' (duration: 104.505445ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:20.989497Z","caller":"traceutil/trace.go:171","msg":"trace[1190630117] linearizableReadLoop","detail":"{readStateIndex:1480; appliedIndex:1479; }","duration":"197.53272ms","start":"2026-04-14T10:47:20.791944Z","end":"2026-04-14T10:47:20.989477Z","steps":["trace[1190630117] 'read index received' (duration: 197.378927ms)","trace[1190630117] 'applied index is now lower than readState.Index' (duration: 152.563µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:47:20.989593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.636523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/envoy-gateway-system/\" range_end:\"/registry/persistentvolumeclaims/envoy-gateway-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:47:20.989576Z","caller":"traceutil/trace.go:171","msg":"trace[1992545161] transaction","detail":"{read_only:false; response_revision:1417; number_of_response:1; }","duration":"222.4768ms","start":"2026-04-14T10:47:20.767071Z","end":"2026-04-14T10:47:20.989548Z","steps":["trace[1992545161] 'process raft request' (duration: 222.271977ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:20.989619Z","caller":"traceutil/trace.go:171","msg":"trace[373660831] range","detail":"{range_begin:/registry/persistentvolumeclaims/envoy-gateway-system/; range_end:/registry/persistentvolumeclaims/envoy-gateway-system0; response_count:0; response_revision:1417; }","duration":"197.705714ms","start":"2026-04-14T10:47:20.791904Z","end":"2026-04-14T10:47:20.98961Z","steps":["trace[373660831] 'agreement among raft nodes before linearized reading' (duration: 197.649443ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:21.498397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.426765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/\" range_end:\"/registry/rolebindings/envoy-gateway-system0\" limit:500 ","response":"range_response_count:3 size:3302"} {"level":"warn","ts":"2026-04-14T10:47:21.498454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.580891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/\" range_end:\"/registry/persistentvolumeclaims/default0\" limit:500 ","response":"range_response_count:1 size:1465"} {"level":"info","ts":"2026-04-14T10:47:21.498559Z","caller":"traceutil/trace.go:171","msg":"trace[1211924799] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/; range_end:/registry/persistentvolumeclaims/default0; response_count:1; response_revision:1417; }","duration":"424.740293ms","start":"2026-04-14T10:47:21.073794Z","end":"2026-04-14T10:47:21.498534Z","steps":["trace[1211924799] 'range keys from in-memory index tree' (duration: 424.417298ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:21.498495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.558858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-14T10:47:21.498672Z","caller":"traceutil/trace.go:171","msg":"trace[784372190] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1417; }","duration":"149.773601ms","start":"2026-04-14T10:47:21.34888Z","end":"2026-04-14T10:47:21.498653Z","steps":["trace[784372190] 'range keys from in-memory index tree' (duration: 149.065239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:21.498613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:21.07377Z","time spent":"424.830525ms","remote":"127.0.0.1:54086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":1,"response size":1489,"request content":"key:\"/registry/persistentvolumeclaims/default/\" range_end:\"/registry/persistentvolumeclaims/default0\" limit:500 "} {"level":"info","ts":"2026-04-14T10:47:21.498493Z","caller":"traceutil/trace.go:171","msg":"trace[579123163] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/; range_end:/registry/rolebindings/envoy-gateway-system0; response_count:3; response_revision:1417; }","duration":"401.577037ms","start":"2026-04-14T10:47:21.096895Z","end":"2026-04-14T10:47:21.498472Z","steps":["trace[579123163] 'range keys from in-memory index tree' (duration: 401.206491ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:21.499098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:47:21.096872Z","time spent":"402.165248ms","remote":"127.0.0.1:54260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":3,"response size":3326,"request content":"key:\"/registry/rolebindings/envoy-gateway-system/\" range_end:\"/registry/rolebindings/envoy-gateway-system0\" limit:500 "} {"level":"info","ts":"2026-04-14T10:47:21.746298Z","caller":"traceutil/trace.go:171","msg":"trace[1821398417] linearizableReadLoop","detail":"{readStateIndex:1481; appliedIndex:1480; }","duration":"116.171137ms","start":"2026-04-14T10:47:21.630106Z","end":"2026-04-14T10:47:21.746277Z","steps":["trace[1821398417] 'read index received' (duration: 115.903332ms)","trace[1821398417] 'applied index is now lower than readState.Index' (duration: 266.965µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:21.746415Z","caller":"traceutil/trace.go:171","msg":"trace[113033855] transaction","detail":"{read_only:false; response_revision:1418; number_of_response:1; }","duration":"241.961699ms","start":"2026-04-14T10:47:21.504412Z","end":"2026-04-14T10:47:21.746374Z","steps":["trace[113033855] 'process raft request' (duration: 241.689204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:21.746551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.413508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-14T10:47:21.746588Z","caller":"traceutil/trace.go:171","msg":"trace[1852911663] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1418; }","duration":"113.478349ms","start":"2026-04-14T10:47:21.633099Z","end":"2026-04-14T10:47:21.746577Z","steps":["trace[1852911663] 'agreement among raft nodes before linearized reading' (duration: 113.392058ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:21.74663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.242435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-14T10:47:21.746693Z","caller":"traceutil/trace.go:171","msg":"trace[1469107166] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1418; }","duration":"113.343357ms","start":"2026-04-14T10:47:21.633334Z","end":"2026-04-14T10:47:21.746678Z","steps":["trace[1469107166] 'agreement among raft nodes before linearized reading' (duration: 113.142563ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:21.746878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.362561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:1059"} {"level":"info","ts":"2026-04-14T10:47:21.746907Z","caller":"traceutil/trace.go:171","msg":"trace[1708332059] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:1418; }","duration":"116.86706ms","start":"2026-04-14T10:47:21.630029Z","end":"2026-04-14T10:47:21.746896Z","steps":["trace[1708332059] 'agreement among raft nodes before linearized reading' (duration: 116.351311ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:21.747058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.840122ms","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-04-14T10:47:21.747089Z","caller":"traceutil/trace.go:171","msg":"trace[1894305954] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1418; }","duration":"116.011464ms","start":"2026-04-14T10:47:21.63107Z","end":"2026-04-14T10:47:21.747081Z","steps":["trace[1894305954] 'agreement among raft nodes before linearized reading' (duration: 115.369833ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:21.921584Z","caller":"traceutil/trace.go:171","msg":"trace[2132929592] transaction","detail":"{read_only:false; response_revision:1421; number_of_response:1; }","duration":"149.006538ms","start":"2026-04-14T10:47:21.772559Z","end":"2026-04-14T10:47:21.921566Z","steps":["trace[2132929592] 'process raft request' (duration: 148.795505ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:21.921698Z","caller":"traceutil/trace.go:171","msg":"trace[1471438735] transaction","detail":"{read_only:false; response_revision:1420; number_of_response:1; }","duration":"170.745129ms","start":"2026-04-14T10:47:21.750918Z","end":"2026-04-14T10:47:21.921663Z","steps":["trace[1471438735] 'process raft request' (duration: 89.286025ms)","trace[1471438735] 'compare' (duration: 81.051377ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:23.652495Z","caller":"traceutil/trace.go:171","msg":"trace[817236127] linearizableReadLoop","detail":"{readStateIndex:1488; appliedIndex:1487; }","duration":"131.406137ms","start":"2026-04-14T10:47:23.521068Z","end":"2026-04-14T10:47:23.652474Z","steps":["trace[817236127] 'read index received' (duration: 39.121539ms)","trace[817236127] 'applied index is now lower than readState.Index' (duration: 92.283188ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:47:23.652786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.694282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/kube-node-lease/\" range_end:\"/registry/persistentvolumeclaims/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:47:23.652859Z","caller":"traceutil/trace.go:171","msg":"trace[326229107] range","detail":"{range_begin:/registry/persistentvolumeclaims/kube-node-lease/; range_end:/registry/persistentvolumeclaims/kube-node-lease0; response_count:0; response_revision:1424; }","duration":"131.801645ms","start":"2026-04-14T10:47:23.521039Z","end":"2026-04-14T10:47:23.652841Z","steps":["trace[326229107] 'agreement among raft nodes before linearized reading' (duration: 131.664902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:23.652885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.890069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:1 size:1914"} {"level":"info","ts":"2026-04-14T10:47:23.652917Z","caller":"traceutil/trace.go:171","msg":"trace[1300353833] range","detail":"{range_begin:/registry/services/specs/envoy-gateway-system/envoy-gateway; range_end:; response_count:1; response_revision:1424; }","duration":"120.949081ms","start":"2026-04-14T10:47:23.531961Z","end":"2026-04-14T10:47:23.65291Z","steps":["trace[1300353833] 'agreement among raft nodes before linearized reading' (duration: 120.822739ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:23.94059Z","caller":"traceutil/trace.go:171","msg":"trace[609364205] transaction","detail":"{read_only:false; response_revision:1426; number_of_response:1; }","duration":"154.805026ms","start":"2026-04-14T10:47:23.78576Z","end":"2026-04-14T10:47:23.940565Z","steps":["trace[609364205] 'process raft request' (duration: 147.719139ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:32.769073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.691687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T10:47:32.769073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.329986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:1 size:205"} {"level":"info","ts":"2026-04-14T10:47:32.769141Z","caller":"traceutil/trace.go:171","msg":"trace[744081538] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1456; }","duration":"127.813918ms","start":"2026-04-14T10:47:32.641315Z","end":"2026-04-14T10:47:32.769129Z","steps":["trace[744081538] 'count revisions from in-memory index tree' (duration: 127.619265ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:32.769162Z","caller":"traceutil/trace.go:171","msg":"trace[583047197] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:1; response_revision:1456; }","duration":"109.457519ms","start":"2026-04-14T10:47:32.659684Z","end":"2026-04-14T10:47:32.769141Z","steps":["trace[583047197] 'range keys from in-memory index tree' (duration: 109.227094ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:32.769263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.626965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:47:32.769563Z","caller":"traceutil/trace.go:171","msg":"trace[1158568733] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1456; }","duration":"128.234435ms","start":"2026-04-14T10:47:32.641295Z","end":"2026-04-14T10:47:32.769529Z","steps":["trace[1158568733] 'count revisions from in-memory index tree' (duration: 127.508933ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:38.740231Z","caller":"traceutil/trace.go:171","msg":"trace[1055270836] linearizableReadLoop","detail":"{readStateIndex:1543; appliedIndex:1542; }","duration":"163.404077ms","start":"2026-04-14T10:47:38.576798Z","end":"2026-04-14T10:47:38.740202Z","steps":["trace[1055270836] 'read index received' (duration: 163.160433ms)","trace[1055270836] 'applied index is now lower than readState.Index' (duration: 242.504µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:38.74031Z","caller":"traceutil/trace.go:171","msg":"trace[1799437194] transaction","detail":"{read_only:false; response_revision:1476; number_of_response:1; }","duration":"165.767318ms","start":"2026-04-14T10:47:38.574509Z","end":"2026-04-14T10:47:38.740277Z","steps":["trace[1799437194] 'process raft request' (duration: 165.528164ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:38.740527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.719163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-c5gkf\" ","response":"range_response_count:1 size:18521"} {"level":"info","ts":"2026-04-14T10:47:38.740583Z","caller":"traceutil/trace.go:171","msg":"trace[130555736] range","detail":"{range_begin:/registry/pods/kube-system/cilium-c5gkf; range_end:; response_count:1; response_revision:1476; }","duration":"163.826034ms","start":"2026-04-14T10:47:38.576741Z","end":"2026-04-14T10:47:38.740567Z","steps":["trace[130555736] 'agreement among raft nodes before linearized reading' (duration: 163.58027ms)"],"step_count":1}