{"level":"warn","ts":"2026-04-10T01:05:02.980079Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-10T01:05:02.980159Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.57: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.57:2380","--initial-cluster=instance=https://199.204.45.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.57:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-10T01:05:02.980222Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-10T01:05:02.980235Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-04-10T01:05:02.980258Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-10T01:05:02.98106Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"]} {"level":"info","ts":"2026-04-10T01:05:02.98115Z","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.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.57:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-10T01:05:02.986441Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.058632ms"} {"level":"info","ts":"2026-04-10T01:05:02.993521Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b6478f0ac5aeb8e1","cluster-id":"6c58cff80d4a5b62"} {"level":"info","ts":"2026-04-10T01:05:02.993593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=()"} {"level":"info","ts":"2026-04-10T01:05:02.993622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 0"} {"level":"info","ts":"2026-04-10T01:05:02.993636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b6478f0ac5aeb8e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-10T01:05:02.993652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 1"} {"level":"info","ts":"2026-04-10T01:05:02.9937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"warn","ts":"2026-04-10T01:05:03.00405Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-10T01:05:03.012406Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-10T01:05:03.013825Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-10T01:05:03.017571Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b6478f0ac5aeb8e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-10T01:05:03.017691Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b6478f0ac5aeb8e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-10T01:05:03.018589Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-10T01:05:03.018752Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-10T01:05:03.018779Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-10T01:05:03.019985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"info","ts":"2026-04-10T01:05:03.023245Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","added-peer-id":"b6478f0ac5aeb8e1","added-peer-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-04-10T01:05:03.025206Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-10T01:05:03.0254Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-04-10T01:05:03.025462Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-04-10T01:05:03.025615Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-10T01:05:03.025392Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b6478f0ac5aeb8e1","initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-10T01:05:03.194619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 is starting a new election at term 1"} {"level":"info","ts":"2026-04-10T01:05:03.194728Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-10T01:05:03.194768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgPreVoteResp from b6478f0ac5aeb8e1 at term 1"} {"level":"info","ts":"2026-04-10T01:05:03.194791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became candidate at term 2"} {"level":"info","ts":"2026-04-10T01:05:03.194805Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgVoteResp from b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-04-10T01:05:03.194824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became leader at term 2"} {"level":"info","ts":"2026-04-10T01:05:03.19485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b6478f0ac5aeb8e1 elected leader b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-04-10T01:05:03.195926Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b6478f0ac5aeb8e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.57:2379]}","request-path":"/0/members/b6478f0ac5aeb8e1/attributes","cluster-id":"6c58cff80d4a5b62","publish-timeout":"7s"} {"level":"info","ts":"2026-04-10T01:05:03.195975Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T01:05:03.196509Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T01:05:03.196641Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T01:05:03.198778Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T01:05:03.198883Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T01:05:03.198911Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T01:05:03.200689Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-10T01:05:03.203232Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.57:2379"} {"level":"info","ts":"2026-04-10T01:05:03.203543Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-10T01:05:03.20358Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-10T01:05:05.269203Z","caller":"traceutil/trace.go:171","msg":"trace[381128728] linearizableReadLoop","detail":"{readStateIndex:7; appliedIndex:5; }","duration":"274.008399ms","start":"2026-04-10T01:05:04.995166Z","end":"2026-04-10T01:05:05.269174Z","steps":["trace[381128728] 'read index received' (duration: 273.831094ms)","trace[381128728] 'applied index is now lower than readState.Index' (duration: 176.125µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:05:05.269344Z","caller":"traceutil/trace.go:171","msg":"trace[1749624329] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"309.71688ms","start":"2026-04-10T01:05:04.959601Z","end":"2026-04-10T01:05:05.269318Z","steps":["trace[1749624329] 'process raft request' (duration: 309.362391ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:05.269486Z","caller":"traceutil/trace.go:171","msg":"trace[1388321658] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"298.841383ms","start":"2026-04-10T01:05:04.970616Z","end":"2026-04-10T01:05:05.269458Z","steps":["trace[1388321658] 'process raft request' (duration: 298.510254ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:05.269721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.066969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-10T01:05:05.269727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.020708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-10T01:05:05.269804Z","caller":"traceutil/trace.go:171","msg":"trace[664247912] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:4; }","duration":"310.179872ms","start":"2026-04-10T01:05:04.959612Z","end":"2026-04-10T01:05:05.269791Z","steps":["trace[664247912] 'agreement among raft nodes before linearized reading' (duration: 309.710529ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:05.269862Z","caller":"traceutil/trace.go:171","msg":"trace[1695934087] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:4; }","duration":"310.194613ms","start":"2026-04-10T01:05:04.959638Z","end":"2026-04-10T01:05:05.269833Z","steps":["trace[1695934087] 'agreement among raft nodes before linearized reading' (duration: 309.678759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:05.269853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:04.959607Z","time spent":"310.236433ms","remote":"127.0.0.1:49880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-04-10T01:05:05.269864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:04.959588Z","time spent":"309.872394ms","remote":"127.0.0.1:50094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T01:05:05.269854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.225383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-10T01:05:05.269919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:04.959624Z","time spent":"310.284245ms","remote":"127.0.0.1:50098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"info","ts":"2026-04-10T01:05:05.270014Z","caller":"traceutil/trace.go:171","msg":"trace[1120421150] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:4; }","duration":"310.384857ms","start":"2026-04-10T01:05:04.959566Z","end":"2026-04-10T01:05:05.269951Z","steps":["trace[1120421150] 'agreement among raft nodes before linearized reading' (duration: 310.031118ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:05.270071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:04.959561Z","time spent":"310.499331ms","remote":"127.0.0.1:50226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-04-10T01:05:05.33691Z","caller":"traceutil/trace.go:171","msg":"trace[641884177] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"309.521092ms","start":"2026-04-10T01:05:05.027367Z","end":"2026-04-10T01:05:05.336888Z","steps":["trace[641884177] 'process raft request' (duration: 309.44957ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:05.336933Z","caller":"traceutil/trace.go:171","msg":"trace[1018151206] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"309.41907ms","start":"2026-04-10T01:05:05.027486Z","end":"2026-04-10T01:05:05.336905Z","steps":["trace[1018151206] 'process raft request' (duration: 309.348498ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:05.337077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:05.027468Z","time spent":"309.541763ms","remote":"127.0.0.1:50360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T01:05:05.337141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:05.027354Z","time spent":"309.615625ms","remote":"127.0.0.1:50360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T01:05:05.337323Z","caller":"traceutil/trace.go:171","msg":"trace[750263198] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"310.436646ms","start":"2026-04-10T01:05:05.026872Z","end":"2026-04-10T01:05:05.337308Z","steps":["trace[750263198] 'process raft request' (duration: 309.865591ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:05.337419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.176954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-10T01:05:05.337458Z","caller":"traceutil/trace.go:171","msg":"trace[1914137078] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"260.262996ms","start":"2026-04-10T01:05:05.077184Z","end":"2026-04-10T01:05:05.337447Z","steps":["trace[1914137078] 'agreement among raft nodes before linearized reading' (duration: 260.158463ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:05.337528Z","caller":"traceutil/trace.go:171","msg":"trace[1191822435] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"311.898166ms","start":"2026-04-10T01:05:05.025608Z","end":"2026-04-10T01:05:05.337506Z","steps":["trace[1191822435] 'process raft request' (duration: 311.010232ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:05.337604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.240312ms","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":"info","ts":"2026-04-10T01:05:05.337634Z","caller":"traceutil/trace.go:171","msg":"trace[315952041] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"307.300634ms","start":"2026-04-10T01:05:05.030324Z","end":"2026-04-10T01:05:05.337625Z","steps":["trace[315952041] 'agreement among raft nodes before linearized reading' (duration: 307.246352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:05.337655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:05.030312Z","time spent":"307.337234ms","remote":"127.0.0.1:49922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-04-10T01:05:05.337661Z","caller":"traceutil/trace.go:171","msg":"trace[1175976963] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"310.5328ms","start":"2026-04-10T01:05:05.027093Z","end":"2026-04-10T01:05:05.337626Z","steps":["trace[1175976963] 'process raft request' (duration: 309.681307ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:05.337521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:05.026853Z","time spent":"310.509439ms","remote":"127.0.0.1:50360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T01:05:05.33767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:05.025588Z","time spent":"311.997438ms","remote":"127.0.0.1:50274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T01:05:05.337756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:05.027085Z","time spent":"310.624772ms","remote":"127.0.0.1:50360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T01:05:05.3378Z","caller":"traceutil/trace.go:171","msg":"trace[1823835561] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"310.513099ms","start":"2026-04-10T01:05:05.027274Z","end":"2026-04-10T01:05:05.337787Z","steps":["trace[1823835561] 'process raft request' (duration: 309.521073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:05.337879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:05.027242Z","time spent":"310.595571ms","remote":"127.0.0.1:50360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T01:05:05.337879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.677642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-10T01:05:05.338032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.306139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-10T01:05:05.338056Z","caller":"traceutil/trace.go:171","msg":"trace[1412099355] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"322.917818ms","start":"2026-04-10T01:05:05.01511Z","end":"2026-04-10T01:05:05.338027Z","steps":["trace[1412099355] 'agreement among raft nodes before linearized reading' (duration: 322.61771ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:05.338076Z","caller":"traceutil/trace.go:171","msg":"trace[1649482812] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:0; response_revision:10; }","duration":"314.375831ms","start":"2026-04-10T01:05:05.023689Z","end":"2026-04-10T01:05:05.338065Z","steps":["trace[1649482812] 'agreement among raft nodes before linearized reading' (duration: 314.269099ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:05.338107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:05.023664Z","time spent":"314.437803ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.57\" "} {"level":"warn","ts":"2026-04-10T01:05:05.338117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:05.015092Z","time spent":"323.015991ms","remote":"127.0.0.1:49954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-10T01:05:05.338283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.261932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-10T01:05:05.338309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.132054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-10T01:05:05.338321Z","caller":"traceutil/trace.go:171","msg":"trace[1230142705] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"313.309923ms","start":"2026-04-10T01:05:05.025001Z","end":"2026-04-10T01:05:05.338311Z","steps":["trace[1230142705] 'agreement among raft nodes before linearized reading' (duration: 313.250831ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:05.338338Z","caller":"traceutil/trace.go:171","msg":"trace[1032614115] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"323.162104ms","start":"2026-04-10T01:05:05.015168Z","end":"2026-04-10T01:05:05.33833Z","steps":["trace[1032614115] 'agreement among raft nodes before linearized reading' (duration: 323.111403ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:05.338352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:05.024995Z","time spent":"313.351534ms","remote":"127.0.0.1:49954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-10T01:05:05.338363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:05.015161Z","time spent":"323.196865ms","remote":"127.0.0.1:49954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-10T01:05:05.338316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.070562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-10T01:05:05.338411Z","caller":"traceutil/trace.go:171","msg":"trace[885218718] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"323.164364ms","start":"2026-04-10T01:05:05.015228Z","end":"2026-04-10T01:05:05.338393Z","steps":["trace[885218718] 'agreement among raft nodes before linearized reading' (duration: 323.039531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:05.33854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:05.015209Z","time spent":"323.282468ms","remote":"127.0.0.1:49954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-10T01:05:09.554074Z","caller":"traceutil/trace.go:171","msg":"trace[457424272] linearizableReadLoop","detail":"{readStateIndex:277; appliedIndex:276; }","duration":"308.990435ms","start":"2026-04-10T01:05:09.245036Z","end":"2026-04-10T01:05:09.554026Z","steps":["trace[457424272] 'read index received' (duration: 298.718365ms)","trace[457424272] 'applied index is now lower than readState.Index' (duration: 10.27102ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:05:09.55414Z","caller":"traceutil/trace.go:171","msg":"trace[1659485723] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"351.345006ms","start":"2026-04-10T01:05:09.202756Z","end":"2026-04-10T01:05:09.554101Z","steps":["trace[1659485723] 'process raft request' (duration: 341.005925ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:09.554243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.18902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-10T01:05:09.554405Z","caller":"traceutil/trace.go:171","msg":"trace[285093545] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:266; }","duration":"309.355924ms","start":"2026-04-10T01:05:09.245026Z","end":"2026-04-10T01:05:09.554382Z","steps":["trace[285093545] 'agreement among raft nodes before linearized reading' (duration: 309.141348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:09.554462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:09.202733Z","time spent":"351.470188ms","remote":"127.0.0.1:50026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4307,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:05:09.554509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:09.244948Z","time spent":"309.542909ms","remote":"127.0.0.1:49954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-10T01:05:11.238472Z","caller":"traceutil/trace.go:171","msg":"trace[1052747371] linearizableReadLoop","detail":"{readStateIndex:296; appliedIndex:295; }","duration":"292.955838ms","start":"2026-04-10T01:05:10.945488Z","end":"2026-04-10T01:05:11.238443Z","steps":["trace[1052747371] 'read index received' (duration: 292.738812ms)","trace[1052747371] 'applied index is now lower than readState.Index' (duration: 215.886µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:05:11.238553Z","caller":"traceutil/trace.go:171","msg":"trace[1780333513] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"320.735497ms","start":"2026-04-10T01:05:10.917794Z","end":"2026-04-10T01:05:11.238529Z","steps":["trace[1780333513] 'process raft request' (duration: 320.507941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:11.239015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:10.917777Z","time spent":"321.158809ms","remote":"127.0.0.1:50098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:05:11.239122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.601166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-10T01:05:11.239247Z","caller":"traceutil/trace.go:171","msg":"trace[1498475456] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:285; }","duration":"293.74948ms","start":"2026-04-10T01:05:10.945453Z","end":"2026-04-10T01:05:11.239202Z","steps":["trace[1498475456] 'agreement among raft nodes before linearized reading' (duration: 293.136193ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:11.926236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.243114ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-10T01:05:11.926543Z","caller":"traceutil/trace.go:171","msg":"trace[335443583] linearizableReadLoop","detail":"{readStateIndex:297; appliedIndex:296; }","duration":"356.201374ms","start":"2026-04-10T01:05:11.570324Z","end":"2026-04-10T01:05:11.926526Z","steps":["trace[335443583] 'read index received' (duration: 200.450856ms)","trace[335443583] 'applied index is now lower than readState.Index' (duration: 155.749178ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:05:11.926678Z","caller":"traceutil/trace.go:171","msg":"trace[1660170257] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"681.054847ms","start":"2026-04-10T01:05:11.245592Z","end":"2026-04-10T01:05:11.926647Z","steps":["trace[1660170257] 'process raft request' (duration: 525.193566ms)","trace[1660170257] 'compare' (duration: 155.09394ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:05:11.926798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:11.245568Z","time spent":"681.174741ms","remote":"127.0.0.1:50052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":178,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T01:05:11.926971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.637556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-10T01:05:11.927033Z","caller":"traceutil/trace.go:171","msg":"trace[18135946] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:286; }","duration":"356.751808ms","start":"2026-04-10T01:05:11.570261Z","end":"2026-04-10T01:05:11.927013Z","steps":["trace[18135946] 'agreement among raft nodes before linearized reading' (duration: 356.583464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:11.927075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:11.570238Z","time spent":"356.828301ms","remote":"127.0.0.1:50098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-10T01:05:11.927263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.71466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-10T01:05:11.927379Z","caller":"traceutil/trace.go:171","msg":"trace[1112615687] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:286; }","duration":"233.866374ms","start":"2026-04-10T01:05:11.693501Z","end":"2026-04-10T01:05:11.927368Z","steps":["trace[1112615687] 'agreement among raft nodes before linearized reading' (duration: 233.494174ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:17.577782Z","caller":"traceutil/trace.go:171","msg":"trace[858870218] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"306.067789ms","start":"2026-04-10T01:05:17.271659Z","end":"2026-04-10T01:05:17.577727Z","steps":["trace[858870218] 'process raft request' (duration: 305.905105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:17.578087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:17.271627Z","time spent":"306.262335ms","remote":"127.0.0.1:50098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:05:18.208692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.33578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-10T01:05:18.208778Z","caller":"traceutil/trace.go:171","msg":"trace[1063267526] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:361; }","duration":"207.494474ms","start":"2026-04-10T01:05:18.001263Z","end":"2026-04-10T01:05:18.208758Z","steps":["trace[1063267526] 'range keys from in-memory index tree' (duration: 207.137783ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:18.208815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.378793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-10T01:05:18.209077Z","caller":"traceutil/trace.go:171","msg":"trace[1560218212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:361; }","duration":"217.630121ms","start":"2026-04-10T01:05:17.991329Z","end":"2026-04-10T01:05:18.208959Z","steps":["trace[1560218212] 'range keys from in-memory index tree' (duration: 217.192779ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:18.622134Z","caller":"traceutil/trace.go:171","msg":"trace[1589446668] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"407.897488ms","start":"2026-04-10T01:05:18.214211Z","end":"2026-04-10T01:05:18.622109Z","steps":["trace[1589446668] 'process raft request' (duration: 407.693522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:18.622303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:18.214181Z","time spent":"408.037112ms","remote":"127.0.0.1:50098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:05:19.433654Z","caller":"traceutil/trace.go:171","msg":"trace[848963508] linearizableReadLoop","detail":"{readStateIndex:377; appliedIndex:374; }","duration":"1.17945001s","start":"2026-04-10T01:05:18.25418Z","end":"2026-04-10T01:05:19.43363Z","steps":["trace[848963508] 'read index received' (duration: 367.886069ms)","trace[848963508] 'applied index is now lower than readState.Index' (duration: 811.562741ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:05:19.43369Z","caller":"traceutil/trace.go:171","msg":"trace[2016327325] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"1.189701331s","start":"2026-04-10T01:05:18.243945Z","end":"2026-04-10T01:05:19.433646Z","steps":["trace[2016327325] 'process raft request' (duration: 1.189618859s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:19.433829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.179665296s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-10T01:05:19.433903Z","caller":"traceutil/trace.go:171","msg":"trace[799419717] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:364; }","duration":"1.17980954s","start":"2026-04-10T01:05:18.254081Z","end":"2026-04-10T01:05:19.433891Z","steps":["trace[799419717] 'agreement among raft nodes before linearized reading' (duration: 1.179655536s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:19.433943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:18.252819Z","time spent":"1.181114777s","remote":"127.0.0.1:50098","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-04-10T01:05:19.434073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:18.243918Z","time spent":"1.189862656s","remote":"127.0.0.1:50098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:05:19.434298Z","caller":"traceutil/trace.go:171","msg":"trace[887428157] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"1.219398937s","start":"2026-04-10T01:05:18.214251Z","end":"2026-04-10T01:05:19.433649Z","steps":["trace[887428157] 'process raft request' (duration: 1.133932053s)","trace[887428157] 'compare' (duration: 85.228357ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:05:19.434478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:18.214223Z","time spent":"1.220141238s","remote":"127.0.0.1:50098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:05:25.606005Z","caller":"traceutil/trace.go:171","msg":"trace[1310193119] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"141.818242ms","start":"2026-04-10T01:05:25.463949Z","end":"2026-04-10T01:05:25.605767Z","steps":["trace[1310193119] 'process raft request' (duration: 141.659227ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:25.607523Z","caller":"traceutil/trace.go:171","msg":"trace[593099739] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"142.788849ms","start":"2026-04-10T01:05:25.464712Z","end":"2026-04-10T01:05:25.607501Z","steps":["trace[593099739] 'process raft request' (duration: 142.645195ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:32.843556Z","caller":"traceutil/trace.go:171","msg":"trace[1130210691] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"150.443484ms","start":"2026-04-10T01:05:32.693081Z","end":"2026-04-10T01:05:32.843525Z","steps":["trace[1130210691] 'process raft request' (duration: 144.237027ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:32.848906Z","caller":"traceutil/trace.go:171","msg":"trace[712085546] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"145.37505ms","start":"2026-04-10T01:05:32.70351Z","end":"2026-04-10T01:05:32.848885Z","steps":["trace[712085546] 'process raft request' (duration: 145.317088ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:32.849067Z","caller":"traceutil/trace.go:171","msg":"trace[940849867] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"154.098803ms","start":"2026-04-10T01:05:32.69496Z","end":"2026-04-10T01:05:32.849059Z","steps":["trace[940849867] 'process raft request' (duration: 153.766623ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:32.849129Z","caller":"traceutil/trace.go:171","msg":"trace[968878940] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"145.769452ms","start":"2026-04-10T01:05:32.703354Z","end":"2026-04-10T01:05:32.849124Z","steps":["trace[968878940] 'process raft request' (duration: 145.436772ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:32.849374Z","caller":"traceutil/trace.go:171","msg":"trace[1271241675] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"154.567788ms","start":"2026-04-10T01:05:32.69448Z","end":"2026-04-10T01:05:32.849047Z","steps":["trace[1271241675] 'process raft request' (duration: 149.156975ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:32.894279Z","caller":"traceutil/trace.go:171","msg":"trace[1701497768] linearizableReadLoop","detail":"{readStateIndex:468; appliedIndex:462; }","duration":"114.054657ms","start":"2026-04-10T01:05:32.780157Z","end":"2026-04-10T01:05:32.894212Z","steps":["trace[1701497768] 'read index received' (duration: 57.184764ms)","trace[1701497768] 'applied index is now lower than readState.Index' (duration: 56.868973ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:05:32.894393Z","caller":"traceutil/trace.go:171","msg":"trace[1932999445] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"184.074406ms","start":"2026-04-10T01:05:32.710305Z","end":"2026-04-10T01:05:32.89438Z","steps":["trace[1932999445] 'process raft request' (duration: 183.652884ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:32.894797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.607724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-10T01:05:32.894887Z","caller":"traceutil/trace.go:171","msg":"trace[1589235588] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:451; }","duration":"114.724137ms","start":"2026-04-10T01:05:32.780142Z","end":"2026-04-10T01:05:32.894866Z","steps":["trace[1589235588] 'agreement among raft nodes before linearized reading' (duration: 114.520891ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:33.095135Z","caller":"traceutil/trace.go:171","msg":"trace[105996443] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"239.959171ms","start":"2026-04-10T01:05:32.855146Z","end":"2026-04-10T01:05:33.095105Z","steps":["trace[105996443] 'process raft request' (duration: 239.840417ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:33.095182Z","caller":"traceutil/trace.go:171","msg":"trace[1593224316] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"195.47347ms","start":"2026-04-10T01:05:32.899675Z","end":"2026-04-10T01:05:33.095148Z","steps":["trace[1593224316] 'process raft request' (duration: 195.398898ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:33.095325Z","caller":"traceutil/trace.go:171","msg":"trace[1698493942] linearizableReadLoop","detail":"{readStateIndex:472; appliedIndex:468; }","duration":"200.945076ms","start":"2026-04-10T01:05:32.894351Z","end":"2026-04-10T01:05:33.095296Z","steps":["trace[1698493942] 'read index received' (duration: 113.549843ms)","trace[1698493942] 'applied index is now lower than readState.Index' (duration: 87.393093ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:05:33.095448Z","caller":"traceutil/trace.go:171","msg":"trace[1779043194] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"240.036243ms","start":"2026-04-10T01:05:32.855402Z","end":"2026-04-10T01:05:33.095438Z","steps":["trace[1779043194] 'process raft request' (duration: 239.629891ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:33.095523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.603471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4335"} {"level":"info","ts":"2026-04-10T01:05:33.095508Z","caller":"traceutil/trace.go:171","msg":"trace[1718950663] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"240.426475ms","start":"2026-04-10T01:05:32.855028Z","end":"2026-04-10T01:05:33.095454Z","steps":["trace[1718950663] 'process raft request' (duration: 239.878019ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:33.095571Z","caller":"traceutil/trace.go:171","msg":"trace[954352540] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:456; }","duration":"240.695843ms","start":"2026-04-10T01:05:32.854859Z","end":"2026-04-10T01:05:33.095555Z","steps":["trace[954352540] 'agreement among raft nodes before linearized reading' (duration: 240.58833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:33.09564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.865291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/cilium\" ","response":"range_response_count:1 size:14463"} {"level":"warn","ts":"2026-04-10T01:05:33.095638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.712393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-c52wd\" ","response":"range_response_count:1 size:15076"} {"level":"info","ts":"2026-04-10T01:05:33.09568Z","caller":"traceutil/trace.go:171","msg":"trace[1401634584] range","detail":"{range_begin:/registry/daemonsets/kube-system/cilium; range_end:; response_count:1; response_revision:456; }","duration":"188.979485ms","start":"2026-04-10T01:05:32.906688Z","end":"2026-04-10T01:05:33.095667Z","steps":["trace[1401634584] 'agreement among raft nodes before linearized reading' (duration: 188.852281ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:33.09572Z","caller":"traceutil/trace.go:171","msg":"trace[2016832200] range","detail":"{range_begin:/registry/pods/kube-system/cilium-c52wd; range_end:; response_count:1; response_revision:456; }","duration":"238.836177ms","start":"2026-04-10T01:05:32.856859Z","end":"2026-04-10T01:05:33.095695Z","steps":["trace[2016832200] 'agreement among raft nodes before linearized reading' (duration: 238.674302ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:33.095721Z","caller":"traceutil/trace.go:171","msg":"trace[630617068] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"246.871439ms","start":"2026-04-10T01:05:32.84883Z","end":"2026-04-10T01:05:33.095702Z","steps":["trace[630617068] 'process raft request' (duration: 159.108685ms)","trace[630617068] 'compare' (duration: 86.780044ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:05:33.095929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.033155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"} {"level":"info","ts":"2026-04-10T01:05:33.09599Z","caller":"traceutil/trace.go:171","msg":"trace[572175486] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:456; }","duration":"176.108447ms","start":"2026-04-10T01:05:32.919861Z","end":"2026-04-10T01:05:33.09597Z","steps":["trace[572175486] 'agreement among raft nodes before linearized reading' (duration: 175.722355ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:33.254272Z","caller":"traceutil/trace.go:171","msg":"trace[906367398] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"142.700354ms","start":"2026-04-10T01:05:33.111547Z","end":"2026-04-10T01:05:33.254247Z","steps":["trace[906367398] 'process raft request' (duration: 142.55617ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:33.254404Z","caller":"traceutil/trace.go:171","msg":"trace[155000890] linearizableReadLoop","detail":"{readStateIndex:477; appliedIndex:474; }","duration":"111.669737ms","start":"2026-04-10T01:05:33.142724Z","end":"2026-04-10T01:05:33.254393Z","steps":["trace[155000890] 'read index received' (duration: 66.967185ms)","trace[155000890] 'applied index is now lower than readState.Index' (duration: 44.701012ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:05:33.254272Z","caller":"traceutil/trace.go:171","msg":"trace[1148064901] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"144.467087ms","start":"2026-04-10T01:05:33.109756Z","end":"2026-04-10T01:05:33.254223Z","steps":["trace[1148064901] 'process raft request' (duration: 100.102726ms)","trace[1148064901] 'compare' (duration: 44.010141ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:05:33.25459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.623993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"} {"level":"info","ts":"2026-04-10T01:05:33.254624Z","caller":"traceutil/trace.go:171","msg":"trace[1009055543] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:460; }","duration":"144.703224ms","start":"2026-04-10T01:05:33.109911Z","end":"2026-04-10T01:05:33.254614Z","steps":["trace[1009055543] 'agreement among raft nodes before linearized reading' (duration: 144.57767ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:33.255113Z","caller":"traceutil/trace.go:171","msg":"trace[2049695937] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"142.994693ms","start":"2026-04-10T01:05:33.112096Z","end":"2026-04-10T01:05:33.255091Z","steps":["trace[2049695937] 'process raft request' (duration: 142.083055ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:33.469562Z","caller":"traceutil/trace.go:171","msg":"trace[967361195] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"197.72565ms","start":"2026-04-10T01:05:33.271807Z","end":"2026-04-10T01:05:33.469533Z","steps":["trace[967361195] 'process raft request' (duration: 197.526093ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:34.891142Z","caller":"traceutil/trace.go:171","msg":"trace[332439537] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"380.285219ms","start":"2026-04-10T01:05:34.510799Z","end":"2026-04-10T01:05:34.891084Z","steps":["trace[332439537] 'process raft request' (duration: 375.363469ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:34.891321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:34.510764Z","time spent":"380.474615ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T01:05:35.076282Z","caller":"traceutil/trace.go:171","msg":"trace[1331150213] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"557.749342ms","start":"2026-04-10T01:05:34.518502Z","end":"2026-04-10T01:05:35.076251Z","steps":["trace[1331150213] 'process raft request' (duration: 557.389561ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:35.076343Z","caller":"traceutil/trace.go:171","msg":"trace[1671156493] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"557.702911ms","start":"2026-04-10T01:05:34.518571Z","end":"2026-04-10T01:05:35.076274Z","steps":["trace[1671156493] 'process raft request' (duration: 557.574697ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:35.076353Z","caller":"traceutil/trace.go:171","msg":"trace[1342051095] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"554.264206ms","start":"2026-04-10T01:05:34.522047Z","end":"2026-04-10T01:05:35.076311Z","steps":["trace[1342051095] 'process raft request' (duration: 554.146372ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:35.076434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:34.518475Z","time spent":"557.881775ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T01:05:35.076533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:34.518566Z","time spent":"557.875426ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T01:05:35.076573Z","caller":"traceutil/trace.go:171","msg":"trace[50287754] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"553.182084ms","start":"2026-04-10T01:05:34.52338Z","end":"2026-04-10T01:05:35.076562Z","steps":["trace[50287754] 'process raft request' (duration: 552.911525ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:35.076621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:34.523375Z","time spent":"553.222435ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T01:05:35.076684Z","caller":"traceutil/trace.go:171","msg":"trace[207629503] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"553.382649ms","start":"2026-04-10T01:05:34.523292Z","end":"2026-04-10T01:05:35.076675Z","steps":["trace[207629503] 'process raft request' (duration: 552.939736ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:35.076705Z","caller":"traceutil/trace.go:171","msg":"trace[195121012] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"549.528613ms","start":"2026-04-10T01:05:34.527168Z","end":"2026-04-10T01:05:35.076697Z","steps":["trace[195121012] 'process raft request' (duration: 549.164682ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:35.076704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:34.522039Z","time spent":"554.39852ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T01:05:35.076813Z","caller":"traceutil/trace.go:171","msg":"trace[1858512098] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"549.590274ms","start":"2026-04-10T01:05:34.527215Z","end":"2026-04-10T01:05:35.076805Z","steps":["trace[1858512098] 'process raft request' (duration: 549.287475ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:35.076865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:34.52721Z","time spent":"549.636855ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T01:05:35.076728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:34.523266Z","time spent":"553.444381ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T01:05:35.07691Z","caller":"traceutil/trace.go:171","msg":"trace[935719698] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"540.125387ms","start":"2026-04-10T01:05:34.536741Z","end":"2026-04-10T01:05:35.076866Z","steps":["trace[935719698] 'process raft request' (duration: 539.815767ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:35.076745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:34.527159Z","time spent":"549.568184ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T01:05:35.077132Z","caller":"traceutil/trace.go:171","msg":"trace[988659835] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"529.108883ms","start":"2026-04-10T01:05:34.548016Z","end":"2026-04-10T01:05:35.077125Z","steps":["trace[988659835] 'process raft request' (duration: 528.725121ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:35.077143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:34.536722Z","time spent":"540.307533ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T01:05:35.077209Z","caller":"traceutil/trace.go:171","msg":"trace[2098658640] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"504.30577ms","start":"2026-04-10T01:05:34.572898Z","end":"2026-04-10T01:05:35.077204Z","steps":["trace[2098658640] 'process raft request' (duration: 503.935609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:35.077177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:34.548003Z","time spent":"529.153815ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T01:05:35.077244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:34.572874Z","time spent":"504.357372ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T01:05:35.077305Z","caller":"traceutil/trace.go:171","msg":"trace[1523896604] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"399.206751ms","start":"2026-04-10T01:05:34.678092Z","end":"2026-04-10T01:05:35.077299Z","steps":["trace[1523896604] 'process raft request' (duration: 398.991934ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:35.077334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:34.67806Z","time spent":"399.262293ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T01:05:35.077408Z","caller":"traceutil/trace.go:171","msg":"trace[512863986] linearizableReadLoop","detail":"{readStateIndex:496; appliedIndex:484; }","duration":"355.376942ms","start":"2026-04-10T01:05:34.721878Z","end":"2026-04-10T01:05:35.077255Z","steps":["trace[512863986] 'read index received' (duration: 164.263195ms)","trace[512863986] 'applied index is now lower than readState.Index' (duration: 191.112057ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:05:35.077639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.732972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:35.07776Z","caller":"traceutil/trace.go:171","msg":"trace[420946244] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:479; }","duration":"355.881676ms","start":"2026-04-10T01:05:34.721828Z","end":"2026-04-10T01:05:35.07771Z","steps":["trace[420946244] 'agreement among raft nodes before linearized reading' (duration: 355.576387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:35.077887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:34.721801Z","time spent":"356.074873ms","remote":"127.0.0.1:49824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-10T01:05:35.092712Z","caller":"traceutil/trace.go:171","msg":"trace[1619920411] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"194.940355ms","start":"2026-04-10T01:05:34.897756Z","end":"2026-04-10T01:05:35.092697Z","steps":["trace[1619920411] 'process raft request' (duration: 193.682927ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:35.092884Z","caller":"traceutil/trace.go:171","msg":"trace[1686151722] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"194.073539ms","start":"2026-04-10T01:05:34.898805Z","end":"2026-04-10T01:05:35.092878Z","steps":["trace[1686151722] 'process raft request' (duration: 192.79265ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:35.092953Z","caller":"traceutil/trace.go:171","msg":"trace[2057621544] transaction","detail":"{read_only:false; number_of_response:1; response_revision:481; }","duration":"193.967436ms","start":"2026-04-10T01:05:34.89898Z","end":"2026-04-10T01:05:35.092947Z","steps":["trace[2057621544] 'process raft request' (duration: 193.44983ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:35.624905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.146121ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-04-10T01:05:35.625275Z","caller":"traceutil/trace.go:171","msg":"trace[177427098] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"462.203433ms","start":"2026-04-10T01:05:35.163055Z","end":"2026-04-10T01:05:35.625258Z","steps":["trace[177427098] 'process raft request' (duration: 461.963556ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:35.625292Z","caller":"traceutil/trace.go:171","msg":"trace[250757924] transaction","detail":"{read_only:false; number_of_response:0; response_revision:492; }","duration":"464.841503ms","start":"2026-04-10T01:05:35.160418Z","end":"2026-04-10T01:05:35.625259Z","steps":["trace[250757924] 'process raft request' (duration: 112.260138ms)","trace[250757924] 'compare' (duration: 352.101ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:05:35.625354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:35.163034Z","time spent":"462.277715ms","remote":"127.0.0.1:50098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:05:35.62538Z","caller":"traceutil/trace.go:171","msg":"trace[71758560] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"444.340738ms","start":"2026-04-10T01:05:35.181002Z","end":"2026-04-10T01:05:35.625343Z","steps":["trace[71758560] 'process raft request' (duration: 444.112612ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:35.625438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:35.160383Z","time spent":"464.984817ms","remote":"127.0.0.1:50360","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T01:05:35.625576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:35.180981Z","time spent":"444.485703ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:05:35.625689Z","caller":"traceutil/trace.go:171","msg":"trace[279332384] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"428.727634ms","start":"2026-04-10T01:05:35.196946Z","end":"2026-04-10T01:05:35.625673Z","steps":["trace[279332384] 'process raft request' (duration: 428.211278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:35.625802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:35.196916Z","time spent":"428.830097ms","remote":"127.0.0.1:50360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T01:05:35.626903Z","caller":"traceutil/trace.go:171","msg":"trace[2091451352] linearizableReadLoop","detail":"{readStateIndex:513; appliedIndex:511; }","duration":"449.258218ms","start":"2026-04-10T01:05:35.177629Z","end":"2026-04-10T01:05:35.626887Z","steps":["trace[2091451352] 'read index received' (duration: 95.098745ms)","trace[2091451352] 'applied index is now lower than readState.Index' (duration: 354.158743ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:05:35.626959Z","caller":"traceutil/trace.go:171","msg":"trace[866894899] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"418.571044ms","start":"2026-04-10T01:05:35.208374Z","end":"2026-04-10T01:05:35.626945Z","steps":["trace[866894899] 'process raft request' (duration: 417.754529ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:35.627042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:35.208357Z","time spent":"418.644767ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:05:35.627088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.443134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:10078"} {"level":"info","ts":"2026-04-10T01:05:35.62713Z","caller":"traceutil/trace.go:171","msg":"trace[595156850] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:499; }","duration":"449.517707ms","start":"2026-04-10T01:05:35.1776Z","end":"2026-04-10T01:05:35.627118Z","steps":["trace[595156850] 'agreement among raft nodes before linearized reading' (duration: 449.355852ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:35.627147Z","caller":"traceutil/trace.go:171","msg":"trace[1832061906] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"387.702894ms","start":"2026-04-10T01:05:35.239435Z","end":"2026-04-10T01:05:35.627138Z","steps":["trace[1832061906] 'process raft request' (duration: 387.017153ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:35.627168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:35.177584Z","time spent":"449.575878ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":10101,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-04-10T01:05:35.627193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:35.239405Z","time spent":"387.763216ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:05:35.627275Z","caller":"traceutil/trace.go:171","msg":"trace[1003748591] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"376.474293ms","start":"2026-04-10T01:05:35.250793Z","end":"2026-04-10T01:05:35.627268Z","steps":["trace[1003748591] 'process raft request' (duration: 375.999919ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:35.627147Z","caller":"traceutil/trace.go:171","msg":"trace[1208165242] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"424.844725ms","start":"2026-04-10T01:05:35.202206Z","end":"2026-04-10T01:05:35.627051Z","steps":["trace[1208165242] 'process raft request' (duration: 423.257527ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:35.627487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:35.202191Z","time spent":"425.185175ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:05:35.627319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:35.250761Z","time spent":"376.539265ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T01:05:36.330495Z","caller":"traceutil/trace.go:171","msg":"trace[1916977372] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"251.209934ms","start":"2026-04-10T01:05:36.079266Z","end":"2026-04-10T01:05:36.330476Z","steps":["trace[1916977372] 'process raft request' (duration: 248.049778ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:36.344443Z","caller":"traceutil/trace.go:171","msg":"trace[1703006704] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"222.007042ms","start":"2026-04-10T01:05:36.122408Z","end":"2026-04-10T01:05:36.344415Z","steps":["trace[1703006704] 'process raft request' (duration: 221.043853ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:36.344615Z","caller":"traceutil/trace.go:171","msg":"trace[284506265] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"129.385762ms","start":"2026-04-10T01:05:36.2152Z","end":"2026-04-10T01:05:36.344586Z","steps":["trace[284506265] 'process raft request' (duration: 128.822405ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:37.014822Z","caller":"traceutil/trace.go:171","msg":"trace[1650142277] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"489.909547ms","start":"2026-04-10T01:05:36.524885Z","end":"2026-04-10T01:05:37.014795Z","steps":["trace[1650142277] 'process raft request' (duration: 486.563554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:37.015001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:36.524855Z","time spent":"490.044681ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:05:37.021428Z","caller":"traceutil/trace.go:171","msg":"trace[1909365069] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"446.038717ms","start":"2026-04-10T01:05:36.575362Z","end":"2026-04-10T01:05:37.0214Z","steps":["trace[1909365069] 'process raft request' (duration: 445.097808ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:37.021564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:36.575335Z","time spent":"446.170481ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T01:05:37.021734Z","caller":"traceutil/trace.go:171","msg":"trace[391180052] linearizableReadLoop","detail":"{readStateIndex:559; appliedIndex:557; }","duration":"412.182223ms","start":"2026-04-10T01:05:36.609527Z","end":"2026-04-10T01:05:37.021709Z","steps":["trace[391180052] 'read index received' (duration: 402.010771ms)","trace[391180052] 'applied index is now lower than readState.Index' (duration: 10.170261ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:05:37.026162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.154754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:37.026241Z","caller":"traceutil/trace.go:171","msg":"trace[546245302] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:540; }","duration":"304.281957ms","start":"2026-04-10T01:05:36.72193Z","end":"2026-04-10T01:05:37.026212Z","steps":["trace[546245302] 'agreement among raft nodes before linearized reading' (duration: 304.155144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:37.026353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:36.721904Z","time spent":"304.433482ms","remote":"127.0.0.1:49824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-10T01:05:37.022085Z","caller":"traceutil/trace.go:171","msg":"trace[1949906251] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"372.079998ms","start":"2026-04-10T01:05:36.64997Z","end":"2026-04-10T01:05:37.02205Z","steps":["trace[1949906251] 'process raft request' (duration: 370.857961ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:37.027029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:36.649935Z","time spent":"376.949957ms","remote":"127.0.0.1:49868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:05:37.028866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.29867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-10T01:05:37.028988Z","caller":"traceutil/trace.go:171","msg":"trace[1406485988] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:540; }","duration":"419.468236ms","start":"2026-04-10T01:05:36.609482Z","end":"2026-04-10T01:05:37.02895Z","steps":["trace[1406485988] 'agreement among raft nodes before linearized reading' (duration: 412.559035ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:37.029033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:36.609458Z","time spent":"419.565849ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.57\" "} {"level":"warn","ts":"2026-04-10T01:05:37.297712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.147441ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T01:05:37.297836Z","caller":"traceutil/trace.go:171","msg":"trace[484422116] linearizableReadLoop","detail":"{readStateIndex:565; appliedIndex:564; }","duration":"190.669464ms","start":"2026-04-10T01:05:37.107148Z","end":"2026-04-10T01:05:37.297817Z","steps":["trace[484422116] 'read index received' (duration: 10.208193ms)","trace[484422116] 'applied index is now lower than readState.Index' (duration: 180.460011ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:05:37.298055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.907631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:80703"} {"level":"info","ts":"2026-04-10T01:05:37.298055Z","caller":"traceutil/trace.go:171","msg":"trace[1898070443] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"206.894731ms","start":"2026-04-10T01:05:37.091118Z","end":"2026-04-10T01:05:37.298013Z","steps":["trace[1898070443] 'process raft request' (duration: 26.330677ms)","trace[1898070443] 'compare' (duration: 179.976796ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:05:37.298099Z","caller":"traceutil/trace.go:171","msg":"trace[2011889339] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:544; }","duration":"190.977243ms","start":"2026-04-10T01:05:37.107109Z","end":"2026-04-10T01:05:37.298086Z","steps":["trace[2011889339] 'agreement among raft nodes before linearized reading' (duration: 190.759767ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:37.305596Z","caller":"traceutil/trace.go:171","msg":"trace[1175531887] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"169.952979ms","start":"2026-04-10T01:05:37.135618Z","end":"2026-04-10T01:05:37.305571Z","steps":["trace[1175531887] 'process raft request' (duration: 169.725692ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:43.689333Z","caller":"traceutil/trace.go:171","msg":"trace[104874617] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"316.790228ms","start":"2026-04-10T01:05:43.37251Z","end":"2026-04-10T01:05:43.689301Z","steps":["trace[104874617] 'read index received' (duration: 316.597492ms)","trace[104874617] 'applied index is now lower than readState.Index' (duration: 191.586µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:05:43.689438Z","caller":"traceutil/trace.go:171","msg":"trace[953151906] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"413.91223ms","start":"2026-04-10T01:05:43.275499Z","end":"2026-04-10T01:05:43.689411Z","steps":["trace[953151906] 'process raft request' (duration: 413.6104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:43.689547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.997346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:43.689616Z","caller":"traceutil/trace.go:171","msg":"trace[1158315790] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:588; }","duration":"317.120989ms","start":"2026-04-10T01:05:43.372466Z","end":"2026-04-10T01:05:43.689587Z","steps":["trace[1158315790] 'agreement among raft nodes before linearized reading' (duration: 317.005576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:43.689667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:43.275475Z","time spent":"414.052414ms","remote":"127.0.0.1:50026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:05:43.689678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:43.372434Z","time spent":"317.226642ms","remote":"127.0.0.1:52174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-10T01:05:43.689909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.982248ms","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\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:43.689969Z","caller":"traceutil/trace.go:171","msg":"trace[730942983] 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:588; }","duration":"163.06587ms","start":"2026-04-10T01:05:43.526887Z","end":"2026-04-10T01:05:43.689953Z","steps":["trace[730942983] 'agreement among raft nodes before linearized reading' (duration: 162.983297ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:43.690063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.835318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T01:05:43.690292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.802839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T01:05:43.690318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.426665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:43.69038Z","caller":"traceutil/trace.go:171","msg":"trace[1878320848] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:588; }","duration":"118.894221ms","start":"2026-04-10T01:05:43.57146Z","end":"2026-04-10T01:05:43.690354Z","steps":["trace[1878320848] 'agreement among raft nodes before linearized reading' (duration: 118.792708ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:43.690384Z","caller":"traceutil/trace.go:171","msg":"trace[1243575416] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:588; }","duration":"183.54928ms","start":"2026-04-10T01:05:43.506819Z","end":"2026-04-10T01:05:43.690368Z","steps":["trace[1243575416] 'agreement among raft nodes before linearized reading' (duration: 183.418265ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:43.690395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.273407ms","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\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:43.690448Z","caller":"traceutil/trace.go:171","msg":"trace[2049047257] 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:588; }","duration":"163.350359ms","start":"2026-04-10T01:05:43.527084Z","end":"2026-04-10T01:05:43.690435Z","steps":["trace[2049047257] 'agreement among raft nodes before linearized reading' (duration: 163.259126ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:43.690571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.070256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:43.690229Z","caller":"traceutil/trace.go:171","msg":"trace[784035201] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:588; }","duration":"117.965302ms","start":"2026-04-10T01:05:43.57219Z","end":"2026-04-10T01:05:43.690155Z","steps":["trace[784035201] 'agreement among raft nodes before linearized reading' (duration: 117.717334ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:43.690611Z","caller":"traceutil/trace.go:171","msg":"trace[721809185] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:588; }","duration":"119.119479ms","start":"2026-04-10T01:05:43.571482Z","end":"2026-04-10T01:05:43.690601Z","steps":["trace[721809185] 'agreement among raft nodes before linearized reading' (duration: 119.060117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:43.690745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.872865ms","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-04-10T01:05:43.690844Z","caller":"traceutil/trace.go:171","msg":"trace[1134039334] 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:588; }","duration":"163.967828ms","start":"2026-04-10T01:05:43.52683Z","end":"2026-04-10T01:05:43.690798Z","steps":["trace[1134039334] 'agreement among raft nodes before linearized reading' (duration: 163.847674ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:43.690881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.21848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:43.690926Z","caller":"traceutil/trace.go:171","msg":"trace[116932542] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:588; }","duration":"200.311523ms","start":"2026-04-10T01:05:43.4906Z","end":"2026-04-10T01:05:43.690912Z","steps":["trace[116932542] 'agreement among raft nodes before linearized reading' (duration: 200.23846ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:43.690889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.154637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T01:05:43.691063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.775586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:43.691087Z","caller":"traceutil/trace.go:171","msg":"trace[1096681794] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:588; }","duration":"200.372175ms","start":"2026-04-10T01:05:43.490675Z","end":"2026-04-10T01:05:43.691047Z","steps":["trace[1096681794] 'agreement among raft nodes before linearized reading' (duration: 200.144098ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:43.691128Z","caller":"traceutil/trace.go:171","msg":"trace[1339386349] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:588; }","duration":"183.87941ms","start":"2026-04-10T01:05:43.507234Z","end":"2026-04-10T01:05:43.691113Z","steps":["trace[1339386349] 'agreement among raft nodes before linearized reading' (duration: 183.784807ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:43.691463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.21872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T01:05:43.690986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.026104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:43.691524Z","caller":"traceutil/trace.go:171","msg":"trace[574925180] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:588; }","duration":"200.326283ms","start":"2026-04-10T01:05:43.491183Z","end":"2026-04-10T01:05:43.691509Z","steps":["trace[574925180] 'agreement among raft nodes before linearized reading' (duration: 200.23738ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:43.691545Z","caller":"traceutil/trace.go:171","msg":"trace[1824972973] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:588; }","duration":"184.618103ms","start":"2026-04-10T01:05:43.506911Z","end":"2026-04-10T01:05:43.691529Z","steps":["trace[1824972973] 'agreement among raft nodes before linearized reading' (duration: 184.031124ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:43.692357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.302775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:43.692429Z","caller":"traceutil/trace.go:171","msg":"trace[305197225] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:588; }","duration":"319.901106ms","start":"2026-04-10T01:05:43.372509Z","end":"2026-04-10T01:05:43.69241Z","steps":["trace[305197225] 'agreement among raft nodes before linearized reading' (duration: 317.301865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:43.692743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:43.372488Z","time spent":"320.105722ms","remote":"127.0.0.1:52174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-10T01:05:44.31976Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322102298236294654,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-10T01:05:44.49713Z","caller":"traceutil/trace.go:171","msg":"trace[696656567] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:611; }","duration":"678.239265ms","start":"2026-04-10T01:05:43.818865Z","end":"2026-04-10T01:05:44.497104Z","steps":["trace[696656567] 'read index received' (duration: 634.225067ms)","trace[696656567] 'applied index is now lower than readState.Index' (duration: 44.012718ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:05:44.497237Z","caller":"traceutil/trace.go:171","msg":"trace[1565815377] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"679.736152ms","start":"2026-04-10T01:05:43.817487Z","end":"2026-04-10T01:05:44.497223Z","steps":["trace[1565815377] 'process raft request' (duration: 635.679222ms)","trace[1565815377] 'compare' (duration: 43.695678ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:05:44.497356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:43.817456Z","time spent":"679.809544ms","remote":"127.0.0.1:50098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:05:44.497639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.774721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-10T01:05:44.497697Z","caller":"traceutil/trace.go:171","msg":"trace[1928348690] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:590; }","duration":"678.867784ms","start":"2026-04-10T01:05:43.818814Z","end":"2026-04-10T01:05:44.497682Z","steps":["trace[1928348690] 'agreement among raft nodes before linearized reading' (duration: 678.698529ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:44.497767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:43.81879Z","time spent":"678.966797ms","remote":"127.0.0.1:50098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-10T01:05:44.497891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.155677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-10T01:05:44.498021Z","caller":"traceutil/trace.go:171","msg":"trace[1880771264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:590; }","duration":"674.305242ms","start":"2026-04-10T01:05:43.823671Z","end":"2026-04-10T01:05:44.497976Z","steps":["trace[1880771264] 'agreement among raft nodes before linearized reading' (duration: 674.025233ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:44.498094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:43.823661Z","time spent":"674.417265ms","remote":"127.0.0.1:50098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-10T01:05:44.850299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.833342ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T01:05:44.850416Z","caller":"traceutil/trace.go:171","msg":"trace[1498010786] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"128.566434ms","start":"2026-04-10T01:05:44.721832Z","end":"2026-04-10T01:05:44.850398Z","steps":["trace[1498010786] 'read index received' (duration: 61.912µs)","trace[1498010786] 'applied index is now lower than readState.Index' (duration: 128.503022ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:05:44.850435Z","caller":"traceutil/trace.go:171","msg":"trace[1147998312] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"348.50777ms","start":"2026-04-10T01:05:44.501899Z","end":"2026-04-10T01:05:44.850407Z","steps":["trace[1147998312] 'process raft request' (duration: 158.468731ms)","trace[1147998312] 'compare' (duration: 189.668057ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:05:44.850484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.658718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:44.850518Z","caller":"traceutil/trace.go:171","msg":"trace[565471642] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:592; }","duration":"128.73594ms","start":"2026-04-10T01:05:44.721773Z","end":"2026-04-10T01:05:44.850509Z","steps":["trace[565471642] 'agreement among raft nodes before linearized reading' (duration: 128.677028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:44.850586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:44.501867Z","time spent":"348.622713ms","remote":"127.0.0.1:50098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:05:46.494302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.991106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-10T01:05:46.494383Z","caller":"traceutil/trace.go:171","msg":"trace[396963139] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:592; }","duration":"721.122021ms","start":"2026-04-10T01:05:45.773239Z","end":"2026-04-10T01:05:46.494361Z","steps":["trace[396963139] 'range keys from in-memory index tree' (duration: 720.743508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:46.494434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:45.773214Z","time spent":"721.206664ms","remote":"127.0.0.1:50098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-10T01:05:46.494564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.326946588s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:46.494715Z","caller":"traceutil/trace.go:171","msg":"trace[1839369214] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:592; }","duration":"1.327092753s","start":"2026-04-10T01:05:45.167587Z","end":"2026-04-10T01:05:46.49468Z","steps":["trace[1839369214] 'range keys from in-memory index tree' (duration: 1.326917408s)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:50.450723Z","caller":"traceutil/trace.go:171","msg":"trace[1969302219] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"151.406407ms","start":"2026-04-10T01:05:50.299294Z","end":"2026-04-10T01:05:50.450701Z","steps":["trace[1969302219] 'process raft request' (duration: 151.252522ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:50.507491Z","caller":"traceutil/trace.go:171","msg":"trace[856136273] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"196.216782ms","start":"2026-04-10T01:05:50.311252Z","end":"2026-04-10T01:05:50.507469Z","steps":["trace[856136273] 'process raft request' (duration: 195.594122ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:53.432244Z","caller":"traceutil/trace.go:171","msg":"trace[737861656] linearizableReadLoop","detail":"{readStateIndex:705; appliedIndex:704; }","duration":"195.138654ms","start":"2026-04-10T01:05:53.237082Z","end":"2026-04-10T01:05:53.432221Z","steps":["trace[737861656] 'read index received' (duration: 195.00761ms)","trace[737861656] 'applied index is now lower than readState.Index' (duration: 129.954µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:05:53.432338Z","caller":"traceutil/trace.go:171","msg":"trace[2137226276] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"215.428294ms","start":"2026-04-10T01:05:53.216884Z","end":"2026-04-10T01:05:53.432312Z","steps":["trace[2137226276] 'process raft request' (duration: 215.182676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:53.432409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.294089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:53.432453Z","caller":"traceutil/trace.go:171","msg":"trace[253266887] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:681; }","duration":"195.380931ms","start":"2026-04-10T01:05:53.237061Z","end":"2026-04-10T01:05:53.432442Z","steps":["trace[253266887] 'agreement among raft nodes before linearized reading' (duration: 195.283298ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:53.565572Z","caller":"traceutil/trace.go:171","msg":"trace[1684568578] linearizableReadLoop","detail":"{readStateIndex:707; appliedIndex:705; }","duration":"133.2418ms","start":"2026-04-10T01:05:53.432315Z","end":"2026-04-10T01:05:53.565557Z","steps":["trace[1684568578] 'read index received' (duration: 89.55486ms)","trace[1684568578] 'applied index is now lower than readState.Index' (duration: 43.68592ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:05:53.565703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.537759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:53.565736Z","caller":"traceutil/trace.go:171","msg":"trace[129037652] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:682; }","duration":"328.621852ms","start":"2026-04-10T01:05:53.237105Z","end":"2026-04-10T01:05:53.565727Z","steps":["trace[129037652] 'agreement among raft nodes before linearized reading' (duration: 328.517948ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:53.565778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.096353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T01:05:53.565952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:53.23709Z","time spent":"328.678583ms","remote":"127.0.0.1:43616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":113,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-10T01:05:53.565948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.289629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:53.565971Z","caller":"traceutil/trace.go:171","msg":"trace[568802210] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:682; }","duration":"156.364441ms","start":"2026-04-10T01:05:53.409585Z","end":"2026-04-10T01:05:53.565949Z","steps":["trace[568802210] 'agreement among raft nodes before linearized reading' (duration: 155.986049ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:53.566048Z","caller":"traceutil/trace.go:171","msg":"trace[767970233] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:682; }","duration":"156.499455ms","start":"2026-04-10T01:05:53.409529Z","end":"2026-04-10T01:05:53.566028Z","steps":["trace[767970233] 'agreement among raft nodes before linearized reading' (duration: 156.255787ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:53.566115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.949623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T01:05:53.566106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.129078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:53.566198Z","caller":"traceutil/trace.go:171","msg":"trace[273151537] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:682; }","duration":"139.150929ms","start":"2026-04-10T01:05:53.427007Z","end":"2026-04-10T01:05:53.566158Z","steps":["trace[273151537] 'agreement among raft nodes before linearized reading' (duration: 138.944403ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:53.566211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.497821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:53.566251Z","caller":"traceutil/trace.go:171","msg":"trace[2036762667] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:682; }","duration":"139.552262ms","start":"2026-04-10T01:05:53.426688Z","end":"2026-04-10T01:05:53.566241Z","steps":["trace[2036762667] 'agreement among raft nodes before linearized reading' (duration: 139.49887ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:53.566256Z","caller":"traceutil/trace.go:171","msg":"trace[134428282] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:682; }","duration":"285.429808ms","start":"2026-04-10T01:05:53.280794Z","end":"2026-04-10T01:05:53.566224Z","steps":["trace[134428282] 'agreement among raft nodes before linearized reading' (duration: 284.954352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:53.566284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.49966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:53.566366Z","caller":"traceutil/trace.go:171","msg":"trace[644567672] transaction","detail":"{read_only:false; number_of_response:1; response_revision:682; }","duration":"259.653301ms","start":"2026-04-10T01:05:53.306676Z","end":"2026-04-10T01:05:53.566329Z","steps":["trace[644567672] 'process raft request' (duration: 258.796013ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:53.566355Z","caller":"traceutil/trace.go:171","msg":"trace[121756170] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"263.935228ms","start":"2026-04-10T01:05:53.302306Z","end":"2026-04-10T01:05:53.566241Z","steps":["trace[121756170] 'process raft request' (duration: 219.531605ms)","trace[121756170] 'compare' (duration: 43.493594ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:05:53.566383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.50711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:53.566428Z","caller":"traceutil/trace.go:171","msg":"trace[1315519264] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:682; }","duration":"285.627554ms","start":"2026-04-10T01:05:53.280735Z","end":"2026-04-10T01:05:53.566363Z","steps":["trace[1315519264] 'agreement among raft nodes before linearized reading' (duration: 285.465869ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:53.566474Z","caller":"traceutil/trace.go:171","msg":"trace[1549484312] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:682; }","duration":"139.724238ms","start":"2026-04-10T01:05:53.42673Z","end":"2026-04-10T01:05:53.566454Z","steps":["trace[1549484312] 'agreement among raft nodes before linearized reading' (duration: 139.387797ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:53.566611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.809879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:53.566669Z","caller":"traceutil/trace.go:171","msg":"trace[1599682302] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:682; }","duration":"285.872331ms","start":"2026-04-10T01:05:53.280785Z","end":"2026-04-10T01:05:53.566657Z","steps":["trace[1599682302] 'agreement among raft nodes before linearized reading' (duration: 285.783279ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:53.566719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.744299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-c52wd\" ","response":"range_response_count:1 size:18512"} {"level":"info","ts":"2026-04-10T01:05:53.567144Z","caller":"traceutil/trace.go:171","msg":"trace[2130349518] range","detail":"{range_begin:/registry/pods/kube-system/cilium-c52wd; range_end:; response_count:1; response_revision:682; }","duration":"238.172943ms","start":"2026-04-10T01:05:53.32894Z","end":"2026-04-10T01:05:53.567113Z","steps":["trace[2130349518] 'agreement among raft nodes before linearized reading' (duration: 237.655326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:53.566814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.630482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:05:53.567276Z","caller":"traceutil/trace.go:171","msg":"trace[1313772602] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:682; }","duration":"329.118558ms","start":"2026-04-10T01:05:53.23814Z","end":"2026-04-10T01:05:53.567258Z","steps":["trace[1313772602] 'agreement among raft nodes before linearized reading' (duration: 328.610121ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:05:53.567327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:05:53.238109Z","time spent":"329.19989ms","remote":"127.0.0.1:43616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 "} {"level":"info","ts":"2026-04-10T01:05:53.671784Z","caller":"traceutil/trace.go:171","msg":"trace[1876385464] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"100.501431ms","start":"2026-04-10T01:05:53.571255Z","end":"2026-04-10T01:05:53.671757Z","steps":["trace[1876385464] 'process raft request' (duration: 100.149289ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:05:53.865241Z","caller":"traceutil/trace.go:171","msg":"trace[6836590] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"182.088605ms","start":"2026-04-10T01:05:53.683127Z","end":"2026-04-10T01:05:53.865215Z","steps":["trace[6836590] 'process raft request' (duration: 125.570504ms)","trace[6836590] 'compare' (duration: 56.395497ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:06:00.454491Z","caller":"traceutil/trace.go:171","msg":"trace[1718752430] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"348.738583ms","start":"2026-04-10T01:06:00.105729Z","end":"2026-04-10T01:06:00.454468Z","steps":["trace[1718752430] 'process raft request' (duration: 348.544117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:06:00.454647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:06:00.105713Z","time spent":"348.856158ms","remote":"127.0.0.1:50098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:06:03.223066Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322102298236294963,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-10T01:06:03.723952Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322102298236294963,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-10T01:06:03.990516Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.344725508s","expected-duration":"1s"} {"level":"info","ts":"2026-04-10T01:06:03.990871Z","caller":"traceutil/trace.go:171","msg":"trace[678523539] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"1.345436632s","start":"2026-04-10T01:06:02.645418Z","end":"2026-04-10T01:06:03.990854Z","steps":["trace[678523539] 'process raft request' (duration: 1.345280837s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:06:03.990997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:06:02.645391Z","time spent":"1.345527685s","remote":"127.0.0.1:50098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:06:03.996391Z","caller":"traceutil/trace.go:171","msg":"trace[408627616] linearizableReadLoop","detail":"{readStateIndex:783; appliedIndex:780; }","duration":"1.273727018s","start":"2026-04-10T01:06:02.722649Z","end":"2026-04-10T01:06:03.996376Z","steps":["trace[408627616] 'read index received' (duration: 1.268464515s)","trace[408627616] 'applied index is now lower than readState.Index' (duration: 5.261573ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:06:03.996645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.273985166s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:06:03.996638Z","caller":"traceutil/trace.go:171","msg":"trace[91642212] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"617.636743ms","start":"2026-04-10T01:06:03.378964Z","end":"2026-04-10T01:06:03.996601Z","steps":["trace[91642212] 'process raft request' (duration: 617.368364ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:06:03.996699Z","caller":"traceutil/trace.go:171","msg":"trace[848692053] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:755; }","duration":"1.274074309s","start":"2026-04-10T01:06:02.722613Z","end":"2026-04-10T01:06:03.996687Z","steps":["trace[848692053] 'agreement among raft nodes before linearized reading' (duration: 1.273953855s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:06:03.996727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:06:02.722557Z","time spent":"1.274164352s","remote":"127.0.0.1:49824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T01:06:03.996741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.033419931s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-10T01:06:03.99677Z","caller":"traceutil/trace.go:171","msg":"trace[1839199791] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:755; }","duration":"1.033489983s","start":"2026-04-10T01:06:02.963272Z","end":"2026-04-10T01:06:03.996762Z","steps":["trace[1839199791] 'agreement among raft nodes before linearized reading' (duration: 1.033341229s)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:06:03.996764Z","caller":"traceutil/trace.go:171","msg":"trace[1295003684] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"1.35088531s","start":"2026-04-10T01:06:02.645864Z","end":"2026-04-10T01:06:03.99675Z","steps":["trace[1295003684] 'process raft request' (duration: 1.350409054s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:06:03.99679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:06:02.963247Z","time spent":"1.033538685s","remote":"127.0.0.1:50098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-10T01:06:03.996826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:06:02.645846Z","time spent":"1.350944562s","remote":"127.0.0.1:50098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:06:03.996821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:06:03.378942Z","time spent":"617.784388ms","remote":"127.0.0.1:50082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:06:03.99687Z","caller":"traceutil/trace.go:171","msg":"trace[2014801545] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"1.351268203s","start":"2026-04-10T01:06:02.645596Z","end":"2026-04-10T01:06:03.996864Z","steps":["trace[2014801545] 'process raft request' (duration: 1.350609301s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:06:03.996909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:06:02.64558Z","time spent":"1.351305794s","remote":"127.0.0.1:50098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:06:24.269488Z","caller":"traceutil/trace.go:171","msg":"trace[1508163916] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"178.727244ms","start":"2026-04-10T01:06:24.090732Z","end":"2026-04-10T01:06:24.269459Z","steps":["trace[1508163916] 'process raft request' (duration: 107.173316ms)","trace[1508163916] 'compare' (duration: 71.337541ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:06:24.269767Z","caller":"traceutil/trace.go:171","msg":"trace[485854708] linearizableReadLoop","detail":"{readStateIndex:981; appliedIndex:980; }","duration":"101.535245ms","start":"2026-04-10T01:06:24.168201Z","end":"2026-04-10T01:06:24.269736Z","steps":["trace[485854708] 'read index received' (duration: 29.662556ms)","trace[485854708] 'applied index is now lower than readState.Index' (duration: 71.849758ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:06:24.270096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.489833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-10T01:06:24.270196Z","caller":"traceutil/trace.go:171","msg":"trace[1776772958] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:949; }","duration":"157.633249ms","start":"2026-04-10T01:06:24.11252Z","end":"2026-04-10T01:06:24.270153Z","steps":["trace[1776772958] 'agreement among raft nodes before linearized reading' (duration: 157.314738ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:06:24.525331Z","caller":"traceutil/trace.go:171","msg":"trace[444931225] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"249.484966ms","start":"2026-04-10T01:06:24.275796Z","end":"2026-04-10T01:06:24.525281Z","steps":["trace[444931225] 'process raft request' (duration: 238.217964ms)","trace[444931225] 'compare' (duration: 10.992573ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:07:20.605261Z","caller":"traceutil/trace.go:171","msg":"trace[978596207] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"105.93518ms","start":"2026-04-10T01:07:20.499304Z","end":"2026-04-10T01:07:20.605239Z","steps":["trace[978596207] 'process raft request' (duration: 105.644539ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:07:57.042043Z","caller":"traceutil/trace.go:171","msg":"trace[63980665] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"203.387145ms","start":"2026-04-10T01:07:56.838626Z","end":"2026-04-10T01:07:57.042013Z","steps":["trace[63980665] 'process raft request' (duration: 203.178346ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:07:57.042254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.30417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-10T01:07:57.042344Z","caller":"traceutil/trace.go:171","msg":"trace[657303324] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1294; }","duration":"199.43066ms","start":"2026-04-10T01:07:56.842901Z","end":"2026-04-10T01:07:57.042332Z","steps":["trace[657303324] 'agreement among raft nodes before linearized reading' (duration: 199.187181ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:07:57.042025Z","caller":"traceutil/trace.go:171","msg":"trace[239236391] linearizableReadLoop","detail":"{readStateIndex:1348; appliedIndex:1347; }","duration":"199.015201ms","start":"2026-04-10T01:07:56.842935Z","end":"2026-04-10T01:07:57.04195Z","steps":["trace[239236391] 'read index received' (duration: 198.845232ms)","trace[239236391] 'applied index is now lower than readState.Index' (duration: 168.899µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:07:57.062427Z","caller":"traceutil/trace.go:171","msg":"trace[562934312] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"191.613894ms","start":"2026-04-10T01:07:56.870766Z","end":"2026-04-10T01:07:57.06238Z","steps":["trace[562934312] 'process raft request' (duration: 177.166754ms)","trace[562934312] 'compare' (duration: 14.225201ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:07:57.062636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.186962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-10T01:07:57.062814Z","caller":"traceutil/trace.go:171","msg":"trace[189698468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1296; }","duration":"219.398511ms","start":"2026-04-10T01:07:56.843396Z","end":"2026-04-10T01:07:57.062795Z","steps":["trace[189698468] 'agreement among raft nodes before linearized reading' (duration: 219.007223ms)"],"step_count":1}