{"level":"warn","ts":"2026-05-26T05:49:46.178292Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T05:49:46.178408Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.235:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.235:2380","--initial-cluster=instance=https://199.204.45.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.235: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-05-26T05:49:46.178494Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T05:49:46.178507Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-05-26T05:49:46.178528Z","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-05-26T05:49:46.179207Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"]} {"level":"info","ts":"2026-05-26T05:49:46.180148Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.235: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-05-26T05:49:46.184631Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.090659ms"} {"level":"info","ts":"2026-05-26T05:49:46.191584Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"aab6040abcf11","cluster-id":"2bae7d3d8857c059"} {"level":"info","ts":"2026-05-26T05:49:46.191664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=()"} {"level":"info","ts":"2026-05-26T05:49:46.191687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 0"} {"level":"info","ts":"2026-05-26T05:49:46.191706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft aab6040abcf11 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-26T05:49:46.191719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 1"} {"level":"info","ts":"2026-05-26T05:49:46.19176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"warn","ts":"2026-05-26T05:49:46.199021Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-26T05:49:46.20477Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-26T05:49:46.206267Z","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-05-26T05:49:46.208252Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"aab6040abcf11","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-26T05:49:46.20854Z","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-05-26T05:49:46.208633Z","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-05-26T05:49:46.208649Z","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-05-26T05:49:46.208582Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"aab6040abcf11","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-26T05:49:46.209296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"info","ts":"2026-05-26T05:49:46.209427Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","added-peer-id":"aab6040abcf11","added-peer-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-05-26T05:49:46.211586Z","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-05-26T05:49:46.211777Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-05-26T05:49:46.21192Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-05-26T05:49:46.212809Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"aab6040abcf11","initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-26T05:49:46.212862Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-26T05:49:46.693855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 is starting a new election at term 1"} {"level":"info","ts":"2026-05-26T05:49:46.694439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-26T05:49:46.695043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgPreVoteResp from aab6040abcf11 at term 1"} {"level":"info","ts":"2026-05-26T05:49:46.695091Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became candidate at term 2"} {"level":"info","ts":"2026-05-26T05:49:46.695114Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgVoteResp from aab6040abcf11 at term 2"} {"level":"info","ts":"2026-05-26T05:49:46.69522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became leader at term 2"} {"level":"info","ts":"2026-05-26T05:49:46.695237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: aab6040abcf11 elected leader aab6040abcf11 at term 2"} {"level":"info","ts":"2026-05-26T05:49:46.696887Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:49:46.698062Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"aab6040abcf11","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.235:2379]}","request-path":"/0/members/aab6040abcf11/attributes","cluster-id":"2bae7d3d8857c059","publish-timeout":"7s"} {"level":"info","ts":"2026-05-26T05:49:46.698093Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T05:49:46.698112Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T05:49:46.698146Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:49:46.698359Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:49:46.698401Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:49:46.701969Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-26T05:49:46.702191Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.235:2379"} {"level":"info","ts":"2026-05-26T05:49:46.706784Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-26T05:49:46.706844Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-26T05:49:48.458965Z","caller":"traceutil/trace.go:171","msg":"trace[720816813] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"491.76148ms","start":"2026-05-26T05:49:47.967179Z","end":"2026-05-26T05:49:48.458941Z","steps":["trace[720816813] 'read index received' (duration: 491.546375ms)","trace[720816813] 'applied index is now lower than readState.Index' (duration: 214.045µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:49:48.458997Z","caller":"traceutil/trace.go:171","msg":"trace[1490194538] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"491.958744ms","start":"2026-05-26T05:49:47.967001Z","end":"2026-05-26T05:49:48.45896Z","steps":["trace[1490194538] 'process raft request' (duration: 491.674068ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:48.459176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.974855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T05:49:48.459313Z","caller":"traceutil/trace.go:171","msg":"trace[1080780520] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:2; }","duration":"492.127489ms","start":"2026-05-26T05:49:47.967174Z","end":"2026-05-26T05:49:48.459301Z","steps":["trace[1080780520] 'agreement among raft nodes before linearized reading' (duration: 491.892933ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:48.459499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:47.966992Z","time spent":"492.083207ms","remote":"127.0.0.1:54908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":35,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:49:48.459451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:47.967162Z","time spent":"492.276172ms","remote":"127.0.0.1:55194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":25,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-05-26T05:49:48.918553Z","caller":"traceutil/trace.go:171","msg":"trace[25971987] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"951.295921ms","start":"2026-05-26T05:49:47.967217Z","end":"2026-05-26T05:49:48.918513Z","steps":["trace[25971987] 'process raft request' (duration: 926.149174ms)","trace[25971987] 'compare' (duration: 24.804889ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:49:48.91875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:47.96721Z","time spent":"951.437824ms","remote":"127.0.0.1:54892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":35,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:49:48.918838Z","caller":"traceutil/trace.go:171","msg":"trace[1661936369] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:5; }","duration":"459.745887ms","start":"2026-05-26T05:49:48.459041Z","end":"2026-05-26T05:49:48.918786Z","steps":["trace[1661936369] 'read index received' (duration: 434.269211ms)","trace[1661936369] 'applied index is now lower than readState.Index' (duration: 25.475716ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:49:48.919268Z","caller":"traceutil/trace.go:171","msg":"trace[453940246] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"871.537055ms","start":"2026-05-26T05:49:48.047713Z","end":"2026-05-26T05:49:48.91925Z","steps":["trace[453940246] 'process raft request' (duration: 870.724745ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:48.919324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.047675Z","time spent":"871.623256ms","remote":"127.0.0.1:55238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":35,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T05:49:48.919347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"870.152971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-26T05:49:48.919345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"897.219725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T05:49:48.919405Z","caller":"traceutil/trace.go:171","msg":"trace[1465871594] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"897.346898ms","start":"2026-05-26T05:49:48.022044Z","end":"2026-05-26T05:49:48.919391Z","steps":["trace[1465871594] 'agreement among raft nodes before linearized reading' (duration: 897.247446ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:49:48.919421Z","caller":"traceutil/trace.go:171","msg":"trace[190341253] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"870.341175ms","start":"2026-05-26T05:49:48.049042Z","end":"2026-05-26T05:49:48.919383Z","steps":["trace[190341253] 'agreement among raft nodes before linearized reading' (duration: 870.100979ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:49:48.919401Z","caller":"traceutil/trace.go:171","msg":"trace[579712972] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"871.319169ms","start":"2026-05-26T05:49:48.048024Z","end":"2026-05-26T05:49:48.919343Z","steps":["trace[579712972] 'process raft request' (duration: 870.591072ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:48.919445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.022004Z","time spent":"897.43226ms","remote":"127.0.0.1:54962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":25,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-26T05:49:48.919462Z","caller":"traceutil/trace.go:171","msg":"trace[1134493614] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"870.578691ms","start":"2026-05-26T05:49:48.048857Z","end":"2026-05-26T05:49:48.919436Z","steps":["trace[1134493614] 'process raft request' (duration: 869.802993ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:48.919457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.04903Z","time spent":"870.416968ms","remote":"127.0.0.1:54940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":25,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-05-26T05:49:48.919512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.048839Z","time spent":"870.651763ms","remote":"127.0.0.1:55312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":35,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T05:49:48.919461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"897.373899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T05:49:48.919564Z","caller":"traceutil/trace.go:171","msg":"trace[1873508765] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"897.574553ms","start":"2026-05-26T05:49:48.021971Z","end":"2026-05-26T05:49:48.919545Z","steps":["trace[1873508765] 'agreement among raft nodes before linearized reading' (duration: 897.340277ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:48.919582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.048Z","time spent":"871.489344ms","remote":"127.0.0.1:55312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":35,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T05:49:48.919615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.021946Z","time spent":"897.657165ms","remote":"127.0.0.1:54962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":25,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-26T05:49:48.919715Z","caller":"traceutil/trace.go:171","msg":"trace[914675860] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"860.961569ms","start":"2026-05-26T05:49:48.058741Z","end":"2026-05-26T05:49:48.919703Z","steps":["trace[914675860] 'process raft request' (duration: 859.949384ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:49:48.919745Z","caller":"traceutil/trace.go:171","msg":"trace[1602475608] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"852.69777ms","start":"2026-05-26T05:49:48.067036Z","end":"2026-05-26T05:49:48.919734Z","steps":["trace[1602475608] 'process raft request' (duration: 851.714386ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:48.919814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.067021Z","time spent":"852.74981ms","remote":"127.0.0.1:55064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":35,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T05:49:48.91997Z","caller":"traceutil/trace.go:171","msg":"trace[1006633977] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"872.013676ms","start":"2026-05-26T05:49:48.047938Z","end":"2026-05-26T05:49:48.919952Z","steps":["trace[1006633977] 'process raft request' (duration: 870.566801ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:48.919986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"872.133938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-26T05:49:48.919973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.058732Z","time spent":"861.01207ms","remote":"127.0.0.1:55006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":35,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T05:49:48.920012Z","caller":"traceutil/trace.go:171","msg":"trace[206802004] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"872.002006ms","start":"2026-05-26T05:49:48.047997Z","end":"2026-05-26T05:49:48.919999Z","steps":["trace[206802004] 'process raft request' (duration: 870.539401ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:49:48.920017Z","caller":"traceutil/trace.go:171","msg":"trace[628995043] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"872.19257ms","start":"2026-05-26T05:49:48.047815Z","end":"2026-05-26T05:49:48.920007Z","steps":["trace[628995043] 'agreement among raft nodes before linearized reading' (duration: 872.148489ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:48.920039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.047916Z","time spent":"872.084138ms","remote":"127.0.0.1:55312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":35,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T05:49:48.920059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.047788Z","time spent":"872.265482ms","remote":"127.0.0.1:54962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":25,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-26T05:49:48.920075Z","caller":"traceutil/trace.go:171","msg":"trace[60441037] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"872.026366ms","start":"2026-05-26T05:49:48.048035Z","end":"2026-05-26T05:49:48.920062Z","steps":["trace[60441037] 'process raft request' (duration: 870.552031ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:48.920097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.047983Z","time spent":"872.059217ms","remote":"127.0.0.1:55312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":35,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T05:49:48.920134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.048027Z","time spent":"872.079387ms","remote":"127.0.0.1:55312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":35,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T05:49:48.920208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"819.99613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-26T05:49:48.920261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"872.439006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.235\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T05:49:48.920265Z","caller":"traceutil/trace.go:171","msg":"trace[362726968] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"820.091222ms","start":"2026-05-26T05:49:48.10014Z","end":"2026-05-26T05:49:48.920232Z","steps":["trace[362726968] 'agreement among raft nodes before linearized reading' (duration: 820.039ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:49:48.920291Z","caller":"traceutil/trace.go:171","msg":"trace[168108410] range","detail":"{range_begin:/registry/masterleases/199.204.45.235; range_end:; response_count:0; response_revision:11; }","duration":"872.492768ms","start":"2026-05-26T05:49:48.04779Z","end":"2026-05-26T05:49:48.920283Z","steps":["trace[168108410] 'agreement among raft nodes before linearized reading' (duration: 872.440196ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:48.92032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.047776Z","time spent":"872.538128ms","remote":"127.0.0.1:54866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":25,"request content":"key:\"/registry/masterleases/199.204.45.235\" "} {"level":"warn","ts":"2026-05-26T05:49:48.920318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.100122Z","time spent":"820.188074ms","remote":"127.0.0.1:54962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":25,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-26T05:49:48.920635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.373063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-05-26T05:49:48.920722Z","caller":"traceutil/trace.go:171","msg":"trace[682533165] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"458.493496ms","start":"2026-05-26T05:49:48.462214Z","end":"2026-05-26T05:49:48.920708Z","steps":["trace[682533165] 'agreement among raft nodes before linearized reading' (duration: 458.381403ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:48.920758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.462188Z","time spent":"458.562538ms","remote":"127.0.0.1:55006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3192,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-26T05:49:48.920525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"898.366692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T05:49:48.921267Z","caller":"traceutil/trace.go:171","msg":"trace[1147873636] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"899.156361ms","start":"2026-05-26T05:49:48.022095Z","end":"2026-05-26T05:49:48.921252Z","steps":["trace[1147873636] 'agreement among raft nodes before linearized reading' (duration: 897.136022ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:48.921301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.022067Z","time spent":"899.222923ms","remote":"127.0.0.1:54962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":25,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-26T05:49:49.503622Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920881187772518288,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-26T05:49:49.572735Z","caller":"traceutil/trace.go:171","msg":"trace[1485510878] linearizableReadLoop","detail":"{readStateIndex:24; appliedIndex:15; }","duration":"569.976639ms","start":"2026-05-26T05:49:49.002733Z","end":"2026-05-26T05:49:49.572709Z","steps":["trace[1485510878] 'read index received' (duration: 569.246371ms)","trace[1485510878] 'applied index is now lower than readState.Index' (duration: 729.068µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:49:49.572882Z","caller":"traceutil/trace.go:171","msg":"trace[59893986] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"644.284965ms","start":"2026-05-26T05:49:48.92858Z","end":"2026-05-26T05:49:49.572865Z","steps":["trace[59893986] 'process raft request' (duration: 643.945906ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:49:49.572983Z","caller":"traceutil/trace.go:171","msg":"trace[877037225] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"644.594562ms","start":"2026-05-26T05:49:48.928353Z","end":"2026-05-26T05:49:49.572947Z","steps":["trace[877037225] 'process raft request' (duration: 644.11636ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:49:49.573062Z","caller":"traceutil/trace.go:171","msg":"trace[854857167] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"641.577849ms","start":"2026-05-26T05:49:48.931375Z","end":"2026-05-26T05:49:49.572953Z","steps":["trace[854857167] 'process raft request' (duration: 641.279031ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:49.573095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.92856Z","time spent":"644.356756ms","remote":"127.0.0.1:55312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":35,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T05:49:49.573178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.928347Z","time spent":"644.731985ms","remote":"127.0.0.1:55312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":35,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T05:49:49.573263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.931369Z","time spent":"641.742103ms","remote":"127.0.0.1:55006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3479,"response count":0,"response size":35,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:49:49.573275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.922435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T05:49:49.573392Z","caller":"traceutil/trace.go:171","msg":"trace[288602367] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:20; }","duration":"627.15005ms","start":"2026-05-26T05:49:48.946225Z","end":"2026-05-26T05:49:49.573375Z","steps":["trace[288602367] 'agreement among raft nodes before linearized reading' (duration: 626.7295ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:49.573502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.855517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-26T05:49:49.573525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.946209Z","time spent":"627.296754ms","remote":"127.0.0.1:55166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":25,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-05-26T05:49:49.573604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.650671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T05:49:49.57361Z","caller":"traceutil/trace.go:171","msg":"trace[214134653] transaction","detail":"{read_only:false; number_of_response:0; response_revision:19; }","duration":"644.327095ms","start":"2026-05-26T05:49:48.92927Z","end":"2026-05-26T05:49:49.573597Z","steps":["trace[214134653] 'process raft request' (duration: 643.354742ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:49:49.57363Z","caller":"traceutil/trace.go:171","msg":"trace[384728918] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:20; }","duration":"160.720233ms","start":"2026-05-26T05:49:49.412902Z","end":"2026-05-26T05:49:49.573623Z","steps":["trace[384728918] 'agreement among raft nodes before linearized reading' (duration: 160.680732ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:49.573654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.929259Z","time spent":"644.374116ms","remote":"127.0.0.1:54962","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":25,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T05:49:49.573583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.285276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T05:49:49.573802Z","caller":"traceutil/trace.go:171","msg":"trace[83124887] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:20; }","duration":"565.797068ms","start":"2026-05-26T05:49:49.007917Z","end":"2026-05-26T05:49:49.573714Z","steps":["trace[83124887] 'agreement among raft nodes before linearized reading' (duration: 565.208074ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:49.573953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:49.007897Z","time spent":"565.998433ms","remote":"127.0.0.1:54940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":25,"request content":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" "} {"level":"info","ts":"2026-05-26T05:49:49.574289Z","caller":"traceutil/trace.go:171","msg":"trace[96704000] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"646.090998ms","start":"2026-05-26T05:49:48.928164Z","end":"2026-05-26T05:49:49.574255Z","steps":["trace[96704000] 'process raft request' (duration: 643.603518ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:49:49.572895Z","caller":"traceutil/trace.go:171","msg":"trace[1271271311] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"644.642913ms","start":"2026-05-26T05:49:48.928221Z","end":"2026-05-26T05:49:49.572864Z","steps":["trace[1271271311] 'process raft request' (duration: 644.213192ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:49.574946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.901218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T05:49:49.575024Z","caller":"traceutil/trace.go:171","msg":"trace[268697439] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20; }","duration":"546.008831ms","start":"2026-05-26T05:49:49.029002Z","end":"2026-05-26T05:49:49.575011Z","steps":["trace[268697439] 'agreement among raft nodes before linearized reading' (duration: 545.901888ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:49.575058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:49.028983Z","time spent":"546.066561ms","remote":"127.0.0.1:54832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":25,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-26T05:49:49.57516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.928211Z","time spent":"646.687992ms","remote":"127.0.0.1:55312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":35,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T05:49:49.57347Z","caller":"traceutil/trace.go:171","msg":"trace[869529340] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"644.582891ms","start":"2026-05-26T05:49:48.928876Z","end":"2026-05-26T05:49:49.573459Z","steps":["trace[869529340] 'process raft request' (duration: 643.69904ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:49:49.573555Z","caller":"traceutil/trace.go:171","msg":"trace[1199347741] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:20; }","duration":"444.934369ms","start":"2026-05-26T05:49:49.1286Z","end":"2026-05-26T05:49:49.573534Z","steps":["trace[1199347741] 'agreement among raft nodes before linearized reading' (duration: 444.870807ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:49.57531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.639274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-05-26T05:49:49.575416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:49.128572Z","time spent":"446.824825ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":25,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-05-26T05:49:49.575497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.027012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T05:49:49.575587Z","caller":"traceutil/trace.go:171","msg":"trace[1276715630] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:20; }","duration":"628.240187ms","start":"2026-05-26T05:49:48.947334Z","end":"2026-05-26T05:49:49.575575Z","steps":["trace[1276715630] 'agreement among raft nodes before linearized reading' (duration: 627.976301ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:49.575668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.947322Z","time spent":"628.334759ms","remote":"127.0.0.1:55184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":25,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-05-26T05:49:49.575389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.928852Z","time spent":"646.482177ms","remote":"127.0.0.1:55194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":35,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T05:49:49.57333Z","caller":"traceutil/trace.go:171","msg":"trace[762505460] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"644.071799ms","start":"2026-05-26T05:49:48.92925Z","end":"2026-05-26T05:49:49.573321Z","steps":["trace[762505460] 'process raft request' (duration: 643.355591ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:49.577053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.929237Z","time spent":"647.795229ms","remote":"127.0.0.1:55312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":35,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T05:49:49.575503Z","caller":"traceutil/trace.go:171","msg":"trace[1002724804] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"589.858829ms","start":"2026-05-26T05:49:48.98563Z","end":"2026-05-26T05:49:49.575488Z","steps":["trace[1002724804] 'agreement among raft nodes before linearized reading' (duration: 589.618143ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:49.577314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.985614Z","time spent":"591.615272ms","remote":"127.0.0.1:54962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":371,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-26T05:49:49.575786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.928148Z","time spent":"646.387445ms","remote":"127.0.0.1:55238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":35,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T05:49:49.575747Z","caller":"traceutil/trace.go:171","msg":"trace[1729539990] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"647.227895ms","start":"2026-05-26T05:49:48.92844Z","end":"2026-05-26T05:49:49.575668Z","steps":["trace[1729539990] 'process raft request' (duration: 644.052869ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:49.577889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:48.928435Z","time spent":"649.433139ms","remote":"127.0.0.1:55312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":35,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T05:50:23.533205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.256879ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:50:23.533678Z","caller":"traceutil/trace.go:171","msg":"trace[56970509] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"388.411432ms","start":"2026-05-26T05:50:23.14526Z","end":"2026-05-26T05:50:23.533671Z","steps":["trace[56970509] 'process raft request' (duration: 388.075104ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:50:23.533667Z","caller":"traceutil/trace.go:171","msg":"trace[808446641] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"386.383753ms","start":"2026-05-26T05:50:23.147251Z","end":"2026-05-26T05:50:23.533634Z","steps":["trace[808446641] 'process raft request' (duration: 386.115277ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:50:23.533731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:50:23.145247Z","time spent":"388.464113ms","remote":"127.0.0.1:55312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T05:50:23.533517Z","caller":"traceutil/trace.go:171","msg":"trace[1718133657] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"379.038805ms","start":"2026-05-26T05:50:23.154465Z","end":"2026-05-26T05:50:23.533504Z","steps":["trace[1718133657] 'process raft request' (duration: 378.997944ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:50:23.534108Z","caller":"traceutil/trace.go:171","msg":"trace[1111231625] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"407.012683ms","start":"2026-05-26T05:50:23.127066Z","end":"2026-05-26T05:50:23.534079Z","steps":["trace[1111231625] 'process raft request' (duration: 57.287818ms)","trace[1111231625] 'compare' (duration: 348.085765ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:50:23.534243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:50:23.127053Z","time spent":"407.148576ms","remote":"127.0.0.1:54882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T05:50:23.534141Z","caller":"traceutil/trace.go:171","msg":"trace[1374917426] transaction","detail":"{read_only:false; number_of_response:1; response_revision:540; }","duration":"383.833901ms","start":"2026-05-26T05:50:23.150293Z","end":"2026-05-26T05:50:23.534127Z","steps":["trace[1374917426] 'process raft request' (duration: 383.102783ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:50:23.53464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:50:23.150278Z","time spent":"384.262352ms","remote":"127.0.0.1:54882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6935,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:50:23.53409Z","caller":"traceutil/trace.go:171","msg":"trace[1650555821] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"390.550754ms","start":"2026-05-26T05:50:23.143514Z","end":"2026-05-26T05:50:23.534065Z","steps":["trace[1650555821] 'process raft request' (duration: 389.772805ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:50:23.53503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:50:23.143497Z","time spent":"391.385654ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:50:23.534162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:50:23.154456Z","time spent":"379.68672ms","remote":"127.0.0.1:54882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T05:50:23.534063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:50:23.147236Z","time spent":"386.504396ms","remote":"127.0.0.1:54882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:50:23.538498Z","caller":"traceutil/trace.go:171","msg":"trace[2015813343] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"342.004267ms","start":"2026-05-26T05:50:23.196472Z","end":"2026-05-26T05:50:23.538476Z","steps":["trace[2015813343] 'process raft request' (duration: 341.811293ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:50:23.538564Z","caller":"traceutil/trace.go:171","msg":"trace[1776273888] linearizableReadLoop","detail":"{readStateIndex:566; appliedIndex:551; }","duration":"137.43477ms","start":"2026-05-26T05:50:23.401108Z","end":"2026-05-26T05:50:23.538543Z","steps":["trace[1776273888] 'read index received' (duration: 132.031529ms)","trace[1776273888] 'applied index is now lower than readState.Index' (duration: 5.402491ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:50:23.538592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:50:23.196453Z","time spent":"342.09329ms","remote":"127.0.0.1:54882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:50:23.538711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.595853ms","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-05-26T05:50:23.538801Z","caller":"traceutil/trace.go:171","msg":"trace[2048717532] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:550; }","duration":"137.744518ms","start":"2026-05-26T05:50:23.401049Z","end":"2026-05-26T05:50:23.538793Z","steps":["trace[2048717532] 'agreement among raft nodes before linearized reading' (duration: 137.557933ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:50:23.538889Z","caller":"traceutil/trace.go:171","msg":"trace[1582257252] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"336.099714ms","start":"2026-05-26T05:50:23.202778Z","end":"2026-05-26T05:50:23.538877Z","steps":["trace[1582257252] 'process raft request' (duration: 335.589462ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:50:23.538973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:50:23.20277Z","time spent":"336.168456ms","remote":"127.0.0.1:54882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:50:23.539037Z","caller":"traceutil/trace.go:171","msg":"trace[1080733214] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"336.157606ms","start":"2026-05-26T05:50:23.20287Z","end":"2026-05-26T05:50:23.539028Z","steps":["trace[1080733214] 'process raft request' (duration: 335.538351ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:50:23.539064Z","caller":"traceutil/trace.go:171","msg":"trace[408447505] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"336.660237ms","start":"2026-05-26T05:50:23.202399Z","end":"2026-05-26T05:50:23.539059Z","steps":["trace[408447505] 'process raft request' (duration: 335.93921ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:50:23.539115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:50:23.202852Z","time spent":"336.211147ms","remote":"127.0.0.1:54882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:50:23.539126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:50:23.202379Z","time spent":"336.72621ms","remote":"127.0.0.1:55312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T05:50:23.539237Z","caller":"traceutil/trace.go:171","msg":"trace[290742383] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"333.327878ms","start":"2026-05-26T05:50:23.205901Z","end":"2026-05-26T05:50:23.539229Z","steps":["trace[290742383] 'process raft request' (duration: 332.549249ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:50:23.539297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:50:23.205886Z","time spent":"333.387109ms","remote":"127.0.0.1:54882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:50:23.539042Z","caller":"traceutil/trace.go:171","msg":"trace[1187329680] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"336.697739ms","start":"2026-05-26T05:50:23.202337Z","end":"2026-05-26T05:50:23.539035Z","steps":["trace[1187329680] 'process raft request' (duration: 335.982872ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:50:23.539452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:50:23.202323Z","time spent":"337.090438ms","remote":"127.0.0.1:55312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T05:50:23.538813Z","caller":"traceutil/trace.go:171","msg":"trace[406929352] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"348.72324ms","start":"2026-05-26T05:50:23.190072Z","end":"2026-05-26T05:50:23.538795Z","steps":["trace[406929352] 'process raft request' (duration: 348.095605ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:50:23.539776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:50:23.190056Z","time spent":"349.698724ms","remote":"127.0.0.1:55312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T05:50:23.539864Z","caller":"traceutil/trace.go:171","msg":"trace[910294176] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"267.101633ms","start":"2026-05-26T05:50:23.272749Z","end":"2026-05-26T05:50:23.539851Z","steps":["trace[910294176] 'process raft request' (duration: 265.75136ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:50:23.538856Z","caller":"traceutil/trace.go:171","msg":"trace[1610730319] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"345.174164ms","start":"2026-05-26T05:50:23.193671Z","end":"2026-05-26T05:50:23.538845Z","steps":["trace[1610730319] 'process raft request' (duration: 344.57816ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:50:23.539976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:50:23.19365Z","time spent":"346.287902ms","remote":"127.0.0.1:55312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T05:50:32.042119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.358079ms","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-05-26T05:50:32.042234Z","caller":"traceutil/trace.go:171","msg":"trace[1988197396] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:649; }","duration":"208.490243ms","start":"2026-05-26T05:50:31.833716Z","end":"2026-05-26T05:50:32.042206Z","steps":["trace[1988197396] 'range keys from in-memory index tree' (duration: 208.142894ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:50:32.943951Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920881187772519569,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T05:50:33.223146Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.079696333s","expected-duration":"1s"} {"level":"info","ts":"2026-05-26T05:50:33.246072Z","caller":"traceutil/trace.go:171","msg":"trace[30326469] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:671; }","duration":"802.292371ms","start":"2026-05-26T05:50:32.443749Z","end":"2026-05-26T05:50:33.246042Z","steps":["trace[30326469] 'read index received' (duration: 779.595041ms)","trace[30326469] 'applied index is now lower than readState.Index' (duration: 22.69618ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:50:33.246167Z","caller":"traceutil/trace.go:171","msg":"trace[37105341] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"1.102779432s","start":"2026-05-26T05:50:32.143352Z","end":"2026-05-26T05:50:33.246131Z","steps":["trace[37105341] 'process raft request' (duration: 1.080075162s)","trace[37105341] 'compare' (duration: 22.055595ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:50:33.246299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"802.528557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T05:50:33.246338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:50:32.143328Z","time spent":"1.102919916s","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:50:33.246359Z","caller":"traceutil/trace.go:171","msg":"trace[126666835] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:651; }","duration":"802.627999ms","start":"2026-05-26T05:50:32.443716Z","end":"2026-05-26T05:50:33.246344Z","steps":["trace[126666835] 'agreement among raft nodes before linearized reading' (duration: 802.521547ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:50:33.246391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.86498ms","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-05-26T05:50:33.246397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:50:32.443701Z","time spent":"802.688831ms","remote":"127.0.0.1:54832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-26T05:50:33.246425Z","caller":"traceutil/trace.go:171","msg":"trace[890523541] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:651; }","duration":"581.940802ms","start":"2026-05-26T05:50:32.664473Z","end":"2026-05-26T05:50:33.246414Z","steps":["trace[890523541] 'agreement among raft nodes before linearized reading' (duration: 581.797469ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:50:33.246454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:50:32.664457Z","time spent":"581.990453ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-26T05:50:34.84102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.20323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:50:34.841108Z","caller":"traceutil/trace.go:171","msg":"trace[1847280915] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:686; }","duration":"169.359114ms","start":"2026-05-26T05:50:34.671728Z","end":"2026-05-26T05:50:34.841088Z","steps":["trace[1847280915] 'range keys from in-memory index tree' (duration: 169.100927ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:50:34.841023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.693635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:50:34.84132Z","caller":"traceutil/trace.go:171","msg":"trace[1536753600] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:686; }","duration":"198.93272ms","start":"2026-05-26T05:50:34.642248Z","end":"2026-05-26T05:50:34.841181Z","steps":["trace[1536753600] 'range keys from in-memory index tree' (duration: 198.551061ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:50:45.562965Z","caller":"traceutil/trace.go:171","msg":"trace[1706618559] linearizableReadLoop","detail":"{readStateIndex:816; appliedIndex:815; }","duration":"173.350241ms","start":"2026-05-26T05:50:45.389595Z","end":"2026-05-26T05:50:45.562945Z","steps":["trace[1706618559] 'read index received' (duration: 173.192647ms)","trace[1706618559] 'applied index is now lower than readState.Index' (duration: 156.764µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:50:45.563024Z","caller":"traceutil/trace.go:171","msg":"trace[1248319349] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"176.740463ms","start":"2026-05-26T05:50:45.386257Z","end":"2026-05-26T05:50:45.562997Z","steps":["trace[1248319349] 'process raft request' (duration: 176.585019ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:50:45.563179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.546445ms","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-05-26T05:50:45.563234Z","caller":"traceutil/trace.go:171","msg":"trace[1764956845] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:792; }","duration":"173.645188ms","start":"2026-05-26T05:50:45.389576Z","end":"2026-05-26T05:50:45.563221Z","steps":["trace[1764956845] 'agreement among raft nodes before linearized reading' (duration: 173.463444ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:50:45.715474Z","caller":"traceutil/trace.go:171","msg":"trace[765236676] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"148.015617ms","start":"2026-05-26T05:50:45.567428Z","end":"2026-05-26T05:50:45.715443Z","steps":["trace[765236676] 'process raft request' (duration: 104.978184ms)","trace[765236676] 'compare' (duration: 42.91436ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:50:46.163741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.365312ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:50:46.164037Z","caller":"traceutil/trace.go:171","msg":"trace[2019816442] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"427.063459ms","start":"2026-05-26T05:50:45.736937Z","end":"2026-05-26T05:50:46.164Z","steps":["trace[2019816442] 'process raft request' (duration: 137.354848ms)","trace[2019816442] 'compare' (duration: 289.25949ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:50:46.164223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:50:45.736917Z","time spent":"427.208822ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:50:48.779348Z","caller":"traceutil/trace.go:171","msg":"trace[1354982347] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"221.832715ms","start":"2026-05-26T05:50:48.55749Z","end":"2026-05-26T05:50:48.779323Z","steps":["trace[1354982347] 'process raft request' (duration: 124.377373ms)","trace[1354982347] 'compare' (duration: 97.300478ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:50:50.35818Z","caller":"traceutil/trace.go:171","msg":"trace[580089428] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"152.179058ms","start":"2026-05-26T05:50:50.205965Z","end":"2026-05-26T05:50:50.358144Z","steps":["trace[580089428] 'process raft request' (duration: 151.924672ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:50:50.553467Z","caller":"traceutil/trace.go:171","msg":"trace[1882476798] linearizableReadLoop","detail":"{readStateIndex:839; appliedIndex:838; }","duration":"118.86449ms","start":"2026-05-26T05:50:50.43458Z","end":"2026-05-26T05:50:50.553444Z","steps":["trace[1882476798] 'read index received' (duration: 118.720317ms)","trace[1882476798] 'applied index is now lower than readState.Index' (duration: 143.303µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:50:50.553577Z","caller":"traceutil/trace.go:171","msg":"trace[1568184150] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"190.921506ms","start":"2026-05-26T05:50:50.362646Z","end":"2026-05-26T05:50:50.553568Z","steps":["trace[1568184150] 'process raft request' (duration: 190.67033ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:50:50.553859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.366765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:50:50.553955Z","caller":"traceutil/trace.go:171","msg":"trace[71283942] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:814; }","duration":"110.486697ms","start":"2026-05-26T05:50:50.443454Z","end":"2026-05-26T05:50:50.553941Z","steps":["trace[71283942] 'agreement among raft nodes before linearized reading' (duration: 110.357844ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:50:50.554122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.536076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.235\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-26T05:50:50.554164Z","caller":"traceutil/trace.go:171","msg":"trace[113995774] range","detail":"{range_begin:/registry/masterleases/199.204.45.235; range_end:; response_count:1; response_revision:814; }","duration":"119.622108ms","start":"2026-05-26T05:50:50.434528Z","end":"2026-05-26T05:50:50.554151Z","steps":["trace[113995774] 'agreement among raft nodes before linearized reading' (duration: 119.483185ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:50:54.207737Z","caller":"traceutil/trace.go:171","msg":"trace[192356459] transaction","detail":"{read_only:false; response_revision:860; number_of_response:1; }","duration":"108.649723ms","start":"2026-05-26T05:50:54.099055Z","end":"2026-05-26T05:50:54.207705Z","steps":["trace[192356459] 'process raft request' (duration: 107.056804ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:50:54.208114Z","caller":"traceutil/trace.go:171","msg":"trace[1202954807] transaction","detail":"{read_only:false; response_revision:861; number_of_response:1; }","duration":"102.36567ms","start":"2026-05-26T05:50:54.105724Z","end":"2026-05-26T05:50:54.20809Z","steps":["trace[1202954807] 'process raft request' (duration: 101.913759ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:50:57.231616Z","caller":"traceutil/trace.go:171","msg":"trace[223668287] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"110.935438ms","start":"2026-05-26T05:50:57.120655Z","end":"2026-05-26T05:50:57.231591Z","steps":["trace[223668287] 'process raft request' (duration: 110.750914ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:50:57.231865Z","caller":"traceutil/trace.go:171","msg":"trace[1351003416] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"109.310719ms","start":"2026-05-26T05:50:57.122523Z","end":"2026-05-26T05:50:57.231834Z","steps":["trace[1351003416] 'process raft request' (duration: 109.015152ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:24.742394Z","caller":"traceutil/trace.go:171","msg":"trace[708252754] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"226.417041ms","start":"2026-05-26T05:51:24.515958Z","end":"2026-05-26T05:51:24.742375Z","steps":["trace[708252754] 'process raft request' (duration: 226.302488ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:25.85817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.628658ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:51:25.858278Z","caller":"traceutil/trace.go:171","msg":"trace[118198589] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"1.08996492s","start":"2026-05-26T05:51:24.768294Z","end":"2026-05-26T05:51:25.858259Z","steps":["trace[118198589] 'process raft request' (duration: 279.172608ms)","trace[118198589] 'compare' (duration: 810.239029ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:51:25.858415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:51:24.768283Z","time spent":"1.090025352s","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:51:26.194385Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.115737119s","expected-duration":"1s"} {"level":"info","ts":"2026-05-26T05:51:26.198102Z","caller":"traceutil/trace.go:171","msg":"trace[365670380] linearizableReadLoop","detail":"{readStateIndex:1062; appliedIndex:1060; }","duration":"1.277642028s","start":"2026-05-26T05:51:24.920438Z","end":"2026-05-26T05:51:26.19808Z","steps":["trace[365670380] 'read index received' (duration: 127.026018ms)","trace[365670380] 'applied index is now lower than readState.Index' (duration: 1.15061519s)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:51:26.198137Z","caller":"traceutil/trace.go:171","msg":"trace[1989013120] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"1.262024706s","start":"2026-05-26T05:51:24.936084Z","end":"2026-05-26T05:51:26.198108Z","steps":["trace[1989013120] 'process raft request' (duration: 1.261906353s)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:26.198196Z","caller":"traceutil/trace.go:171","msg":"trace[617644904] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"1.389117976s","start":"2026-05-26T05:51:24.809058Z","end":"2026-05-26T05:51:26.198176Z","steps":["trace[617644904] 'process raft request' (duration: 1.385541149s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:26.19829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:51:24.809033Z","time spent":"1.389202737s","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:51:26.198309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:51:24.936055Z","time spent":"1.262139309s","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:51:26.198304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.277848202s","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-05-26T05:51:26.19905Z","caller":"traceutil/trace.go:171","msg":"trace[207743021] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1029; }","duration":"1.278622031s","start":"2026-05-26T05:51:24.920408Z","end":"2026-05-26T05:51:26.19903Z","steps":["trace[207743021] 'agreement among raft nodes before linearized reading' (duration: 1.277738979s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:26.199094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:51:24.920393Z","time spent":"1.278691963s","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T05:51:26.199906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.491707ms","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-05-26T05:51:26.199937Z","caller":"traceutil/trace.go:171","msg":"trace[185945471] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1029; }","duration":"163.5903ms","start":"2026-05-26T05:51:26.036339Z","end":"2026-05-26T05:51:26.199929Z","steps":["trace[185945471] 'agreement among raft nodes before linearized reading' (duration: 163.508878ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:26.199888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.313087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-26T05:51:26.199963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.593646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-26T05:51:26.199985Z","caller":"traceutil/trace.go:171","msg":"trace[582480261] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1029; }","duration":"467.473181ms","start":"2026-05-26T05:51:25.732491Z","end":"2026-05-26T05:51:26.199964Z","steps":["trace[582480261] 'agreement among raft nodes before linearized reading' (duration: 467.312747ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:26.200008Z","caller":"traceutil/trace.go:171","msg":"trace[945785266] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1029; }","duration":"331.667798ms","start":"2026-05-26T05:51:25.868328Z","end":"2026-05-26T05:51:26.199996Z","steps":["trace[945785266] 'agreement among raft nodes before linearized reading' (duration: 331.541855ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:26.200037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:51:25.868315Z","time spent":"331.715279ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T05:51:26.200033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:51:25.73246Z","time spent":"467.561343ms","remote":"127.0.0.1:55220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":28,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-05-26T05:51:40.361301Z","caller":"traceutil/trace.go:171","msg":"trace[914512968] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"345.925896ms","start":"2026-05-26T05:51:40.015346Z","end":"2026-05-26T05:51:40.361272Z","steps":["trace[914512968] 'process raft request' (duration: 345.802033ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:40.361477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:51:40.015334Z","time spent":"346.045739ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:51:40.510191Z","caller":"traceutil/trace.go:171","msg":"trace[2143222211] linearizableReadLoop","detail":"{readStateIndex:1112; appliedIndex:1111; }","duration":"117.728701ms","start":"2026-05-26T05:51:40.392445Z","end":"2026-05-26T05:51:40.510174Z","steps":["trace[2143222211] 'read index received' (duration: 117.623269ms)","trace[2143222211] 'applied index is now lower than readState.Index' (duration: 104.762µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:51:40.510242Z","caller":"traceutil/trace.go:171","msg":"trace[1136407355] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"136.690773ms","start":"2026-05-26T05:51:40.373521Z","end":"2026-05-26T05:51:40.510211Z","steps":["trace[1136407355] 'process raft request' (duration: 136.54876ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:40.510384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.924886ms","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-05-26T05:51:40.510416Z","caller":"traceutil/trace.go:171","msg":"trace[1673809929] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1075; }","duration":"118.045849ms","start":"2026-05-26T05:51:40.392362Z","end":"2026-05-26T05:51:40.510407Z","steps":["trace[1673809929] 'agreement among raft nodes before linearized reading' (duration: 117.910176ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:40.510514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.972057ms","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-05-26T05:51:40.510606Z","caller":"traceutil/trace.go:171","msg":"trace[1009779329] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1075; }","duration":"118.09646ms","start":"2026-05-26T05:51:40.3925Z","end":"2026-05-26T05:51:40.510596Z","steps":["trace[1009779329] 'agreement among raft nodes before linearized reading' (duration: 117.808593ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:41.848298Z","caller":"traceutil/trace.go:171","msg":"trace[256069328] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"141.500471ms","start":"2026-05-26T05:51:41.706772Z","end":"2026-05-26T05:51:41.848273Z","steps":["trace[256069328] 'process raft request' (duration: 141.360237ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:48.873435Z","caller":"traceutil/trace.go:171","msg":"trace[1042326109] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"477.967104ms","start":"2026-05-26T05:51:48.395442Z","end":"2026-05-26T05:51:48.873409Z","steps":["trace[1042326109] 'process raft request' (duration: 477.232626ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:48.873781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:51:48.395417Z","time spent":"478.114158ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:51:49.205557Z","caller":"traceutil/trace.go:171","msg":"trace[1518093837] linearizableReadLoop","detail":"{readStateIndex:1140; appliedIndex:1138; }","duration":"790.610968ms","start":"2026-05-26T05:51:48.41492Z","end":"2026-05-26T05:51:49.205531Z","steps":["trace[1518093837] 'read index received' (duration: 457.748271ms)","trace[1518093837] 'applied index is now lower than readState.Index' (duration: 332.861327ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:51:49.205701Z","caller":"traceutil/trace.go:171","msg":"trace[528941957] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"807.88014ms","start":"2026-05-26T05:51:48.397808Z","end":"2026-05-26T05:51:49.205688Z","steps":["trace[528941957] 'process raft request' (duration: 736.709144ms)","trace[528941957] 'compare' (duration: 70.870309ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:51:49.205808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:51:48.397791Z","time spent":"807.944311ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:51:49.205969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.05069ms","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-05-26T05:51:49.206007Z","caller":"traceutil/trace.go:171","msg":"trace[1929658570] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1101; }","duration":"791.120321ms","start":"2026-05-26T05:51:48.414877Z","end":"2026-05-26T05:51:49.205997Z","steps":["trace[1929658570] 'agreement among raft nodes before linearized reading' (duration: 791.057199ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:49.206036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:51:48.41486Z","time spent":"791.169192ms","remote":"127.0.0.1:55026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":3,"response size":28,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-05-26T05:51:49.206399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.313904ms","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-05-26T05:51:49.206435Z","caller":"traceutil/trace.go:171","msg":"trace[1749062348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1101; }","duration":"275.351205ms","start":"2026-05-26T05:51:48.931075Z","end":"2026-05-26T05:51:49.206426Z","steps":["trace[1749062348] 'agreement among raft nodes before linearized reading' (duration: 275.233052ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:49.206453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.127714ms","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":"warn","ts":"2026-05-26T05:51:49.20651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.299518ms","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-05-26T05:51:49.206547Z","caller":"traceutil/trace.go:171","msg":"trace[1468726741] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1101; }","duration":"267.296659ms","start":"2026-05-26T05:51:48.939233Z","end":"2026-05-26T05:51:49.206529Z","steps":["trace[1468726741] 'agreement among raft nodes before linearized reading' (duration: 267.119594ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:49.206554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.048962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-26T05:51:49.206555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.053576ms","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-05-26T05:51:49.206636Z","caller":"traceutil/trace.go:171","msg":"trace[1858111411] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1101; }","duration":"657.148845ms","start":"2026-05-26T05:51:48.549465Z","end":"2026-05-26T05:51:49.206614Z","steps":["trace[1858111411] 'agreement among raft nodes before linearized reading' (duration: 656.834617ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:49.206656Z","caller":"traceutil/trace.go:171","msg":"trace[2106348056] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1101; }","duration":"603.203369ms","start":"2026-05-26T05:51:48.603429Z","end":"2026-05-26T05:51:49.206632Z","steps":["trace[2106348056] 'agreement among raft nodes before linearized reading' (duration: 602.936473ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:49.206695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:51:48.54941Z","time spent":"657.275377ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T05:51:49.206709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:51:48.603402Z","time spent":"603.294822ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-26T05:51:49.206577Z","caller":"traceutil/trace.go:171","msg":"trace[1584900688] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1101; }","duration":"602.409799ms","start":"2026-05-26T05:51:48.604151Z","end":"2026-05-26T05:51:49.20656Z","steps":["trace[1584900688] 'agreement among raft nodes before linearized reading' (duration: 602.176734ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:49.206885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:51:48.604133Z","time spent":"602.735348ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-26T05:51:50.563114Z","caller":"traceutil/trace.go:171","msg":"trace[1808189543] linearizableReadLoop","detail":"{readStateIndex:1145; appliedIndex:1144; }","duration":"118.340596ms","start":"2026-05-26T05:51:50.444744Z","end":"2026-05-26T05:51:50.563085Z","steps":["trace[1808189543] 'read index received' (duration: 118.137621ms)","trace[1808189543] 'applied index is now lower than readState.Index' (duration: 201.515µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:51:50.5633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.546481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:51:50.563529Z","caller":"traceutil/trace.go:171","msg":"trace[881528154] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1105; }","duration":"118.762286ms","start":"2026-05-26T05:51:50.444695Z","end":"2026-05-26T05:51:50.563458Z","steps":["trace[881528154] 'agreement among raft nodes before linearized reading' (duration: 118.49641ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:50.891974Z","caller":"traceutil/trace.go:171","msg":"trace[1864716002] linearizableReadLoop","detail":"{readStateIndex:1146; appliedIndex:1145; }","duration":"326.731259ms","start":"2026-05-26T05:51:50.565223Z","end":"2026-05-26T05:51:50.891954Z","steps":["trace[1864716002] 'read index received' (duration: 265.950727ms)","trace[1864716002] 'applied index is now lower than readState.Index' (duration: 60.779672ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:51:50.89209Z","caller":"traceutil/trace.go:171","msg":"trace[117952338] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"327.201111ms","start":"2026-05-26T05:51:50.564856Z","end":"2026-05-26T05:51:50.892057Z","steps":["trace[117952338] 'process raft request' (duration: 266.376067ms)","trace[117952338] 'compare' (duration: 60.570978ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:51:50.892154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.880093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:51:50.892223Z","caller":"traceutil/trace.go:171","msg":"trace[2006842857] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1106; }","duration":"327.007065ms","start":"2026-05-26T05:51:50.565187Z","end":"2026-05-26T05:51:50.892194Z","steps":["trace[2006842857] 'agreement among raft nodes before linearized reading' (duration: 326.860032ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:50.892278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:51:50.565175Z","time spent":"327.090128ms","remote":"127.0.0.1:54834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-26T05:51:50.892641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:51:50.564831Z","time spent":"327.328783ms","remote":"127.0.0.1:54866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:51:53.391211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.263114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:51:53.391322Z","caller":"traceutil/trace.go:171","msg":"trace[1081974887] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1114; }","duration":"118.445939ms","start":"2026-05-26T05:51:53.27285Z","end":"2026-05-26T05:51:53.391296Z","steps":["trace[1081974887] 'count revisions from in-memory index tree' (duration: 118.179633ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:53.391763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.007838ms","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-05-26T05:51:53.391856Z","caller":"traceutil/trace.go:171","msg":"trace[1589519047] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1114; }","duration":"141.132112ms","start":"2026-05-26T05:51:53.250702Z","end":"2026-05-26T05:51:53.391835Z","steps":["trace[1589519047] 'range keys from in-memory index tree' (duration: 140.901976ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:51:53.391884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.550697ms","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-05-26T05:51:53.39201Z","caller":"traceutil/trace.go:171","msg":"trace[476743517] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1114; }","duration":"167.652329ms","start":"2026-05-26T05:51:53.224278Z","end":"2026-05-26T05:51:53.391931Z","steps":["trace[476743517] 'range keys from in-memory index tree' (duration: 166.981802ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:57.712546Z","caller":"traceutil/trace.go:171","msg":"trace[573160191] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"137.787651ms","start":"2026-05-26T05:51:57.574735Z","end":"2026-05-26T05:51:57.712523Z","steps":["trace[573160191] 'process raft request' (duration: 137.74309ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:51:57.71272Z","caller":"traceutil/trace.go:171","msg":"trace[1917257784] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"138.650971ms","start":"2026-05-26T05:51:57.574021Z","end":"2026-05-26T05:51:57.712672Z","steps":["trace[1917257784] 'process raft request' (duration: 78.836202ms)","trace[1917257784] 'compare' (duration: 59.395489ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:51:57.713001Z","caller":"traceutil/trace.go:171","msg":"trace[1968082682] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"138.867036ms","start":"2026-05-26T05:51:57.574013Z","end":"2026-05-26T05:51:57.71288Z","steps":["trace[1968082682] 'process raft request' (duration: 138.405575ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:10.432489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.333122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T05:52:10.432551Z","caller":"traceutil/trace.go:171","msg":"trace[1811554941] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1218; }","duration":"327.428425ms","start":"2026-05-26T05:52:10.105107Z","end":"2026-05-26T05:52:10.432535Z","steps":["trace[1811554941] 'count revisions from in-memory index tree' (duration: 327.284632ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:10.432575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:10.105094Z","time spent":"327.475746ms","remote":"127.0.0.1:55396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-26T05:52:10.432581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.672848ms","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-05-26T05:52:10.432621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"991.602422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:52:10.43267Z","caller":"traceutil/trace.go:171","msg":"trace[1667795068] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1218; }","duration":"650.814952ms","start":"2026-05-26T05:52:09.781834Z","end":"2026-05-26T05:52:10.432649Z","steps":["trace[1667795068] 'range keys from in-memory index tree' (duration: 650.471973ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:10.432709Z","caller":"traceutil/trace.go:171","msg":"trace[1841115140] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1218; }","duration":"991.734836ms","start":"2026-05-26T05:52:09.440955Z","end":"2026-05-26T05:52:10.432689Z","steps":["trace[1841115140] 'range keys from in-memory index tree' (duration: 991.527281ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:10.432732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:09.781807Z","time spent":"650.899933ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-26T05:52:10.432753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:09.440936Z","time spent":"991.808958ms","remote":"127.0.0.1:54832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-26T05:52:10.432847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.120137ms","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-05-26T05:52:10.432835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.292832ms","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-05-26T05:52:10.432885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.553471ms","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-05-26T05:52:10.432917Z","caller":"traceutil/trace.go:171","msg":"trace[543404651] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1218; }","duration":"646.403104ms","start":"2026-05-26T05:52:09.786496Z","end":"2026-05-26T05:52:10.432899Z","steps":["trace[543404651] 'range keys from in-memory index tree' (duration: 646.143718ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:10.43295Z","caller":"traceutil/trace.go:171","msg":"trace[813774290] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1218; }","duration":"649.637233ms","start":"2026-05-26T05:52:09.783296Z","end":"2026-05-26T05:52:10.432933Z","steps":["trace[813774290] 'range keys from in-memory index tree' (duration: 649.420078ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:10.432939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.455901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-26T05:52:10.432988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:09.783287Z","time spent":"649.690954ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T05:52:10.432965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:09.786485Z","time spent":"646.470515ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-26T05:52:10.433023Z","caller":"traceutil/trace.go:171","msg":"trace[263628411] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1218; }","duration":"645.561563ms","start":"2026-05-26T05:52:09.787442Z","end":"2026-05-26T05:52:10.433003Z","steps":["trace[263628411] 'range keys from in-memory index tree' (duration: 645.308907ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:10.432873Z","caller":"traceutil/trace.go:171","msg":"trace[468014804] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1218; }","duration":"646.170798ms","start":"2026-05-26T05:52:09.786697Z","end":"2026-05-26T05:52:10.432867Z","steps":["trace[468014804] 'range keys from in-memory index tree' (duration: 646.020265ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:10.433067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:09.787433Z","time spent":"645.623115ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T05:52:10.433085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:09.786685Z","time spent":"646.391924ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T05:52:10.938945Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920881187772520808,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-26T05:52:10.96224Z","caller":"traceutil/trace.go:171","msg":"trace[446913169] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"526.55252ms","start":"2026-05-26T05:52:10.43566Z","end":"2026-05-26T05:52:10.962212Z","steps":["trace[446913169] 'process raft request' (duration: 526.388256ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:10.962393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:10.435613Z","time spent":"526.702824ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:52:10.963145Z","caller":"traceutil/trace.go:171","msg":"trace[500051902] linearizableReadLoop","detail":"{readStateIndex:1268; appliedIndex:1263; }","duration":"524.90123ms","start":"2026-05-26T05:52:10.43823Z","end":"2026-05-26T05:52:10.963131Z","steps":["trace[500051902] 'read index received' (duration: 523.840814ms)","trace[500051902] 'applied index is now lower than readState.Index' (duration: 1.059836ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:52:10.963141Z","caller":"traceutil/trace.go:171","msg":"trace[840089703] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"524.761917ms","start":"2026-05-26T05:52:10.438369Z","end":"2026-05-26T05:52:10.963131Z","steps":["trace[840089703] 'process raft request' (duration: 524.567542ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:10.96322Z","caller":"traceutil/trace.go:171","msg":"trace[1566723503] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"524.769307ms","start":"2026-05-26T05:52:10.438442Z","end":"2026-05-26T05:52:10.963212Z","steps":["trace[1566723503] 'process raft request' (duration: 524.659234ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:10.963251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:10.438358Z","time spent":"524.835818ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:52:10.963261Z","caller":"traceutil/trace.go:171","msg":"trace[1373238373] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"524.831618ms","start":"2026-05-26T05:52:10.438398Z","end":"2026-05-26T05:52:10.96323Z","steps":["trace[1373238373] 'process raft request' (duration: 524.644083ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:10.963293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:10.438437Z","time spent":"524.799607ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:52:10.963313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.821136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T05:52:10.963341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:10.43839Z","time spent":"524.90888ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:52:10.963382Z","caller":"traceutil/trace.go:171","msg":"trace[997507378] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1223; }","duration":"519.908018ms","start":"2026-05-26T05:52:10.443451Z","end":"2026-05-26T05:52:10.963359Z","steps":["trace[997507378] 'agreement among raft nodes before linearized reading' (duration: 519.816636ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:10.963437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:10.443439Z","time spent":"519.98726ms","remote":"127.0.0.1:54832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-26T05:52:10.9631Z","caller":"traceutil/trace.go:171","msg":"trace[535392022] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"524.736195ms","start":"2026-05-26T05:52:10.438343Z","end":"2026-05-26T05:52:10.963079Z","steps":["trace[535392022] 'process raft request' (duration: 524.416098ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:10.963389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.155066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.235\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-26T05:52:10.963515Z","caller":"traceutil/trace.go:171","msg":"trace[307205756] range","detail":"{range_begin:/registry/masterleases/199.204.45.235; range_end:; response_count:1; response_revision:1223; }","duration":"525.29656ms","start":"2026-05-26T05:52:10.438206Z","end":"2026-05-26T05:52:10.963503Z","steps":["trace[307205756] 'agreement among raft nodes before linearized reading' (duration: 525.102365ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:10.963544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:10.438192Z","time spent":"525.34129ms","remote":"127.0.0.1:54866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.235\" "} {"level":"warn","ts":"2026-05-26T05:52:10.963823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:10.438328Z","time spent":"525.461764ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:52:23.394883Z","caller":"traceutil/trace.go:171","msg":"trace[1060173653] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"146.955144ms","start":"2026-05-26T05:52:23.247911Z","end":"2026-05-26T05:52:23.394866Z","steps":["trace[1060173653] 'process raft request' (duration: 146.838151ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:25.526106Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920881187772520940,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-26T05:52:25.987823Z","caller":"traceutil/trace.go:171","msg":"trace[2138555911] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"962.270728ms","start":"2026-05-26T05:52:25.025525Z","end":"2026-05-26T05:52:25.987796Z","steps":["trace[2138555911] 'process raft request' (duration: 962.125295ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:25.987988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:25.025516Z","time spent":"962.37671ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:52:25.988762Z","caller":"traceutil/trace.go:171","msg":"trace[1789845772] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"960.613939ms","start":"2026-05-26T05:52:25.028119Z","end":"2026-05-26T05:52:25.988733Z","steps":["trace[1789845772] 'process raft request' (duration: 960.428995ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:25.988866Z","caller":"traceutil/trace.go:171","msg":"trace[352649709] linearizableReadLoop","detail":"{readStateIndex:1324; appliedIndex:1321; }","duration":"963.118678ms","start":"2026-05-26T05:52:25.025728Z","end":"2026-05-26T05:52:25.988846Z","steps":["trace[352649709] 'read index received' (duration: 961.93093ms)","trace[352649709] 'applied index is now lower than readState.Index' (duration: 1.186558ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:52:25.988963Z","caller":"traceutil/trace.go:171","msg":"trace[1371692498] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"589.912573ms","start":"2026-05-26T05:52:25.399036Z","end":"2026-05-26T05:52:25.988949Z","steps":["trace[1371692498] 'process raft request' (duration: 589.645337ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:25.989095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:25.398985Z","time spent":"590.014395ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:52:25.98914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.897682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:52:25.989189Z","caller":"traceutil/trace.go:171","msg":"trace[1749700188] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1276; }","duration":"545.001325ms","start":"2026-05-26T05:52:25.444174Z","end":"2026-05-26T05:52:25.989175Z","steps":["trace[1749700188] 'agreement among raft nodes before linearized reading' (duration: 544.886572ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:25.989193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"956.426991ms","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-05-26T05:52:25.989222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:25.444153Z","time spent":"545.062616ms","remote":"127.0.0.1:54832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-26T05:52:25.989164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"963.158169ms","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-05-26T05:52:25.989296Z","caller":"traceutil/trace.go:171","msg":"trace[42335743] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1276; }","duration":"956.572844ms","start":"2026-05-26T05:52:25.032707Z","end":"2026-05-26T05:52:25.98928Z","steps":["trace[42335743] 'agreement among raft nodes before linearized reading' (duration: 956.363899ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:25.989342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:25.032698Z","time spent":"956.634665ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-26T05:52:25.989343Z","caller":"traceutil/trace.go:171","msg":"trace[1252344114] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1276; }","duration":"963.436875ms","start":"2026-05-26T05:52:25.025888Z","end":"2026-05-26T05:52:25.989325Z","steps":["trace[1252344114] 'agreement among raft nodes before linearized reading' (duration: 963.090687ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:25.989441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"963.706982ms","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-05-26T05:52:25.989491Z","caller":"traceutil/trace.go:171","msg":"trace[538917280] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1276; }","duration":"963.767474ms","start":"2026-05-26T05:52:25.02571Z","end":"2026-05-26T05:52:25.989477Z","steps":["trace[538917280] 'agreement among raft nodes before linearized reading' (duration: 963.59371ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:25.989537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:25.025703Z","time spent":"963.823035ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T05:52:25.989447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:25.025834Z","time spent":"963.59189ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T05:52:25.989911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:25.028107Z","time spent":"961.429248ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:52:27.025966Z","caller":"traceutil/trace.go:171","msg":"trace[1298417025] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"135.970425ms","start":"2026-05-26T05:52:26.889973Z","end":"2026-05-26T05:52:27.025943Z","steps":["trace[1298417025] 'process raft request' (duration: 135.829091ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:27.226527Z","caller":"traceutil/trace.go:171","msg":"trace[1248814623] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"195.394605ms","start":"2026-05-26T05:52:27.031099Z","end":"2026-05-26T05:52:27.226494Z","steps":["trace[1248814623] 'process raft request' (duration: 109.606083ms)","trace[1248814623] 'compare' (duration: 85.656319ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:52:27.239076Z","caller":"traceutil/trace.go:171","msg":"trace[295043342] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"205.952974ms","start":"2026-05-26T05:52:27.033064Z","end":"2026-05-26T05:52:27.239017Z","steps":["trace[295043342] 'process raft request' (duration: 205.80461ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:27.23939Z","caller":"traceutil/trace.go:171","msg":"trace[165776018] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"203.405444ms","start":"2026-05-26T05:52:27.035855Z","end":"2026-05-26T05:52:27.239261Z","steps":["trace[165776018] 'process raft request' (duration: 203.107837ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:28.256636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"865.296553ms","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-05-26T05:52:28.256712Z","caller":"traceutil/trace.go:171","msg":"trace[202048553] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1289; }","duration":"865.390625ms","start":"2026-05-26T05:52:27.391304Z","end":"2026-05-26T05:52:28.256695Z","steps":["trace[202048553] 'range keys from in-memory index tree' (duration: 865.276203ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:28.2568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.836828ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:52:28.257007Z","caller":"traceutil/trace.go:171","msg":"trace[2006205239] linearizableReadLoop","detail":"{readStateIndex:1339; appliedIndex:1338; }","duration":"812.97244ms","start":"2026-05-26T05:52:27.444017Z","end":"2026-05-26T05:52:28.25699Z","steps":["trace[2006205239] 'read index received' (duration: 240.919648ms)","trace[2006205239] 'applied index is now lower than readState.Index' (duration: 572.051742ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:52:28.257159Z","caller":"traceutil/trace.go:171","msg":"trace[493964200] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"980.701563ms","start":"2026-05-26T05:52:27.276417Z","end":"2026-05-26T05:52:28.257119Z","steps":["trace[493964200] 'process raft request' (duration: 408.467397ms)","trace[493964200] 'compare' (duration: 571.718654ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:52:28.25723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.352268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-05-26T05:52:28.257251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"760.957634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5331"} {"level":"info","ts":"2026-05-26T05:52:28.257268Z","caller":"traceutil/trace.go:171","msg":"trace[660466911] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1291; }","duration":"255.40488ms","start":"2026-05-26T05:52:28.001853Z","end":"2026-05-26T05:52:28.257258Z","steps":["trace[660466911] 'agreement among raft nodes before linearized reading' (duration: 255.264656ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:28.257282Z","caller":"traceutil/trace.go:171","msg":"trace[348098845] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1291; }","duration":"761.013826ms","start":"2026-05-26T05:52:27.496258Z","end":"2026-05-26T05:52:28.257271Z","steps":["trace[348098845] 'agreement among raft nodes before linearized reading' (duration: 760.862072ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:28.257315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:27.496243Z","time spent":"761.064027ms","remote":"127.0.0.1:55006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":5352,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-26T05:52:28.257313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:27.276393Z","time spent":"980.841447ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:52:28.257341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"813.303698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:52:28.257398Z","caller":"traceutil/trace.go:171","msg":"trace[562168646] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1291; }","duration":"813.397791ms","start":"2026-05-26T05:52:27.443987Z","end":"2026-05-26T05:52:28.257384Z","steps":["trace[562168646] 'agreement among raft nodes before linearized reading' (duration: 813.088563ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:28.257423Z","caller":"traceutil/trace.go:171","msg":"trace[438351902] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"261.280258ms","start":"2026-05-26T05:52:27.996129Z","end":"2026-05-26T05:52:28.25741Z","steps":["trace[438351902] 'process raft request' (duration: 260.811557ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:28.257432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:27.443971Z","time spent":"813.451012ms","remote":"127.0.0.1:54832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-26T05:52:28.25744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.789514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-26T05:52:28.25746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.099418ms","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-05-26T05:52:28.257488Z","caller":"traceutil/trace.go:171","msg":"trace[580499786] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1291; }","duration":"265.16606ms","start":"2026-05-26T05:52:27.992315Z","end":"2026-05-26T05:52:28.257481Z","steps":["trace[580499786] 'agreement among raft nodes before linearized reading' (duration: 265.042907ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:28.257487Z","caller":"traceutil/trace.go:171","msg":"trace[1283908636] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1291; }","duration":"262.861135ms","start":"2026-05-26T05:52:27.994613Z","end":"2026-05-26T05:52:28.257474Z","steps":["trace[1283908636] 'agreement among raft nodes before linearized reading' (duration: 262.726282ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:28.257477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.443837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:52:28.257553Z","caller":"traceutil/trace.go:171","msg":"trace[491961511] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1291; }","duration":"551.5773ms","start":"2026-05-26T05:52:27.705958Z","end":"2026-05-26T05:52:28.257536Z","steps":["trace[491961511] 'agreement among raft nodes before linearized reading' (duration: 551.436377ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:28.257568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.257179ms","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-05-26T05:52:28.257587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.818686ms","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-05-26T05:52:28.257608Z","caller":"traceutil/trace.go:171","msg":"trace[2080241524] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1291; }","duration":"257.859937ms","start":"2026-05-26T05:52:27.999743Z","end":"2026-05-26T05:52:28.257603Z","steps":["trace[2080241524] 'agreement among raft nodes before linearized reading' (duration: 257.798535ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:28.257605Z","caller":"traceutil/trace.go:171","msg":"trace[126170688] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1291; }","duration":"253.340161ms","start":"2026-05-26T05:52:28.004256Z","end":"2026-05-26T05:52:28.257596Z","steps":["trace[126170688] 'agreement among raft nodes before linearized reading' (duration: 253.236338ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:28.257608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:27.705936Z","time spent":"551.651001ms","remote":"127.0.0.1:55182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":26,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"info","ts":"2026-05-26T05:52:28.431132Z","caller":"traceutil/trace.go:171","msg":"trace[1963302785] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"163.247228ms","start":"2026-05-26T05:52:28.267852Z","end":"2026-05-26T05:52:28.4311Z","steps":["trace[1963302785] 'process raft request' (duration: 89.51642ms)","trace[1963302785] 'compare' (duration: 73.562444ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:52:28.431234Z","caller":"traceutil/trace.go:171","msg":"trace[1228312919] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"163.186596ms","start":"2026-05-26T05:52:28.268027Z","end":"2026-05-26T05:52:28.431214Z","steps":["trace[1228312919] 'process raft request' (duration: 163.145766ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:28.431327Z","caller":"traceutil/trace.go:171","msg":"trace[155056058] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"163.35039ms","start":"2026-05-26T05:52:28.267958Z","end":"2026-05-26T05:52:28.431308Z","steps":["trace[155056058] 'process raft request' (duration: 163.133855ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:28.431409Z","caller":"traceutil/trace.go:171","msg":"trace[1223521262] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"163.531765ms","start":"2026-05-26T05:52:28.267857Z","end":"2026-05-26T05:52:28.431389Z","steps":["trace[1223521262] 'process raft request' (duration: 163.190377ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:28.431453Z","caller":"traceutil/trace.go:171","msg":"trace[1280240142] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"163.451762ms","start":"2026-05-26T05:52:28.267997Z","end":"2026-05-26T05:52:28.431449Z","steps":["trace[1280240142] 'process raft request' (duration: 163.121454ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:28.431437Z","caller":"traceutil/trace.go:171","msg":"trace[1376914458] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"163.422452ms","start":"2026-05-26T05:52:28.268009Z","end":"2026-05-26T05:52:28.431431Z","steps":["trace[1376914458] 'process raft request' (duration: 163.131295ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:30.742767Z","caller":"traceutil/trace.go:171","msg":"trace[2095862510] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"479.718246ms","start":"2026-05-26T05:52:30.263022Z","end":"2026-05-26T05:52:30.74274Z","steps":["trace[2095862510] 'process raft request' (duration: 479.511552ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:30.742913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:30.262996Z","time spent":"479.828998ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:52:30.742962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.465767ms","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-05-26T05:52:30.743017Z","caller":"traceutil/trace.go:171","msg":"trace[523858304] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1299; }","duration":"307.58727ms","start":"2026-05-26T05:52:30.435416Z","end":"2026-05-26T05:52:30.743003Z","steps":["trace[523858304] 'agreement among raft nodes before linearized reading' (duration: 307.391515ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:30.743058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:30.435395Z","time spent":"307.651781ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-26T05:52:30.742743Z","caller":"traceutil/trace.go:171","msg":"trace[2131168529] linearizableReadLoop","detail":"{readStateIndex:1348; appliedIndex:1347; }","duration":"307.205951ms","start":"2026-05-26T05:52:30.435469Z","end":"2026-05-26T05:52:30.742674Z","steps":["trace[2131168529] 'read index received' (duration: 307.017536ms)","trace[2131168529] 'applied index is now lower than readState.Index' (duration: 187.265µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:52:30.743622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.877586ms","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-05-26T05:52:30.743676Z","caller":"traceutil/trace.go:171","msg":"trace[63128533] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1299; }","duration":"307.954498ms","start":"2026-05-26T05:52:30.435708Z","end":"2026-05-26T05:52:30.743662Z","steps":["trace[63128533] 'agreement among raft nodes before linearized reading' (duration: 307.798404ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:30.743719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:30.435698Z","time spent":"308.011029ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T05:52:30.743998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.331102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.235\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-26T05:52:30.744056Z","caller":"traceutil/trace.go:171","msg":"trace[2085504653] range","detail":"{range_begin:/registry/masterleases/199.204.45.235; range_end:; response_count:1; response_revision:1299; }","duration":"301.408433ms","start":"2026-05-26T05:52:30.442634Z","end":"2026-05-26T05:52:30.744042Z","steps":["trace[2085504653] 'agreement among raft nodes before linearized reading' (duration: 301.25863ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:30.744101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:30.442623Z","time spent":"301.463655ms","remote":"127.0.0.1:54866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.235\" "} {"level":"warn","ts":"2026-05-26T05:52:30.744359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.63396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-26T05:52:30.744449Z","caller":"traceutil/trace.go:171","msg":"trace[610735672] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1299; }","duration":"307.749103ms","start":"2026-05-26T05:52:30.436687Z","end":"2026-05-26T05:52:30.744436Z","steps":["trace[610735672] 'agreement among raft nodes before linearized reading' (duration: 307.58749ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:30.744532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:30.436672Z","time spent":"307.846065ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":511,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T05:52:30.744804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.995043ms","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-05-26T05:52:30.744865Z","caller":"traceutil/trace.go:171","msg":"trace[1694489111] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1299; }","duration":"309.063634ms","start":"2026-05-26T05:52:30.435785Z","end":"2026-05-26T05:52:30.744849Z","steps":["trace[1694489111] 'agreement among raft nodes before linearized reading' (duration: 308.933421ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:30.744902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:30.435781Z","time spent":"309.111855ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T05:52:30.745145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.359211ms","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-05-26T05:52:30.745201Z","caller":"traceutil/trace.go:171","msg":"trace[1130200714] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1299; }","duration":"309.428943ms","start":"2026-05-26T05:52:30.435759Z","end":"2026-05-26T05:52:30.745187Z","steps":["trace[1130200714] 'agreement among raft nodes before linearized reading' (duration: 309.30178ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:30.745242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:30.435753Z","time spent":"309.477124ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-26T05:52:31.328897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.207564ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:38"} {"level":"warn","ts":"2026-05-26T05:52:31.328984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:30.747743Z","time spent":"581.235719ms","remote":"127.0.0.1:54866","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-26T05:52:31.670677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.206934ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:52:31.670963Z","caller":"traceutil/trace.go:171","msg":"trace[500286590] linearizableReadLoop","detail":"{readStateIndex:1355; appliedIndex:1349; }","duration":"227.524813ms","start":"2026-05-26T05:52:31.443422Z","end":"2026-05-26T05:52:31.670947Z","steps":["trace[500286590] 'read index received' (duration: 69.99467ms)","trace[500286590] 'applied index is now lower than readState.Index' (duration: 157.529213ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:52:31.6711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.684576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:52:31.67114Z","caller":"traceutil/trace.go:171","msg":"trace[1907226192] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1305; }","duration":"227.767428ms","start":"2026-05-26T05:52:31.443363Z","end":"2026-05-26T05:52:31.67113Z","steps":["trace[1907226192] 'agreement among raft nodes before linearized reading' (duration: 227.639455ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:31.671178Z","caller":"traceutil/trace.go:171","msg":"trace[2081373996] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"920.380192ms","start":"2026-05-26T05:52:30.750785Z","end":"2026-05-26T05:52:31.67113Z","steps":["trace[2081373996] 'process raft request' (duration: 919.977922ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:31.671089Z","caller":"traceutil/trace.go:171","msg":"trace[692168355] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"923.130946ms","start":"2026-05-26T05:52:30.747832Z","end":"2026-05-26T05:52:31.670963Z","steps":["trace[692168355] 'process raft request' (duration: 765.567643ms)","trace[692168355] 'compare' (duration: 157.02837ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:52:31.671343Z","caller":"traceutil/trace.go:171","msg":"trace[672420581] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"919.110222ms","start":"2026-05-26T05:52:30.752217Z","end":"2026-05-26T05:52:31.671328Z","steps":["trace[672420581] 'process raft request' (duration: 918.656171ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:31.67139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:30.74781Z","time spent":"923.500735ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:52:31.671375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:30.750767Z","time spent":"920.487714ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:52:31.671406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:30.752211Z","time spent":"919.159934ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:52:31.671594Z","caller":"traceutil/trace.go:171","msg":"trace[1081614316] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"920.71709ms","start":"2026-05-26T05:52:30.750863Z","end":"2026-05-26T05:52:31.67158Z","steps":["trace[1081614316] 'process raft request' (duration: 919.952342ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:31.671609Z","caller":"traceutil/trace.go:171","msg":"trace[1420204082] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"341.319214ms","start":"2026-05-26T05:52:31.33028Z","end":"2026-05-26T05:52:31.671599Z","steps":["trace[1420204082] 'process raft request' (duration: 340.633328ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:31.671051Z","caller":"traceutil/trace.go:171","msg":"trace[2088315541] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"919.675885ms","start":"2026-05-26T05:52:30.751345Z","end":"2026-05-26T05:52:31.671021Z","steps":["trace[2088315541] 'process raft request' (duration: 919.500301ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:31.671679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:30.751329Z","time spent":"920.32637ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:52:31.67176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:31.330262Z","time spent":"341.371076ms","remote":"127.0.0.1:54866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:52:31.671683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:30.750853Z","time spent":"920.767981ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:52:33.850675Z","caller":"traceutil/trace.go:171","msg":"trace[1249410211] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"166.930765ms","start":"2026-05-26T05:52:33.683719Z","end":"2026-05-26T05:52:33.85065Z","steps":["trace[1249410211] 'process raft request' (duration: 166.784131ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:33.872847Z","caller":"traceutil/trace.go:171","msg":"trace[2119969996] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"189.045805ms","start":"2026-05-26T05:52:33.683779Z","end":"2026-05-26T05:52:33.872825Z","steps":["trace[2119969996] 'process raft request' (duration: 188.884482ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:33.872986Z","caller":"traceutil/trace.go:171","msg":"trace[1656927655] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"187.871498ms","start":"2026-05-26T05:52:33.685105Z","end":"2026-05-26T05:52:33.872976Z","steps":["trace[1656927655] 'process raft request' (duration: 187.659133ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:33.873147Z","caller":"traceutil/trace.go:171","msg":"trace[67417924] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"187.630633ms","start":"2026-05-26T05:52:33.685505Z","end":"2026-05-26T05:52:33.873136Z","steps":["trace[67417924] 'process raft request' (duration: 187.431088ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:33.873141Z","caller":"traceutil/trace.go:171","msg":"trace[419158924] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"186.434384ms","start":"2026-05-26T05:52:33.686685Z","end":"2026-05-26T05:52:33.87312Z","steps":["trace[419158924] 'process raft request' (duration: 186.369633ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:34.526867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:34.170767Z","time spent":"356.087553ms","remote":"127.0.0.1:55438","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-26T05:52:34.527363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.492068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T05:52:34.527401Z","caller":"traceutil/trace.go:171","msg":"trace[220721180] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1313; }","duration":"226.577209ms","start":"2026-05-26T05:52:34.300813Z","end":"2026-05-26T05:52:34.52739Z","steps":["trace[220721180] 'count revisions from in-memory index tree' (duration: 226.409406ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:35.236421Z","caller":"traceutil/trace.go:171","msg":"trace[2097118197] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"418.099384ms","start":"2026-05-26T05:52:34.818294Z","end":"2026-05-26T05:52:35.236393Z","steps":["trace[2097118197] 'process raft request' (duration: 417.93231ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:35.236579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:34.818273Z","time spent":"418.225017ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:52:36.649934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.206175877s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:52:36.649999Z","caller":"traceutil/trace.go:171","msg":"trace[581421314] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1314; }","duration":"1.20629005s","start":"2026-05-26T05:52:35.443694Z","end":"2026-05-26T05:52:36.649984Z","steps":["trace[581421314] 'range keys from in-memory index tree' (duration: 1.206091335s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:36.650032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:35.443674Z","time spent":"1.206350621s","remote":"127.0.0.1:54834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-26T05:52:36.650708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.928544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-26T05:52:36.650789Z","caller":"traceutil/trace.go:171","msg":"trace[1042138785] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1314; }","duration":"795.051497ms","start":"2026-05-26T05:52:35.855719Z","end":"2026-05-26T05:52:36.650771Z","steps":["trace[1042138785] 'range keys from in-memory index tree' (duration: 794.677249ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:36.650829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:35.8557Z","time spent":"795.120459ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T05:52:36.651064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"773.634532ms","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-05-26T05:52:36.651097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"775.189459ms","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-05-26T05:52:36.651104Z","caller":"traceutil/trace.go:171","msg":"trace[554694639] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1314; }","duration":"773.673663ms","start":"2026-05-26T05:52:35.877419Z","end":"2026-05-26T05:52:36.651093Z","steps":["trace[554694639] 'range keys from in-memory index tree' (duration: 773.51107ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:36.651129Z","caller":"traceutil/trace.go:171","msg":"trace[832993479] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1314; }","duration":"775.258341ms","start":"2026-05-26T05:52:35.875862Z","end":"2026-05-26T05:52:36.65112Z","steps":["trace[832993479] 'range keys from in-memory index tree' (duration: 775.024435ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:36.651136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:35.877395Z","time spent":"773.730945ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T05:52:36.651156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:35.875842Z","time spent":"775.308042ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T05:52:36.651333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"774.362469ms","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-05-26T05:52:36.651356Z","caller":"traceutil/trace.go:171","msg":"trace[1419844946] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1314; }","duration":"774.403841ms","start":"2026-05-26T05:52:35.876945Z","end":"2026-05-26T05:52:36.651349Z","steps":["trace[1419844946] 'range keys from in-memory index tree' (duration: 774.286118ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:36.65138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:35.876938Z","time spent":"774.433062ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-26T05:52:36.651434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"774.859892ms","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-05-26T05:52:36.651484Z","caller":"traceutil/trace.go:171","msg":"trace[203579205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1314; }","duration":"774.970824ms","start":"2026-05-26T05:52:35.876501Z","end":"2026-05-26T05:52:36.651472Z","steps":["trace[203579205] 'range keys from in-memory index tree' (duration: 774.697567ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:36.651515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:35.87648Z","time spent":"775.028585ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-26T05:52:36.734356Z","caller":"traceutil/trace.go:171","msg":"trace[1492780868] linearizableReadLoop","detail":"{readStateIndex:1365; appliedIndex:1364; }","duration":"271.743245ms","start":"2026-05-26T05:52:36.462584Z","end":"2026-05-26T05:52:36.734327Z","steps":["trace[1492780868] 'read index received' (duration: 179.657994ms)","trace[1492780868] 'applied index is now lower than readState.Index' (duration: 92.083811ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:52:36.734817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.212275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T05:52:36.734871Z","caller":"traceutil/trace.go:171","msg":"trace[1616518694] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1314; }","duration":"272.320848ms","start":"2026-05-26T05:52:36.462539Z","end":"2026-05-26T05:52:36.734859Z","steps":["trace[1616518694] 'agreement among raft nodes before linearized reading' (duration: 271.913619ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:36.741444Z","caller":"traceutil/trace.go:171","msg":"trace[1762125999] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"171.109863ms","start":"2026-05-26T05:52:36.570318Z","end":"2026-05-26T05:52:36.741428Z","steps":["trace[1762125999] 'process raft request' (duration: 170.98675ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:40.946354Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920881187772521070,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-26T05:52:41.162044Z","caller":"traceutil/trace.go:171","msg":"trace[314977577] linearizableReadLoop","detail":"{readStateIndex:1399; appliedIndex:1398; }","duration":"716.789603ms","start":"2026-05-26T05:52:40.445231Z","end":"2026-05-26T05:52:41.162021Z","steps":["trace[314977577] 'read index received' (duration: 716.618239ms)","trace[314977577] 'applied index is now lower than readState.Index' (duration: 168.404µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:52:41.162076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:40.444286Z","time spent":"717.781757ms","remote":"127.0.0.1:54866","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-26T05:52:41.162298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.706614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-26T05:52:41.162325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.24769ms","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-05-26T05:52:41.162373Z","caller":"traceutil/trace.go:171","msg":"trace[1255145701] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1347; }","duration":"402.334412ms","start":"2026-05-26T05:52:40.760026Z","end":"2026-05-26T05:52:41.162361Z","steps":["trace[1255145701] 'agreement among raft nodes before linearized reading' (duration: 402.199319ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:41.162338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"717.06841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T05:52:41.162409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:40.760019Z","time spent":"402.382393ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T05:52:41.162415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.973058ms","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-05-26T05:52:41.162453Z","caller":"traceutil/trace.go:171","msg":"trace[799380687] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1347; }","duration":"403.037399ms","start":"2026-05-26T05:52:40.759398Z","end":"2026-05-26T05:52:41.162436Z","steps":["trace[799380687] 'agreement among raft nodes before linearized reading' (duration: 402.962067ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:52:41.162469Z","caller":"traceutil/trace.go:171","msg":"trace[1074150965] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1347; }","duration":"717.204124ms","start":"2026-05-26T05:52:40.445206Z","end":"2026-05-26T05:52:41.16241Z","steps":["trace[1074150965] 'agreement among raft nodes before linearized reading' (duration: 716.949238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:41.162488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:40.759372Z","time spent":"403.10805ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-26T05:52:41.162521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.463576ms","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-05-26T05:52:41.162339Z","caller":"traceutil/trace.go:171","msg":"trace[491298783] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1347; }","duration":"403.805907ms","start":"2026-05-26T05:52:40.758523Z","end":"2026-05-26T05:52:41.162329Z","steps":["trace[491298783] 'agreement among raft nodes before linearized reading' (duration: 403.639093ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:41.162579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:40.758502Z","time spent":"404.071424ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-26T05:52:41.162582Z","caller":"traceutil/trace.go:171","msg":"trace[278324125] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1347; }","duration":"402.550047ms","start":"2026-05-26T05:52:40.760017Z","end":"2026-05-26T05:52:41.162567Z","steps":["trace[278324125] 'agreement among raft nodes before linearized reading' (duration: 402.340732ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:41.162586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:40.445195Z","time spent":"717.350757ms","remote":"127.0.0.1:54834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-26T05:52:41.162608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.598286ms","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-05-26T05:52:41.162631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:40.760006Z","time spent":"402.613529ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-26T05:52:41.162655Z","caller":"traceutil/trace.go:171","msg":"trace[1392610893] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1347; }","duration":"401.700627ms","start":"2026-05-26T05:52:40.760939Z","end":"2026-05-26T05:52:41.162639Z","steps":["trace[1392610893] 'agreement among raft nodes before linearized reading' (duration: 401.525893ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:41.162693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:52:40.760922Z","time spent":"401.763399ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-26T05:52:42.585271Z","caller":"traceutil/trace.go:171","msg":"trace[1019086262] linearizableReadLoop","detail":"{readStateIndex:1416; appliedIndex:1415; }","duration":"142.027097ms","start":"2026-05-26T05:52:42.443204Z","end":"2026-05-26T05:52:42.585231Z","steps":["trace[1019086262] 'read index received' (duration: 97.655162ms)","trace[1019086262] 'applied index is now lower than readState.Index' (duration: 44.370605ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:52:42.585296Z","caller":"traceutil/trace.go:171","msg":"trace[594348682] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"205.734018ms","start":"2026-05-26T05:52:42.379503Z","end":"2026-05-26T05:52:42.585237Z","steps":["trace[594348682] 'process raft request' (duration: 161.416054ms)","trace[594348682] 'compare' (duration: 44.12621ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:52:42.585915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.648089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:52:42.585975Z","caller":"traceutil/trace.go:171","msg":"trace[1246590256] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1364; }","duration":"130.760342ms","start":"2026-05-26T05:52:42.455202Z","end":"2026-05-26T05:52:42.585962Z","steps":["trace[1246590256] 'agreement among raft nodes before linearized reading' (duration: 130.651259ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:52:42.585624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.340144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:52:42.58623Z","caller":"traceutil/trace.go:171","msg":"trace[80151965] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1364; }","duration":"143.054801ms","start":"2026-05-26T05:52:42.443149Z","end":"2026-05-26T05:52:42.586204Z","steps":["trace[80151965] 'agreement among raft nodes before linearized reading' (duration: 142.229262ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:53:07.660932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.194311ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:53:07.661365Z","caller":"traceutil/trace.go:171","msg":"trace[361491505] transaction","detail":"{read_only:false; response_revision:1492; number_of_response:1; }","duration":"225.137236ms","start":"2026-05-26T05:53:07.436203Z","end":"2026-05-26T05:53:07.66134Z","steps":["trace[361491505] 'process raft request' (duration: 225.094795ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:53:07.661436Z","caller":"traceutil/trace.go:171","msg":"trace[46917846] transaction","detail":"{read_only:false; response_revision:1491; number_of_response:1; }","duration":"225.73853ms","start":"2026-05-26T05:53:07.435676Z","end":"2026-05-26T05:53:07.661415Z","steps":["trace[46917846] 'process raft request' (duration: 225.589917ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:53:07.661432Z","caller":"traceutil/trace.go:171","msg":"trace[185189518] transaction","detail":"{read_only:false; response_revision:1489; number_of_response:1; }","duration":"225.73202ms","start":"2026-05-26T05:53:07.435649Z","end":"2026-05-26T05:53:07.661381Z","steps":["trace[185189518] 'process raft request' (duration: 225.456234ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:53:07.661436Z","caller":"traceutil/trace.go:171","msg":"trace[1923973483] transaction","detail":"{read_only:false; response_revision:1488; number_of_response:1; }","duration":"225.948966ms","start":"2026-05-26T05:53:07.435447Z","end":"2026-05-26T05:53:07.661396Z","steps":["trace[1923973483] 'process raft request' (duration: 97.14871ms)","trace[1923973483] 'compare' (duration: 127.762651ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:53:07.661442Z","caller":"traceutil/trace.go:171","msg":"trace[159994896] transaction","detail":"{read_only:false; response_revision:1490; number_of_response:1; }","duration":"225.72244ms","start":"2026-05-26T05:53:07.435674Z","end":"2026-05-26T05:53:07.661397Z","steps":["trace[159994896] 'process raft request' (duration: 225.553386ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:53:17.624189Z","caller":"traceutil/trace.go:171","msg":"trace[1639678061] transaction","detail":"{read_only:false; response_revision:1533; number_of_response:1; }","duration":"162.826588ms","start":"2026-05-26T05:53:17.461337Z","end":"2026-05-26T05:53:17.624164Z","steps":["trace[1639678061] 'process raft request' (duration: 162.676644ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:53:25.966427Z","caller":"traceutil/trace.go:171","msg":"trace[1409755518] transaction","detail":"{read_only:false; response_revision:1573; number_of_response:1; }","duration":"137.45503ms","start":"2026-05-26T05:53:25.828947Z","end":"2026-05-26T05:53:25.966402Z","steps":["trace[1409755518] 'process raft request' (duration: 132.622306ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:53:25.969404Z","caller":"traceutil/trace.go:171","msg":"trace[1697176716] transaction","detail":"{read_only:false; response_revision:1575; number_of_response:1; }","duration":"139.57328ms","start":"2026-05-26T05:53:25.829801Z","end":"2026-05-26T05:53:25.969374Z","steps":["trace[1697176716] 'process raft request' (duration: 139.520258ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:53:25.969524Z","caller":"traceutil/trace.go:171","msg":"trace[1476778814] transaction","detail":"{read_only:false; response_revision:1574; number_of_response:1; }","duration":"140.142413ms","start":"2026-05-26T05:53:25.829346Z","end":"2026-05-26T05:53:25.969488Z","steps":["trace[1476778814] 'process raft request' (duration: 139.831376ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:53:39.863009Z","caller":"traceutil/trace.go:171","msg":"trace[1363828041] transaction","detail":"{read_only:false; response_revision:1635; number_of_response:1; }","duration":"152.455712ms","start":"2026-05-26T05:53:39.710533Z","end":"2026-05-26T05:53:39.862988Z","steps":["trace[1363828041] 'process raft request' (duration: 64.828166ms)","trace[1363828041] 'compare' (duration: 87.539944ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:53:39.911124Z","caller":"traceutil/trace.go:171","msg":"trace[1565981987] transaction","detail":"{read_only:false; response_revision:1636; number_of_response:1; }","duration":"161.136568ms","start":"2026-05-26T05:53:39.749956Z","end":"2026-05-26T05:53:39.911093Z","steps":["trace[1565981987] 'process raft request' (duration: 160.985764ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:53:56.167866Z","caller":"traceutil/trace.go:171","msg":"trace[308947006] transaction","detail":"{read_only:false; response_revision:1710; number_of_response:1; }","duration":"134.241321ms","start":"2026-05-26T05:53:56.033601Z","end":"2026-05-26T05:53:56.167842Z","steps":["trace[308947006] 'process raft request' (duration: 134.115378ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:54:10.20723Z","caller":"traceutil/trace.go:171","msg":"trace[1379917328] transaction","detail":"{read_only:false; response_revision:1773; number_of_response:1; }","duration":"106.938924ms","start":"2026-05-26T05:54:10.100267Z","end":"2026-05-26T05:54:10.207206Z","steps":["trace[1379917328] 'process raft request' (duration: 106.804351ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:54:10.28786Z","caller":"traceutil/trace.go:171","msg":"trace[949078941] transaction","detail":"{read_only:false; response_revision:1774; number_of_response:1; }","duration":"150.823083ms","start":"2026-05-26T05:54:10.137009Z","end":"2026-05-26T05:54:10.287832Z","steps":["trace[949078941] 'process raft request' (duration: 103.637425ms)","trace[949078941] 'compare' (duration: 47.054935ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:54:10.585051Z","caller":"traceutil/trace.go:171","msg":"trace[301961142] transaction","detail":"{read_only:false; response_revision:1779; number_of_response:1; }","duration":"105.416017ms","start":"2026-05-26T05:54:10.4796Z","end":"2026-05-26T05:54:10.585016Z","steps":["trace[301961142] 'process raft request' (duration: 105.179902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:54:12.528803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.561098ms","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-05-26T05:54:12.528891Z","caller":"traceutil/trace.go:171","msg":"trace[1171673484] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1783; }","duration":"175.703321ms","start":"2026-05-26T05:54:12.353168Z","end":"2026-05-26T05:54:12.528871Z","steps":["trace[1171673484] 'range keys from in-memory index tree' (duration: 175.366683ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:54:12.529125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.126071ms","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-05-26T05:54:12.529284Z","caller":"traceutil/trace.go:171","msg":"trace[1845080218] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1783; }","duration":"184.284735ms","start":"2026-05-26T05:54:12.344953Z","end":"2026-05-26T05:54:12.529238Z","steps":["trace[1845080218] 'range keys from in-memory index tree' (duration: 183.941806ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:54:57.277501Z","caller":"traceutil/trace.go:171","msg":"trace[510961316] transaction","detail":"{read_only:false; response_revision:1991; number_of_response:1; }","duration":"132.053073ms","start":"2026-05-26T05:54:57.145418Z","end":"2026-05-26T05:54:57.277471Z","steps":["trace[510961316] 'process raft request' (duration: 131.877779ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:55:21.113091Z","caller":"traceutil/trace.go:171","msg":"trace[1273360325] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"115.137922ms","start":"2026-05-26T05:55:20.997924Z","end":"2026-05-26T05:55:21.113062Z","steps":["trace[1273360325] 'process raft request' (duration: 115.0377ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:55:51.423426Z","caller":"traceutil/trace.go:171","msg":"trace[788868288] linearizableReadLoop","detail":"{readStateIndex:2327; appliedIndex:2326; }","duration":"121.906706ms","start":"2026-05-26T05:55:51.301499Z","end":"2026-05-26T05:55:51.423405Z","steps":["trace[788868288] 'read index received' (duration: 1.789422ms)","trace[788868288] 'applied index is now lower than readState.Index' (duration: 120.116374ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:55:51.423516Z","caller":"traceutil/trace.go:171","msg":"trace[1111149086] transaction","detail":"{read_only:false; response_revision:2237; number_of_response:1; }","duration":"136.341468ms","start":"2026-05-26T05:55:51.287141Z","end":"2026-05-26T05:55:51.423482Z","steps":["trace[1111149086] 'process raft request' (duration: 136.139854ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:55:51.423585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.06178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T05:55:51.423662Z","caller":"traceutil/trace.go:171","msg":"trace[917839417] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2237; }","duration":"122.166442ms","start":"2026-05-26T05:55:51.301451Z","end":"2026-05-26T05:55:51.423618Z","steps":["trace[917839417] 'agreement among raft nodes before linearized reading' (duration: 122.07995ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:55:51.552311Z","caller":"traceutil/trace.go:171","msg":"trace[1471816359] transaction","detail":"{read_only:false; response_revision:2239; number_of_response:1; }","duration":"124.60949ms","start":"2026-05-26T05:55:51.427673Z","end":"2026-05-26T05:55:51.552282Z","steps":["trace[1471816359] 'process raft request' (duration: 77.420513ms)","trace[1471816359] 'compare' (duration: 47.033724ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:55:52.835249Z","caller":"traceutil/trace.go:171","msg":"trace[1244783384] linearizableReadLoop","detail":"{readStateIndex:2333; appliedIndex:2332; }","duration":"212.907001ms","start":"2026-05-26T05:55:52.62232Z","end":"2026-05-26T05:55:52.835227Z","steps":["trace[1244783384] 'read index received' (duration: 2.848857ms)","trace[1244783384] 'applied index is now lower than readState.Index' (duration: 210.057324ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:55:52.835365Z","caller":"traceutil/trace.go:171","msg":"trace[1220661416] transaction","detail":"{read_only:false; response_revision:2243; number_of_response:1; }","duration":"221.888364ms","start":"2026-05-26T05:55:52.61346Z","end":"2026-05-26T05:55:52.835348Z","steps":["trace[1220661416] 'process raft request' (duration: 177.965614ms)","trace[1220661416] 'compare' (duration: 43.676884ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:55:52.835801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.474425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-26T05:55:52.835842Z","caller":"traceutil/trace.go:171","msg":"trace[1938243231] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2243; }","duration":"213.567618ms","start":"2026-05-26T05:55:52.622264Z","end":"2026-05-26T05:55:52.835832Z","steps":["trace[1938243231] 'agreement among raft nodes before linearized reading' (duration: 213.049425ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:00.23985Z","caller":"traceutil/trace.go:171","msg":"trace[1732260129] transaction","detail":"{read_only:false; response_revision:2277; number_of_response:1; }","duration":"230.094868ms","start":"2026-05-26T05:56:00.009718Z","end":"2026-05-26T05:56:00.239813Z","steps":["trace[1732260129] 'process raft request' (duration: 229.77494ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:00.406646Z","caller":"traceutil/trace.go:171","msg":"trace[1056463231] linearizableReadLoop","detail":"{readStateIndex:2369; appliedIndex:2368; }","duration":"114.189354ms","start":"2026-05-26T05:56:00.292431Z","end":"2026-05-26T05:56:00.406621Z","steps":["trace[1056463231] 'read index received' (duration: 25.872633ms)","trace[1056463231] 'applied index is now lower than readState.Index' (duration: 88.315541ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:56:00.406858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.407379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:56:00.406871Z","caller":"traceutil/trace.go:171","msg":"trace[184394667] transaction","detail":"{read_only:false; response_revision:2278; number_of_response:1; }","duration":"162.910708ms","start":"2026-05-26T05:56:00.243935Z","end":"2026-05-26T05:56:00.406845Z","steps":["trace[184394667] 'process raft request' (duration: 74.371661ms)","trace[184394667] 'compare' (duration: 88.186868ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:56:00.406963Z","caller":"traceutil/trace.go:171","msg":"trace[1180907208] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2278; }","duration":"114.583323ms","start":"2026-05-26T05:56:00.292336Z","end":"2026-05-26T05:56:00.406919Z","steps":["trace[1180907208] 'agreement among raft nodes before linearized reading' (duration: 114.44179ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:00.617633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.722749ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:38"} {"level":"info","ts":"2026-05-26T05:56:00.859981Z","caller":"traceutil/trace.go:171","msg":"trace[206712835] transaction","detail":"{read_only:false; response_revision:2279; number_of_response:1; }","duration":"241.13297ms","start":"2026-05-26T05:56:00.618818Z","end":"2026-05-26T05:56:00.859951Z","steps":["trace[206712835] 'process raft request' (duration: 236.708625ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:13.784274Z","caller":"traceutil/trace.go:171","msg":"trace[919650650] transaction","detail":"{read_only:false; response_revision:2345; number_of_response:1; }","duration":"123.815112ms","start":"2026-05-26T05:56:13.660423Z","end":"2026-05-26T05:56:13.784239Z","steps":["trace[919650650] 'process raft request' (duration: 123.598657ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:14.776915Z","caller":"traceutil/trace.go:171","msg":"trace[1345260579] linearizableReadLoop","detail":"{readStateIndex:2455; appliedIndex:2454; }","duration":"104.896614ms","start":"2026-05-26T05:56:14.672Z","end":"2026-05-26T05:56:14.776896Z","steps":["trace[1345260579] 'read index received' (duration: 104.684569ms)","trace[1345260579] 'applied index is now lower than readState.Index' (duration: 211.325µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:56:14.777183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.14329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:56:14.777218Z","caller":"traceutil/trace.go:171","msg":"trace[479008150] transaction","detail":"{read_only:false; response_revision:2360; number_of_response:1; }","duration":"116.287834ms","start":"2026-05-26T05:56:14.660905Z","end":"2026-05-26T05:56:14.777193Z","steps":["trace[479008150] 'process raft request' (duration: 115.837433ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:14.777244Z","caller":"traceutil/trace.go:171","msg":"trace[1973757064] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2360; }","duration":"105.272753ms","start":"2026-05-26T05:56:14.671954Z","end":"2026-05-26T05:56:14.777226Z","steps":["trace[1973757064] 'agreement among raft nodes before linearized reading' (duration: 105.134709ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:22.825742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.903206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-05-26T05:56:22.825822Z","caller":"traceutil/trace.go:171","msg":"trace[754031342] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2399; }","duration":"312.033638ms","start":"2026-05-26T05:56:22.513773Z","end":"2026-05-26T05:56:22.825807Z","steps":["trace[754031342] 'range keys from in-memory index tree' (duration: 311.766182ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:22.825939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:56:22.513742Z","time spent":"312.187822ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":495,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-05-26T05:56:23.300615Z","caller":"traceutil/trace.go:171","msg":"trace[1936976315] linearizableReadLoop","detail":"{readStateIndex:2498; appliedIndex:2497; }","duration":"235.748262ms","start":"2026-05-26T05:56:23.064849Z","end":"2026-05-26T05:56:23.300597Z","steps":["trace[1936976315] 'read index received' (duration: 235.536007ms)","trace[1936976315] 'applied index is now lower than readState.Index' (duration: 211.375µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:56:23.30069Z","caller":"traceutil/trace.go:171","msg":"trace[347631457] transaction","detail":"{read_only:false; response_revision:2401; number_of_response:1; }","duration":"251.953036ms","start":"2026-05-26T05:56:23.048694Z","end":"2026-05-26T05:56:23.300647Z","steps":["trace[347631457] 'process raft request' (duration: 251.753132ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:23.30077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.908186ms","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-05-26T05:56:23.300799Z","caller":"traceutil/trace.go:171","msg":"trace[1488158809] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2401; }","duration":"235.981018ms","start":"2026-05-26T05:56:23.064807Z","end":"2026-05-26T05:56:23.300788Z","steps":["trace[1488158809] 'agreement among raft nodes before linearized reading' (duration: 235.864415ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:30.734928Z","caller":"traceutil/trace.go:171","msg":"trace[94993344] linearizableReadLoop","detail":"{readStateIndex:2540; appliedIndex:2539; }","duration":"275.768469ms","start":"2026-05-26T05:56:30.459139Z","end":"2026-05-26T05:56:30.734908Z","steps":["trace[94993344] 'read index received' (duration: 275.632316ms)","trace[94993344] 'applied index is now lower than readState.Index' (duration: 135.063µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:56:30.73513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.978495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-05-26T05:56:30.735184Z","caller":"traceutil/trace.go:171","msg":"trace[1341046050] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2441; }","duration":"276.065707ms","start":"2026-05-26T05:56:30.459106Z","end":"2026-05-26T05:56:30.735172Z","steps":["trace[1341046050] 'agreement among raft nodes before linearized reading' (duration: 275.913053ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:30.735523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.091329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-05-26T05:56:30.735604Z","caller":"traceutil/trace.go:171","msg":"trace[1552429630] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2441; }","duration":"244.215582ms","start":"2026-05-26T05:56:30.491371Z","end":"2026-05-26T05:56:30.735587Z","steps":["trace[1552429630] 'agreement among raft nodes before linearized reading' (duration: 244.012688ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:34.055681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.600878ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:56:34.055754Z","caller":"traceutil/trace.go:171","msg":"trace[2037095496] linearizableReadLoop","detail":"{readStateIndex:2562; appliedIndex:2561; }","duration":"331.91561ms","start":"2026-05-26T05:56:33.723827Z","end":"2026-05-26T05:56:34.055743Z","steps":["trace[2037095496] 'read index received' (duration: 137.132967ms)","trace[2037095496] 'applied index is now lower than readState.Index' (duration: 194.781753ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:56:34.056043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.198067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-26T05:56:34.056117Z","caller":"traceutil/trace.go:171","msg":"trace[741293836] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2462; }","duration":"332.309959ms","start":"2026-05-26T05:56:33.723792Z","end":"2026-05-26T05:56:34.056102Z","steps":["trace[741293836] 'agreement among raft nodes before linearized reading' (duration: 332.088254ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:34.05606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.014948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-05-26T05:56:34.056162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:56:33.723777Z","time spent":"332.375791ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-26T05:56:34.056082Z","caller":"traceutil/trace.go:171","msg":"trace[1667218318] transaction","detail":"{read_only:false; response_revision:2462; number_of_response:1; }","duration":"339.486549ms","start":"2026-05-26T05:56:33.716563Z","end":"2026-05-26T05:56:34.05605Z","steps":["trace[1667218318] 'process raft request' (duration: 144.457431ms)","trace[1667218318] 'compare' (duration: 194.482755ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:56:34.05619Z","caller":"traceutil/trace.go:171","msg":"trace[218207003] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2462; }","duration":"195.176762ms","start":"2026-05-26T05:56:33.860999Z","end":"2026-05-26T05:56:34.056176Z","steps":["trace[218207003] 'agreement among raft nodes before linearized reading' (duration: 195.007678ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:34.056243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.204486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-26T05:56:34.056332Z","caller":"traceutil/trace.go:171","msg":"trace[2001751047] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2462; }","duration":"139.341079ms","start":"2026-05-26T05:56:33.91697Z","end":"2026-05-26T05:56:34.056311Z","steps":["trace[2001751047] 'agreement among raft nodes before linearized reading' (duration: 139.095684ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:34.056409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:56:33.716551Z","time spent":"339.679664ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:56:34.354114Z","caller":"traceutil/trace.go:171","msg":"trace[589915298] transaction","detail":"{read_only:false; response_revision:2463; number_of_response:1; }","duration":"294.837032ms","start":"2026-05-26T05:56:34.059226Z","end":"2026-05-26T05:56:34.354063Z","steps":["trace[589915298] 'process raft request' (duration: 208.997939ms)","trace[589915298] 'compare' (duration: 85.682149ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:56:34.446465Z","caller":"traceutil/trace.go:171","msg":"trace[778962214] transaction","detail":"{read_only:false; response_revision:2464; number_of_response:1; }","duration":"386.584494ms","start":"2026-05-26T05:56:34.059812Z","end":"2026-05-26T05:56:34.446397Z","steps":["trace[778962214] 'process raft request' (duration: 386.282967ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:34.446542Z","caller":"traceutil/trace.go:171","msg":"trace[949424556] transaction","detail":"{read_only:false; response_revision:2465; number_of_response:1; }","duration":"386.282137ms","start":"2026-05-26T05:56:34.060239Z","end":"2026-05-26T05:56:34.446522Z","steps":["trace[949424556] 'process raft request' (duration: 385.95598ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:34.446618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:56:34.059797Z","time spent":"386.744818ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:56:34.446682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:56:34.060235Z","time spent":"386.357339ms","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:56:34.664709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.804981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:500 ","response":"range_response_count:5 size:1788"} {"level":"info","ts":"2026-05-26T05:56:34.664784Z","caller":"traceutil/trace.go:171","msg":"trace[188343722] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:5; response_revision:2465; }","duration":"112.930124ms","start":"2026-05-26T05:56:34.551837Z","end":"2026-05-26T05:56:34.664767Z","steps":["trace[188343722] 'range keys from in-memory index tree' (duration: 112.658437ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:35.500322Z","caller":"traceutil/trace.go:171","msg":"trace[644266928] transaction","detail":"{read_only:false; response_revision:2468; number_of_response:1; }","duration":"107.227729ms","start":"2026-05-26T05:56:35.393057Z","end":"2026-05-26T05:56:35.500285Z","steps":["trace[644266928] 'process raft request' (duration: 56.359894ms)","trace[644266928] 'compare' (duration: 50.613639ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:56:35.645232Z","caller":"traceutil/trace.go:171","msg":"trace[757855381] transaction","detail":"{read_only:false; response_revision:2469; number_of_response:1; }","duration":"116.841446ms","start":"2026-05-26T05:56:35.528358Z","end":"2026-05-26T05:56:35.645199Z","steps":["trace[757855381] 'process raft request' (duration: 110.601189ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:40.199952Z","caller":"traceutil/trace.go:171","msg":"trace[729213295] transaction","detail":"{read_only:false; response_revision:2489; number_of_response:1; }","duration":"111.115102ms","start":"2026-05-26T05:56:40.088808Z","end":"2026-05-26T05:56:40.199923Z","steps":["trace[729213295] 'process raft request' (duration: 110.927007ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:40.365984Z","caller":"traceutil/trace.go:171","msg":"trace[7392717] linearizableReadLoop","detail":"{readStateIndex:2591; appliedIndex:2590; }","duration":"166.073573ms","start":"2026-05-26T05:56:40.199876Z","end":"2026-05-26T05:56:40.36595Z","steps":["trace[7392717] 'read index received' (duration: 165.830227ms)","trace[7392717] 'applied index is now lower than readState.Index' (duration: 242.356µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:56:40.366018Z","caller":"traceutil/trace.go:171","msg":"trace[1472362766] transaction","detail":"{read_only:false; response_revision:2490; number_of_response:1; }","duration":"218.441913ms","start":"2026-05-26T05:56:40.147546Z","end":"2026-05-26T05:56:40.365988Z","steps":["trace[1472362766] 'process raft request' (duration: 218.258938ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:40.366161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.372325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:attachdetach-controller\" ","response":"range_response_count:1 size:952"} {"level":"info","ts":"2026-05-26T05:56:40.366223Z","caller":"traceutil/trace.go:171","msg":"trace[1306928515] range","detail":"{range_begin:/registry/clusterroles/system:controller:attachdetach-controller; range_end:; response_count:1; response_revision:2490; }","duration":"181.475817ms","start":"2026-05-26T05:56:40.184731Z","end":"2026-05-26T05:56:40.366207Z","steps":["trace[1306928515] 'agreement among raft nodes before linearized reading' (duration: 181.347984ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:40.594733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.183987ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:56:40.594891Z","caller":"traceutil/trace.go:171","msg":"trace[1968812808] transaction","detail":"{read_only:false; response_revision:2491; number_of_response:1; }","duration":"210.821413ms","start":"2026-05-26T05:56:40.384045Z","end":"2026-05-26T05:56:40.594866Z","steps":["trace[1968812808] 'process raft request' (duration: 41.434131ms)","trace[1968812808] 'compare' (duration: 169.091695ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:56:40.595538Z","caller":"traceutil/trace.go:171","msg":"trace[1205173130] linearizableReadLoop","detail":"{readStateIndex:2593; appliedIndex:2592; }","duration":"151.60738ms","start":"2026-05-26T05:56:40.443913Z","end":"2026-05-26T05:56:40.59552Z","steps":["trace[1205173130] 'read index received' (duration: 151.459507ms)","trace[1205173130] 'applied index is now lower than readState.Index' (duration: 146.853µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:56:40.595618Z","caller":"traceutil/trace.go:171","msg":"trace[736124959] transaction","detail":"{read_only:false; response_revision:2492; number_of_response:1; }","duration":"163.295657ms","start":"2026-05-26T05:56:40.432313Z","end":"2026-05-26T05:56:40.595609Z","steps":["trace[736124959] 'process raft request' (duration: 163.109803ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:40.595716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.797144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:56:40.595901Z","caller":"traceutil/trace.go:171","msg":"trace[378559987] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2492; }","duration":"152.00836ms","start":"2026-05-26T05:56:40.443876Z","end":"2026-05-26T05:56:40.595884Z","steps":["trace[378559987] 'agreement among raft nodes before linearized reading' (duration: 151.789115ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:40.596313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.216621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:700"} {"level":"info","ts":"2026-05-26T05:56:40.596402Z","caller":"traceutil/trace.go:171","msg":"trace[1318785545] range","detail":"{range_begin:/registry/clusterroles/system:controller:clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:2492; }","duration":"151.305843ms","start":"2026-05-26T05:56:40.445055Z","end":"2026-05-26T05:56:40.59636Z","steps":["trace[1318785545] 'agreement among raft nodes before linearized reading' (duration: 151.129049ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:40.596684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.881079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:cronjob-controller\" ","response":"range_response_count:1 size:837"} {"level":"info","ts":"2026-05-26T05:56:40.596743Z","caller":"traceutil/trace.go:171","msg":"trace[192466231] range","detail":"{range_begin:/registry/clusterroles/system:controller:cronjob-controller; range_end:; response_count:1; response_revision:2492; }","duration":"149.954261ms","start":"2026-05-26T05:56:40.446775Z","end":"2026-05-26T05:56:40.596729Z","steps":["trace[192466231] 'agreement among raft nodes before linearized reading' (duration: 149.853588ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:40.597457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.589224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.235\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-26T05:56:40.597539Z","caller":"traceutil/trace.go:171","msg":"trace[749004043] range","detail":"{range_begin:/registry/masterleases/199.204.45.235; range_end:; response_count:1; response_revision:2492; }","duration":"145.779223ms","start":"2026-05-26T05:56:40.451744Z","end":"2026-05-26T05:56:40.597523Z","steps":["trace[749004043] 'agreement among raft nodes before linearized reading' (duration: 144.530213ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:40.792993Z","caller":"traceutil/trace.go:171","msg":"trace[1323468400] transaction","detail":"{read_only:false; response_revision:2494; number_of_response:1; }","duration":"126.980037ms","start":"2026-05-26T05:56:40.665987Z","end":"2026-05-26T05:56:40.792967Z","steps":["trace[1323468400] 'process raft request' (duration: 126.908575ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:40.793092Z","caller":"traceutil/trace.go:171","msg":"trace[2056246977] linearizableReadLoop","detail":"{readStateIndex:2595; appliedIndex:2594; }","duration":"128.036882ms","start":"2026-05-26T05:56:40.665026Z","end":"2026-05-26T05:56:40.793063Z","steps":["trace[2056246977] 'read index received' (duration: 30.620445ms)","trace[2056246977] 'applied index is now lower than readState.Index' (duration: 97.413447ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:56:40.793395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.436307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:cronjob-controller\" ","response":"range_response_count:1 size:837"} {"level":"warn","ts":"2026-05-26T05:56:40.793444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.366167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:700"} {"level":"info","ts":"2026-05-26T05:56:40.793451Z","caller":"traceutil/trace.go:171","msg":"trace[807363121] range","detail":"{range_begin:/registry/clusterroles/system:controller:cronjob-controller; range_end:; response_count:1; response_revision:2494; }","duration":"127.51556ms","start":"2026-05-26T05:56:40.66592Z","end":"2026-05-26T05:56:40.793436Z","steps":["trace[807363121] 'agreement among raft nodes before linearized reading' (duration: 127.380087ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:40.793484Z","caller":"traceutil/trace.go:171","msg":"trace[1812274628] range","detail":"{range_begin:/registry/clusterroles/system:controller:clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:2494; }","duration":"130.450069ms","start":"2026-05-26T05:56:40.663023Z","end":"2026-05-26T05:56:40.793473Z","steps":["trace[1812274628] 'agreement among raft nodes before linearized reading' (duration: 130.184402ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:40.793076Z","caller":"traceutil/trace.go:171","msg":"trace[1235229669] transaction","detail":"{read_only:false; response_revision:2493; number_of_response:1; }","duration":"190.441469ms","start":"2026-05-26T05:56:40.602583Z","end":"2026-05-26T05:56:40.793024Z","steps":["trace[1235229669] 'process raft request' (duration: 93.054593ms)","trace[1235229669] 'compare' (duration: 97.12195ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:56:40.793487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.874381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/csi-e9f4c4113ca33d310cfeeec954f9447387fe690054bec175a15f040155dc2a33\" ","response":"range_response_count:1 size:651"} {"level":"info","ts":"2026-05-26T05:56:40.793537Z","caller":"traceutil/trace.go:171","msg":"trace[174994434] range","detail":"{range_begin:/registry/volumeattachments/csi-e9f4c4113ca33d310cfeeec954f9447387fe690054bec175a15f040155dc2a33; range_end:; response_count:1; response_revision:2494; }","duration":"125.960763ms","start":"2026-05-26T05:56:40.667562Z","end":"2026-05-26T05:56:40.793523Z","steps":["trace[174994434] 'agreement among raft nodes before linearized reading' (duration: 125.746998ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:43.058255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.97485ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:56:43.058348Z","caller":"traceutil/trace.go:171","msg":"trace[1796024650] linearizableReadLoop","detail":"{readStateIndex:2607; appliedIndex:2606; }","duration":"116.941596ms","start":"2026-05-26T05:56:42.941392Z","end":"2026-05-26T05:56:43.058333Z","steps":["trace[1796024650] 'read index received' (duration: 15.756841ms)","trace[1796024650] 'applied index is now lower than readState.Index' (duration: 101.183665ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:56:43.058441Z","caller":"traceutil/trace.go:171","msg":"trace[906635989] transaction","detail":"{read_only:false; response_revision:2505; number_of_response:1; }","duration":"138.465474ms","start":"2026-05-26T05:56:42.919964Z","end":"2026-05-26T05:56:43.058429Z","steps":["trace[906635989] 'process raft request' (duration: 37.238708ms)","trace[906635989] 'compare' (duration: 100.860477ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:56:43.058606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.200693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/kubeadm:kubelet-bootstrap\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-26T05:56:43.058645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.167172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:node-controller\" ","response":"range_response_count:1 size:837"} {"level":"info","ts":"2026-05-26T05:56:43.058738Z","caller":"traceutil/trace.go:171","msg":"trace[2020858656] range","detail":"{range_begin:/registry/clusterrolebindings/kubeadm:kubelet-bootstrap; range_end:; response_count:1; response_revision:2505; }","duration":"117.335755ms","start":"2026-05-26T05:56:42.941354Z","end":"2026-05-26T05:56:43.05869Z","steps":["trace[2020858656] 'agreement among raft nodes before linearized reading' (duration: 117.189612ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:43.058722Z","caller":"traceutil/trace.go:171","msg":"trace[1098708736] range","detail":"{range_begin:/registry/clusterroles/system:controller:node-controller; range_end:; response_count:1; response_revision:2505; }","duration":"109.302386ms","start":"2026-05-26T05:56:42.949402Z","end":"2026-05-26T05:56:43.058705Z","steps":["trace[1098708736] 'agreement among raft nodes before linearized reading' (duration: 109.154732ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:43.957318Z","caller":"traceutil/trace.go:171","msg":"trace[915351932] transaction","detail":"{read_only:false; response_revision:2509; number_of_response:1; }","duration":"205.770912ms","start":"2026-05-26T05:56:43.751522Z","end":"2026-05-26T05:56:43.957292Z","steps":["trace[915351932] 'process raft request' (duration: 205.574587ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:43.986843Z","caller":"traceutil/trace.go:171","msg":"trace[765595755] linearizableReadLoop","detail":"{readStateIndex:2612; appliedIndex:2610; }","duration":"173.167473ms","start":"2026-05-26T05:56:43.813651Z","end":"2026-05-26T05:56:43.986818Z","steps":["trace[765595755] 'read index received' (duration: 143.430912ms)","trace[765595755] 'applied index is now lower than readState.Index' (duration: 29.735431ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:56:43.986934Z","caller":"traceutil/trace.go:171","msg":"trace[2040389736] transaction","detail":"{read_only:false; response_revision:2510; number_of_response:1; }","duration":"173.514231ms","start":"2026-05-26T05:56:43.813381Z","end":"2026-05-26T05:56:43.986896Z","steps":["trace[2040389736] 'process raft request' (duration: 173.309466ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:43.987075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.403409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:pvc-protection-controller\" ","response":"range_response_count:1 size:728"} {"level":"warn","ts":"2026-05-26T05:56:43.987277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.724569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:basic-user\" ","response":"range_response_count:1 size:697"} {"level":"info","ts":"2026-05-26T05:56:43.987532Z","caller":"traceutil/trace.go:171","msg":"trace[940365431] range","detail":"{range_begin:/registry/clusterroles/system:controller:pvc-protection-controller; range_end:; response_count:1; response_revision:2510; }","duration":"173.855389ms","start":"2026-05-26T05:56:43.813627Z","end":"2026-05-26T05:56:43.987482Z","steps":["trace[940365431] 'agreement among raft nodes before linearized reading' (duration: 173.362467ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:43.987608Z","caller":"traceutil/trace.go:171","msg":"trace[573986848] range","detail":"{range_begin:/registry/clusterrolebindings/system:basic-user; range_end:; response_count:1; response_revision:2510; }","duration":"172.262682ms","start":"2026-05-26T05:56:43.815325Z","end":"2026-05-26T05:56:43.987588Z","steps":["trace[573986848] 'agreement among raft nodes before linearized reading' (duration: 171.908583ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:44.189743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.365282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:replicaset-controller\" ","response":"range_response_count:1 size:843"} {"level":"info","ts":"2026-05-26T05:56:44.189826Z","caller":"traceutil/trace.go:171","msg":"trace[320184810] range","detail":"{range_begin:/registry/clusterroles/system:controller:replicaset-controller; range_end:; response_count:1; response_revision:2510; }","duration":"121.465504ms","start":"2026-05-26T05:56:44.068342Z","end":"2026-05-26T05:56:44.189808Z","steps":["trace[320184810] 'range keys from in-memory index tree' (duration: 121.227438ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:44.189857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.782047ms","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-05-26T05:56:44.189926Z","caller":"traceutil/trace.go:171","msg":"trace[2007031054] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:attachdetach-controller; range_end:; response_count:1; response_revision:2510; }","duration":"117.891ms","start":"2026-05-26T05:56:44.072017Z","end":"2026-05-26T05:56:44.189908Z","steps":["trace[2007031054] 'range keys from in-memory index tree' (duration: 117.690025ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:44.457906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.231887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:certificate-controller\" ","response":"range_response_count:1 size:763"} {"level":"info","ts":"2026-05-26T05:56:44.457994Z","caller":"traceutil/trace.go:171","msg":"trace[1788394146] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:certificate-controller; range_end:; response_count:1; response_revision:2511; }","duration":"101.35626ms","start":"2026-05-26T05:56:44.356615Z","end":"2026-05-26T05:56:44.457971Z","steps":["trace[1788394146] 'range keys from in-memory index tree' (duration: 101.105224ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:46.794916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.172632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:job-controller\" ","response":"range_response_count:1 size:731"} {"level":"info","ts":"2026-05-26T05:56:46.795004Z","caller":"traceutil/trace.go:171","msg":"trace[1185266774] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:job-controller; range_end:; response_count:1; response_revision:2521; }","duration":"128.307325ms","start":"2026-05-26T05:56:46.66668Z","end":"2026-05-26T05:56:46.794987Z","steps":["trace[1185266774] 'range keys from in-memory index tree' (duration: 128.066019ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:46.795056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.328462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:heapster\" ","response":"range_response_count:1 size:638"} {"level":"info","ts":"2026-05-26T05:56:46.795143Z","caller":"traceutil/trace.go:171","msg":"trace[1253639450] range","detail":"{range_begin:/registry/clusterroles/system:heapster; range_end:; response_count:1; response_revision:2521; }","duration":"113.456485ms","start":"2026-05-26T05:56:46.681668Z","end":"2026-05-26T05:56:46.795125Z","steps":["trace[1253639450] 'range keys from in-memory index tree' (duration: 113.22899ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:47.901014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.166375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:replication-controller\" ","response":"range_response_count:1 size:763"} {"level":"warn","ts":"2026-05-26T05:56:47.901069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.878101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:kube-dns\" ","response":"range_response_count:1 size:576"} {"level":"info","ts":"2026-05-26T05:56:47.90112Z","caller":"traceutil/trace.go:171","msg":"trace[2128149554] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:replication-controller; range_end:; response_count:1; response_revision:2525; }","duration":"115.297688ms","start":"2026-05-26T05:56:47.785785Z","end":"2026-05-26T05:56:47.901082Z","steps":["trace[2128149554] 'range keys from in-memory index tree' (duration: 115.067933ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:47.90115Z","caller":"traceutil/trace.go:171","msg":"trace[573676851] range","detail":"{range_begin:/registry/clusterroles/system:kube-dns; range_end:; response_count:1; response_revision:2525; }","duration":"109.990473ms","start":"2026-05-26T05:56:47.791139Z","end":"2026-05-26T05:56:47.90113Z","steps":["trace[573676851] 'range keys from in-memory index tree' (duration: 109.804859ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:47.907749Z","caller":"traceutil/trace.go:171","msg":"trace[1946559229] transaction","detail":"{read_only:false; response_revision:2526; number_of_response:1; }","duration":"103.680114ms","start":"2026-05-26T05:56:47.804049Z","end":"2026-05-26T05:56:47.907729Z","steps":["trace[1946559229] 'process raft request' (duration: 103.334086ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:49.680793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.128009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:service-account-issuer-discovery\" ","response":"range_response_count:1 size:701"} {"level":"info","ts":"2026-05-26T05:56:49.680885Z","caller":"traceutil/trace.go:171","msg":"trace[920926132] range","detail":"{range_begin:/registry/clusterroles/system:service-account-issuer-discovery; range_end:; response_count:1; response_revision:2534; }","duration":"105.263701ms","start":"2026-05-26T05:56:49.575602Z","end":"2026-05-26T05:56:49.680866Z","steps":["trace[920926132] 'range keys from in-memory index tree' (duration: 105.020386ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:50.126235Z","caller":"traceutil/trace.go:171","msg":"trace[2142482908] linearizableReadLoop","detail":"{readStateIndex:2640; appliedIndex:2639; }","duration":"100.040759ms","start":"2026-05-26T05:56:50.026173Z","end":"2026-05-26T05:56:50.126214Z","steps":["trace[2142482908] 'read index received' (duration: 99.891535ms)","trace[2142482908] 'applied index is now lower than readState.Index' (duration: 148.144µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:56:50.12627Z","caller":"traceutil/trace.go:171","msg":"trace[1030391633] transaction","detail":"{read_only:false; response_revision:2537; number_of_response:1; }","duration":"102.677631ms","start":"2026-05-26T05:56:50.02356Z","end":"2026-05-26T05:56:50.126237Z","steps":["trace[1030391633] 'process raft request' (duration: 102.524288ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:50.126404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.206732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:volume-scheduler\" ","response":"range_response_count:1 size:723"} {"level":"info","ts":"2026-05-26T05:56:50.126479Z","caller":"traceutil/trace.go:171","msg":"trace[1459625900] range","detail":"{range_begin:/registry/clusterroles/system:volume-scheduler; range_end:; response_count:1; response_revision:2537; }","duration":"100.306176ms","start":"2026-05-26T05:56:50.026155Z","end":"2026-05-26T05:56:50.126461Z","steps":["trace[1459625900] 'agreement among raft nodes before linearized reading' (duration: 100.126581ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:52.277092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.438462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-26T05:56:52.277188Z","caller":"traceutil/trace.go:171","msg":"trace[281038390] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2545; }","duration":"146.599456ms","start":"2026-05-26T05:56:52.130568Z","end":"2026-05-26T05:56:52.277167Z","steps":["trace[281038390] 'range keys from in-memory index tree' (duration: 146.224577ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:52.601966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.785645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/default/\" range_end:\"/registry/cronjobs/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:56:52.602016Z","caller":"traceutil/trace.go:171","msg":"trace[1813702818] range","detail":"{range_begin:/registry/cronjobs/default/; range_end:/registry/cronjobs/default0; response_count:0; response_revision:2547; }","duration":"161.850806ms","start":"2026-05-26T05:56:52.440154Z","end":"2026-05-26T05:56:52.602005Z","steps":["trace[1813702818] 'range keys from in-memory index tree' (duration: 161.753554ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:52.602029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.338171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/envoy-gateway-system/kube-root-ca.crt\" ","response":"range_response_count:1 size:1764"} {"level":"warn","ts":"2026-05-26T05:56:52.602009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.707716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/envoy-gateway-system/\" range_end:\"/registry/cronjobs/envoy-gateway-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:56:52.60206Z","caller":"traceutil/trace.go:171","msg":"trace[119630919] range","detail":"{range_begin:/registry/configmaps/envoy-gateway-system/kube-root-ca.crt; range_end:; response_count:1; response_revision:2547; }","duration":"163.404523ms","start":"2026-05-26T05:56:52.438648Z","end":"2026-05-26T05:56:52.602052Z","steps":["trace[119630919] 'range keys from in-memory index tree' (duration: 163.229958ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:56:52.6021Z","caller":"traceutil/trace.go:171","msg":"trace[897734666] range","detail":"{range_begin:/registry/cronjobs/envoy-gateway-system/; range_end:/registry/cronjobs/envoy-gateway-system0; response_count:0; response_revision:2547; }","duration":"148.832849ms","start":"2026-05-26T05:56:52.453242Z","end":"2026-05-26T05:56:52.602075Z","steps":["trace[897734666] 'range keys from in-memory index tree' (duration: 148.665306ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:56:52.602173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.43794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/envoy-gateway-system/envoy-gateway-config\" ","response":"range_response_count:1 size:1550"} {"level":"info","ts":"2026-05-26T05:56:52.602265Z","caller":"traceutil/trace.go:171","msg":"trace[1771282710] range","detail":"{range_begin:/registry/configmaps/envoy-gateway-system/envoy-gateway-config; range_end:; response_count:1; response_revision:2547; }","duration":"151.559994ms","start":"2026-05-26T05:56:52.450686Z","end":"2026-05-26T05:56:52.602246Z","steps":["trace[1771282710] 'range keys from in-memory index tree' (duration: 151.303778ms)"],"step_count":1}