{"level":"warn","ts":"2026-07-20T18:53:05.18687Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-20T18:53:05.186945Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.116:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.116:2380","--initial-cluster=instance=https://199.204.45.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.116:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-20T18:53:05.187Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-20T18:53:05.187007Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-07-20T18:53:05.187024Z","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-07-20T18:53:05.187644Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"]} {"level":"info","ts":"2026-07-20T18:53:05.187748Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.116:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-20T18:53:05.19231Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.369762ms"} {"level":"info","ts":"2026-07-20T18:53:05.200831Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5caa70ef1dd6dc04","cluster-id":"45afccab143d2c82"} {"level":"info","ts":"2026-07-20T18:53:05.200916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=()"} {"level":"info","ts":"2026-07-20T18:53:05.200942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 0"} {"level":"info","ts":"2026-07-20T18:53:05.200956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5caa70ef1dd6dc04 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-20T18:53:05.200979Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 1"} {"level":"info","ts":"2026-07-20T18:53:05.201022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"warn","ts":"2026-07-20T18:53:05.207235Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-20T18:53:05.209317Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-20T18:53:05.210774Z","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-07-20T18:53:05.214318Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5caa70ef1dd6dc04","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-20T18:53:05.225666Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5caa70ef1dd6dc04","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-20T18:53:05.22646Z","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-07-20T18:53:05.226552Z","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-07-20T18:53:05.226683Z","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-07-20T18:53:05.226699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"info","ts":"2026-07-20T18:53:05.226798Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","added-peer-id":"5caa70ef1dd6dc04","added-peer-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-07-20T18:53:05.226701Z","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-07-20T18:53:05.2269Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-07-20T18:53:05.226934Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-07-20T18:53:05.227477Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5caa70ef1dd6dc04","initial-advertise-peer-urls":["https://199.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-20T18:53:05.227509Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-20T18:53:06.101598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 is starting a new election at term 1"} {"level":"info","ts":"2026-07-20T18:53:06.101637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-20T18:53:06.10165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgPreVoteResp from 5caa70ef1dd6dc04 at term 1"} {"level":"info","ts":"2026-07-20T18:53:06.101661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became candidate at term 2"} {"level":"info","ts":"2026-07-20T18:53:06.101667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgVoteResp from 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-07-20T18:53:06.101684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became leader at term 2"} {"level":"info","ts":"2026-07-20T18:53:06.101691Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5caa70ef1dd6dc04 elected leader 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-07-20T18:53:06.102741Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-20T18:53:06.103621Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-20T18:53:06.103615Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5caa70ef1dd6dc04","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.116:2379]}","request-path":"/0/members/5caa70ef1dd6dc04/attributes","cluster-id":"45afccab143d2c82","publish-timeout":"7s"} {"level":"info","ts":"2026-07-20T18:53:06.103687Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-20T18:53:06.104732Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","cluster-version":"3.5"} {"level":"info","ts":"2026-07-20T18:53:06.104879Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-20T18:53:06.10492Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-20T18:53:06.105Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-20T18:53:06.105071Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-20T18:53:06.105817Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.116:2379"} {"level":"info","ts":"2026-07-20T18:53:06.107309Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-20T18:53:07.634269Z","caller":"traceutil/trace.go:171","msg":"trace[7651296] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"197.75047ms","start":"2026-07-20T18:53:07.436485Z","end":"2026-07-20T18:53:07.634235Z","steps":["trace[7651296] 'process raft request' (duration: 118.700741ms)","trace[7651296] 'compare' (duration: 78.868417ms)"],"step_count":2} {"level":"info","ts":"2026-07-20T18:53:07.63456Z","caller":"traceutil/trace.go:171","msg":"trace[625897888] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"197.546718ms","start":"2026-07-20T18:53:07.436985Z","end":"2026-07-20T18:53:07.634532Z","steps":["trace[625897888] 'process raft request' (duration: 197.216294ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:07.634345Z","caller":"traceutil/trace.go:171","msg":"trace[1213399703] linearizableReadLoop","detail":"{readStateIndex:9; appliedIndex:7; }","duration":"197.73244ms","start":"2026-07-20T18:53:07.436577Z","end":"2026-07-20T18:53:07.634309Z","steps":["trace[1213399703] 'read index received' (duration: 3.432222ms)","trace[1213399703] 'applied index is now lower than readState.Index' (duration: 194.298798ms)"],"step_count":2} {"level":"info","ts":"2026-07-20T18:53:07.634328Z","caller":"traceutil/trace.go:171","msg":"trace[13491497] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"197.457857ms","start":"2026-07-20T18:53:07.436816Z","end":"2026-07-20T18:53:07.634274Z","steps":["trace[13491497] 'process raft request' (duration: 197.350275ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:07.634715Z","caller":"traceutil/trace.go:171","msg":"trace[788134126] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"197.147543ms","start":"2026-07-20T18:53:07.437556Z","end":"2026-07-20T18:53:07.634703Z","steps":["trace[788134126] 'process raft request' (duration: 196.708267ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:07.634758Z","caller":"traceutil/trace.go:171","msg":"trace[210972407] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"197.705921ms","start":"2026-07-20T18:53:07.437028Z","end":"2026-07-20T18:53:07.634734Z","steps":["trace[210972407] 'process raft request' (duration: 197.205064ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:07.634623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.983504ms","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-07-20T18:53:07.634909Z","caller":"traceutil/trace.go:171","msg":"trace[1904375020] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"198.329588ms","start":"2026-07-20T18:53:07.436567Z","end":"2026-07-20T18:53:07.634897Z","steps":["trace[1904375020] 'agreement among raft nodes before linearized reading' (duration: 197.832251ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:07.70217Z","caller":"traceutil/trace.go:171","msg":"trace[880249868] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"259.716337ms","start":"2026-07-20T18:53:07.442389Z","end":"2026-07-20T18:53:07.702106Z","steps":["trace[880249868] 'process raft request' (duration: 259.292062ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:07.703121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.166944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-20T18:53:07.703193Z","caller":"traceutil/trace.go:171","msg":"trace[1289323633] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12; }","duration":"266.264035ms","start":"2026-07-20T18:53:07.436912Z","end":"2026-07-20T18:53:07.703176Z","steps":["trace[1289323633] 'agreement among raft nodes before linearized reading' (duration: 265.421585ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:07.704129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.120408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-20T18:53:07.704236Z","caller":"traceutil/trace.go:171","msg":"trace[315806250] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:12; }","duration":"264.22492ms","start":"2026-07-20T18:53:07.439965Z","end":"2026-07-20T18:53:07.70419Z","steps":["trace[315806250] 'agreement among raft nodes before linearized reading' (duration: 264.117108ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:07.704484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.673825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-20T18:53:07.705329Z","caller":"traceutil/trace.go:171","msg":"trace[1070243822] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"217.550045ms","start":"2026-07-20T18:53:07.487754Z","end":"2026-07-20T18:53:07.705304Z","steps":["trace[1070243822] 'agreement among raft nodes before linearized reading' (duration: 215.180877ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:07.704947Z","caller":"traceutil/trace.go:171","msg":"trace[1865448172] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"250.358275ms","start":"2026-07-20T18:53:07.454037Z","end":"2026-07-20T18:53:07.704395Z","steps":["trace[1865448172] 'process raft request' (duration: 248.118839ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:11.010997Z","caller":"traceutil/trace.go:171","msg":"trace[294951660] linearizableReadLoop","detail":"{readStateIndex:240; appliedIndex:239; }","duration":"309.565613ms","start":"2026-07-20T18:53:10.701407Z","end":"2026-07-20T18:53:11.010972Z","steps":["trace[294951660] 'read index received' (duration: 309.480622ms)","trace[294951660] 'applied index is now lower than readState.Index' (duration: 83.581µs)"],"step_count":2} {"level":"info","ts":"2026-07-20T18:53:11.011096Z","caller":"traceutil/trace.go:171","msg":"trace[773262817] transaction","detail":"{read_only:false; response_revision:234; number_of_response:1; }","duration":"320.721285ms","start":"2026-07-20T18:53:10.690343Z","end":"2026-07-20T18:53:11.011064Z","steps":["trace[773262817] 'process raft request' (duration: 320.497172ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:11.011257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.816455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-20T18:53:11.011365Z","caller":"traceutil/trace.go:171","msg":"trace[2065439816] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:234; }","duration":"309.994688ms","start":"2026-07-20T18:53:10.701349Z","end":"2026-07-20T18:53:11.011344Z","steps":["trace[2065439816] 'agreement among raft nodes before linearized reading' (duration: 309.761555ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:11.011413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:10.701328Z","time spent":"310.073728ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-20T18:53:11.011622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:10.690319Z","time spent":"320.836126ms","remote":"127.0.0.1:58350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-20T18:53:11.511764Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853971964112089912,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-20T18:53:11.542399Z","caller":"traceutil/trace.go:171","msg":"trace[304420101] transaction","detail":"{read_only:false; response_revision:235; number_of_response:1; }","duration":"683.316642ms","start":"2026-07-20T18:53:10.859036Z","end":"2026-07-20T18:53:11.542352Z","steps":["trace[304420101] 'process raft request' (duration: 683.005427ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:11.542587Z","caller":"traceutil/trace.go:171","msg":"trace[388256428] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"565.494184ms","start":"2026-07-20T18:53:10.977053Z","end":"2026-07-20T18:53:11.542548Z","steps":["trace[388256428] 'process raft request' (duration: 565.451724ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:11.542647Z","caller":"traceutil/trace.go:171","msg":"trace[433049656] transaction","detail":"{read_only:false; number_of_response:0; response_revision:236; }","duration":"566.378985ms","start":"2026-07-20T18:53:10.976196Z","end":"2026-07-20T18:53:11.542575Z","steps":["trace[433049656] 'process raft request' (duration: 566.226414ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:11.542743Z","caller":"traceutil/trace.go:171","msg":"trace[1750746240] transaction","detail":"{read_only:false; response_revision:237; number_of_response:1; }","duration":"565.693827ms","start":"2026-07-20T18:53:10.977031Z","end":"2026-07-20T18:53:11.542725Z","steps":["trace[1750746240] 'process raft request' (duration: 565.432034ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:11.542804Z","caller":"traceutil/trace.go:171","msg":"trace[1815669340] transaction","detail":"{read_only:false; number_of_response:0; response_revision:235; }","duration":"566.894202ms","start":"2026-07-20T18:53:10.975874Z","end":"2026-07-20T18:53:11.542768Z","steps":["trace[1815669340] 'process raft request' (duration: 566.451987ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:11.542885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:10.977024Z","time spent":"565.768318ms","remote":"127.0.0.1:58340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-20T18:53:11.542889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:10.976175Z","time spent":"566.540377ms","remote":"127.0.0.1:58340","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-20T18:53:11.54293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:10.975857Z","time spent":"566.996352ms","remote":"127.0.0.1:58340","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-20T18:53:11.543045Z","caller":"traceutil/trace.go:171","msg":"trace[2099496283] transaction","detail":"{read_only:false; response_revision:236; number_of_response:1; }","duration":"566.961781ms","start":"2026-07-20T18:53:10.976073Z","end":"2026-07-20T18:53:11.543035Z","steps":["trace[2099496283] 'process raft request' (duration: 566.286844ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:11.543115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:10.976068Z","time spent":"567.022732ms","remote":"127.0.0.1:58340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-20T18:53:11.543232Z","caller":"traceutil/trace.go:171","msg":"trace[1423300033] transaction","detail":"{read_only:false; number_of_response:0; response_revision:235; }","duration":"584.904775ms","start":"2026-07-20T18:53:10.95776Z","end":"2026-07-20T18:53:11.542665Z","steps":["trace[1423300033] 'process raft request' (duration: 584.510391ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:11.543326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:10.957739Z","time spent":"585.566792ms","remote":"127.0.0.1:58328","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-20T18:53:11.543504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:10.859025Z","time spent":"683.465263ms","remote":"127.0.0.1:58248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-20T18:53:11.543504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:10.977042Z","time spent":"565.654517ms","remote":"127.0.0.1:58340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-20T18:53:12.286518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.214778ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-20T18:53:12.286691Z","caller":"traceutil/trace.go:171","msg":"trace[1907037016] transaction","detail":"{read_only:false; response_revision:240; number_of_response:1; }","duration":"736.973355ms","start":"2026-07-20T18:53:11.549701Z","end":"2026-07-20T18:53:12.286675Z","steps":["trace[1907037016] 'process raft request' (duration: 736.906694ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:12.286673Z","caller":"traceutil/trace.go:171","msg":"trace[139919118] transaction","detail":"{read_only:false; response_revision:239; number_of_response:1; }","duration":"1.271362051s","start":"2026-07-20T18:53:11.015285Z","end":"2026-07-20T18:53:12.286647Z","steps":["trace[139919118] 'process raft request' (duration: 792.717878ms)","trace[139919118] 'compare' (duration: 477.693072ms)"],"step_count":2} {"level":"warn","ts":"2026-07-20T18:53:12.286748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:11.54969Z","time spent":"737.035825ms","remote":"127.0.0.1:58248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-20T18:53:12.286785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:11.015263Z","time spent":"1.271468572s","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-20T18:53:12.286862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.430083514s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-20T18:53:12.286899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.3210667s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-20T18:53:12.286765Z","caller":"traceutil/trace.go:171","msg":"trace[1566282935] linearizableReadLoop","detail":"{readStateIndex:248; appliedIndex:240; }","duration":"1.275660822s","start":"2026-07-20T18:53:11.011076Z","end":"2026-07-20T18:53:12.286737Z","steps":["trace[1566282935] 'read index received' (duration: 531.063976ms)","trace[1566282935] 'applied index is now lower than readState.Index' (duration: 744.593075ms)"],"step_count":2} {"level":"info","ts":"2026-07-20T18:53:12.286969Z","caller":"traceutil/trace.go:171","msg":"trace[349373550] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:240; }","duration":"1.321188141s","start":"2026-07-20T18:53:10.965762Z","end":"2026-07-20T18:53:12.28695Z","steps":["trace[349373550] 'agreement among raft nodes before linearized reading' (duration: 1.321000369s)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:12.28699Z","caller":"traceutil/trace.go:171","msg":"trace[758622191] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:240; }","duration":"1.430195885s","start":"2026-07-20T18:53:10.856736Z","end":"2026-07-20T18:53:12.286932Z","steps":["trace[758622191] 'agreement among raft nodes before linearized reading' (duration: 1.430021413s)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:12.287026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:10.965743Z","time spent":"1.321270953s","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-20T18:53:12.287051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:10.856727Z","time spent":"1.430313336s","remote":"127.0.0.1:58422","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":"warn","ts":"2026-07-20T18:53:12.287173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.4306227s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"warn","ts":"2026-07-20T18:53:12.287209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.272401534s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-20T18:53:12.287222Z","caller":"traceutil/trace.go:171","msg":"trace[1599504741] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:240; }","duration":"1.430707662s","start":"2026-07-20T18:53:10.856501Z","end":"2026-07-20T18:53:12.287209Z","steps":["trace[1599504741] 'agreement among raft nodes before linearized reading' (duration: 1.430541169s)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:12.287243Z","caller":"traceutil/trace.go:171","msg":"trace[1732645379] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:0; response_revision:240; }","duration":"1.272470414s","start":"2026-07-20T18:53:11.014761Z","end":"2026-07-20T18:53:12.287232Z","steps":["trace[1732645379] 'agreement among raft nodes before linearized reading' (duration: 1.272422704s)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:12.287258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:10.856484Z","time spent":"1.430766982s","remote":"127.0.0.1:57068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":686,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-07-20T18:53:12.287278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:11.014745Z","time spent":"1.272527235s","remote":"127.0.0.1:58350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-07-20T18:53:12.287312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.372031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"} {"level":"info","ts":"2026-07-20T18:53:12.287358Z","caller":"traceutil/trace.go:171","msg":"trace[741331831] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:240; }","duration":"742.427451ms","start":"2026-07-20T18:53:11.54492Z","end":"2026-07-20T18:53:12.287347Z","steps":["trace[741331831] 'agreement among raft nodes before linearized reading' (duration: 742.34031ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:12.287388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:11.544916Z","time spent":"742.465332ms","remote":"127.0.0.1:58340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":3488,"request content":"key:\"/registry/pods/kube-system/kube-vip-instance\" "} {"level":"warn","ts":"2026-07-20T18:53:12.287182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.51071289s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-20T18:53:12.287526Z","caller":"traceutil/trace.go:171","msg":"trace[404672628] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:0; response_revision:240; }","duration":"1.511101505s","start":"2026-07-20T18:53:10.776409Z","end":"2026-07-20T18:53:12.28751Z","steps":["trace[404672628] 'agreement among raft nodes before linearized reading' (duration: 1.510657839s)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:12.287556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.567403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"warn","ts":"2026-07-20T18:53:12.287571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:10.776384Z","time spent":"1.511174586s","remote":"127.0.0.1:57128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" "} {"level":"info","ts":"2026-07-20T18:53:12.287586Z","caller":"traceutil/trace.go:171","msg":"trace[762042209] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:240; }","duration":"742.601343ms","start":"2026-07-20T18:53:11.544974Z","end":"2026-07-20T18:53:12.287575Z","steps":["trace[762042209] 'agreement among raft nodes before linearized reading' (duration: 742.549072ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:12.287615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:11.54497Z","time spent":"742.637363ms","remote":"127.0.0.1:58328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4039,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-07-20T18:53:12.287619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"809.08513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-20T18:53:12.287483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.572173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5897"} {"level":"info","ts":"2026-07-20T18:53:12.287662Z","caller":"traceutil/trace.go:171","msg":"trace[1463849735] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:240; }","duration":"809.156062ms","start":"2026-07-20T18:53:11.478496Z","end":"2026-07-20T18:53:12.287652Z","steps":["trace[1463849735] 'agreement among raft nodes before linearized reading' (duration: 809.102351ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:12.287685Z","caller":"traceutil/trace.go:171","msg":"trace[1003299012] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:240; }","duration":"742.787125ms","start":"2026-07-20T18:53:11.544888Z","end":"2026-07-20T18:53:12.287675Z","steps":["trace[1003299012] 'agreement among raft nodes before linearized reading' (duration: 742.548702ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:12.287689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:11.478476Z","time spent":"809.207362ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-20T18:53:12.287722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:11.544875Z","time spent":"742.838565ms","remote":"127.0.0.1:58340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":5919,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"warn","ts":"2026-07-20T18:53:12.287703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.055577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"} {"level":"info","ts":"2026-07-20T18:53:12.287918Z","caller":"traceutil/trace.go:171","msg":"trace[304129087] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:240; }","duration":"408.35967ms","start":"2026-07-20T18:53:11.879542Z","end":"2026-07-20T18:53:12.287902Z","steps":["trace[304129087] 'agreement among raft nodes before linearized reading' (duration: 407.913415ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:12.288015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:11.879521Z","time spent":"408.472592ms","remote":"127.0.0.1:58340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":3488,"request content":"key:\"/registry/pods/kube-system/kube-vip-instance\" "} {"level":"info","ts":"2026-07-20T18:53:21.096792Z","caller":"traceutil/trace.go:171","msg":"trace[814848058] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"121.273821ms","start":"2026-07-20T18:53:20.97548Z","end":"2026-07-20T18:53:21.096753Z","steps":["trace[814848058] 'process raft request' (duration: 73.683489ms)","trace[814848058] 'compare' (duration: 47.422999ms)"],"step_count":2} {"level":"info","ts":"2026-07-20T18:53:29.726197Z","caller":"traceutil/trace.go:171","msg":"trace[1353921285] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"100.378209ms","start":"2026-07-20T18:53:29.6258Z","end":"2026-07-20T18:53:29.726178Z","steps":["trace[1353921285] 'process raft request' (duration: 100.257428ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:29.846748Z","caller":"traceutil/trace.go:171","msg":"trace[121969063] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"114.785688ms","start":"2026-07-20T18:53:29.731938Z","end":"2026-07-20T18:53:29.846723Z","steps":["trace[121969063] 'process raft request' (duration: 96.971469ms)","trace[121969063] 'compare' (duration: 17.634487ms)"],"step_count":2} {"level":"info","ts":"2026-07-20T18:53:43.280551Z","caller":"traceutil/trace.go:171","msg":"trace[1199812081] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"585.548203ms","start":"2026-07-20T18:53:42.694979Z","end":"2026-07-20T18:53:43.280527Z","steps":["trace[1199812081] 'process raft request' (duration: 585.24589ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:43.280672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:42.694959Z","time spent":"585.662214ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-20T18:53:43.28812Z","caller":"traceutil/trace.go:171","msg":"trace[1082525727] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"589.531999ms","start":"2026-07-20T18:53:42.698575Z","end":"2026-07-20T18:53:43.288107Z","steps":["trace[1082525727] 'process raft request' (duration: 589.404358ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:43.288171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:42.698545Z","time spent":"589.603651ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-20T18:53:43.288267Z","caller":"traceutil/trace.go:171","msg":"trace[235292379] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"579.176409ms","start":"2026-07-20T18:53:42.709048Z","end":"2026-07-20T18:53:43.288225Z","steps":["trace[235292379] 'process raft request' (duration: 579.057287ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:43.288345Z","caller":"traceutil/trace.go:171","msg":"trace[1999455591] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"570.596108ms","start":"2026-07-20T18:53:42.717726Z","end":"2026-07-20T18:53:43.288323Z","steps":["trace[1999455591] 'process raft request' (duration: 570.468026ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:43.288399Z","caller":"traceutil/trace.go:171","msg":"trace[1973872968] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"558.422865ms","start":"2026-07-20T18:53:42.729968Z","end":"2026-07-20T18:53:43.288391Z","steps":["trace[1973872968] 'process raft request' (duration: 558.251714ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:43.288429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:42.717715Z","time spent":"570.681469ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-20T18:53:43.288442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:42.709031Z","time spent":"579.31343ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-20T18:53:43.288468Z","caller":"traceutil/trace.go:171","msg":"trace[861472825] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"554.398549ms","start":"2026-07-20T18:53:42.734058Z","end":"2026-07-20T18:53:43.288457Z","steps":["trace[861472825] 'process raft request' (duration: 554.206147ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:43.288494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:42.729936Z","time spent":"558.500357ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-20T18:53:43.288329Z","caller":"traceutil/trace.go:171","msg":"trace[384737221] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"575.06217ms","start":"2026-07-20T18:53:42.713222Z","end":"2026-07-20T18:53:43.288284Z","steps":["trace[384737221] 'process raft request' (duration: 574.929499ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:43.28853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:42.734038Z","time spent":"554.46956ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-20T18:53:43.28858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:42.71318Z","time spent":"575.376523ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-20T18:53:43.288593Z","caller":"traceutil/trace.go:171","msg":"trace[1946202135] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"347.839548ms","start":"2026-07-20T18:53:42.940737Z","end":"2026-07-20T18:53:43.288576Z","steps":["trace[1946202135] 'process raft request' (duration: 347.786017ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:43.288628Z","caller":"traceutil/trace.go:171","msg":"trace[2057980146] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"411.731885ms","start":"2026-07-20T18:53:42.876889Z","end":"2026-07-20T18:53:43.288621Z","steps":["trace[2057980146] 'process raft request' (duration: 411.569902ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:43.288638Z","caller":"traceutil/trace.go:171","msg":"trace[1866916759] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"533.326744ms","start":"2026-07-20T18:53:42.755304Z","end":"2026-07-20T18:53:43.288631Z","steps":["trace[1866916759] 'process raft request' (duration: 532.995339ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:43.288661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:42.876857Z","time spent":"411.788666ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-20T18:53:43.28868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:42.755285Z","time spent":"533.375874ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-20T18:53:43.288755Z","caller":"traceutil/trace.go:171","msg":"trace[184946597] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"589.944745ms","start":"2026-07-20T18:53:42.698796Z","end":"2026-07-20T18:53:43.288741Z","steps":["trace[184946597] 'process raft request' (duration: 589.266507ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:43.288249Z","caller":"traceutil/trace.go:171","msg":"trace[620245574] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"575.475396ms","start":"2026-07-20T18:53:42.71276Z","end":"2026-07-20T18:53:43.288235Z","steps":["trace[620245574] 'process raft request' (duration: 575.372445ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:43.288813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:42.69879Z","time spent":"590.002396ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-20T18:53:43.288843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:42.712729Z","time spent":"576.083083ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-20T18:53:43.28861Z","caller":"traceutil/trace.go:171","msg":"trace[211441775] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"519.223319ms","start":"2026-07-20T18:53:42.769378Z","end":"2026-07-20T18:53:43.288601Z","steps":["trace[211441775] 'process raft request' (duration: 518.974455ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:43.288892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:42.94072Z","time spent":"347.93447ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-20T18:53:43.288909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:42.769354Z","time spent":"519.530543ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-20T18:53:43.877843Z","caller":"traceutil/trace.go:171","msg":"trace[1320540404] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"109.105023ms","start":"2026-07-20T18:53:43.768724Z","end":"2026-07-20T18:53:43.877829Z","steps":["trace[1320540404] 'process raft request' (duration: 108.975012ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:43.877984Z","caller":"traceutil/trace.go:171","msg":"trace[1207057011] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"140.224396ms","start":"2026-07-20T18:53:43.737753Z","end":"2026-07-20T18:53:43.877978Z","steps":["trace[1207057011] 'process raft request' (duration: 67.820412ms)","trace[1207057011] 'compare' (duration: 71.980139ms)"],"step_count":2} {"level":"warn","ts":"2026-07-20T18:53:44.386092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.218522ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-20T18:53:44.386212Z","caller":"traceutil/trace.go:171","msg":"trace[1268129048] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"356.217424ms","start":"2026-07-20T18:53:44.029976Z","end":"2026-07-20T18:53:44.386193Z","steps":["trace[1268129048] 'process raft request' (duration: 223.8314ms)","trace[1268129048] 'compare' (duration: 132.09863ms)"],"step_count":2} {"level":"warn","ts":"2026-07-20T18:53:44.386274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:44.029948Z","time spent":"356.297035ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-20T18:53:44.399428Z","caller":"traceutil/trace.go:171","msg":"trace[899827277] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"364.147617ms","start":"2026-07-20T18:53:44.035242Z","end":"2026-07-20T18:53:44.399389Z","steps":["trace[899827277] 'process raft request' (duration: 354.544885ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:44.39958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:44.035209Z","time spent":"364.303628ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98698,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-20T18:53:44.399819Z","caller":"traceutil/trace.go:171","msg":"trace[437946904] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"252.389413ms","start":"2026-07-20T18:53:44.147405Z","end":"2026-07-20T18:53:44.399794Z","steps":["trace[437946904] 'process raft request' (duration: 243.038484ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:44.607345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.468012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-20T18:53:44.607383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.328091ms","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-07-20T18:53:44.607433Z","caller":"traceutil/trace.go:171","msg":"trace[633771175] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:557; }","duration":"125.569743ms","start":"2026-07-20T18:53:44.481844Z","end":"2026-07-20T18:53:44.607414Z","steps":["trace[633771175] 'agreement among raft nodes before linearized reading' (duration: 125.368211ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:44.607464Z","caller":"traceutil/trace.go:171","msg":"trace[1929644852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:557; }","duration":"125.441523ms","start":"2026-07-20T18:53:44.482007Z","end":"2026-07-20T18:53:44.607448Z","steps":["trace[1929644852] 'agreement among raft nodes before linearized reading' (duration: 125.293131ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:44.607353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.385749ms","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-07-20T18:53:44.607597Z","caller":"traceutil/trace.go:171","msg":"trace[854532576] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:557; }","duration":"124.620533ms","start":"2026-07-20T18:53:44.482929Z","end":"2026-07-20T18:53:44.607549Z","steps":["trace[854532576] 'agreement among raft nodes before linearized reading' (duration: 124.302518ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:44.825324Z","caller":"traceutil/trace.go:171","msg":"trace[1730742792] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"270.450814ms","start":"2026-07-20T18:53:44.554775Z","end":"2026-07-20T18:53:44.825226Z","steps":["trace[1730742792] 'process raft request' (duration: 213.704482ms)","trace[1730742792] 'compare' (duration: 56.429019ms)"],"step_count":2} {"level":"info","ts":"2026-07-20T18:53:44.825716Z","caller":"traceutil/trace.go:171","msg":"trace[1787140455] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"214.41812ms","start":"2026-07-20T18:53:44.611274Z","end":"2026-07-20T18:53:44.825693Z","steps":["trace[1787140455] 'process raft request' (duration: 214.097307ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:44.825897Z","caller":"traceutil/trace.go:171","msg":"trace[1615122992] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"214.510551ms","start":"2026-07-20T18:53:44.61137Z","end":"2026-07-20T18:53:44.82588Z","steps":["trace[1615122992] 'process raft request' (duration: 214.277409ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:44.826075Z","caller":"traceutil/trace.go:171","msg":"trace[633685220] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"214.284109ms","start":"2026-07-20T18:53:44.611776Z","end":"2026-07-20T18:53:44.82606Z","steps":["trace[633685220] 'process raft request' (duration: 214.048906ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:44.826303Z","caller":"traceutil/trace.go:171","msg":"trace[1582374984] linearizableReadLoop","detail":"{readStateIndex:585; appliedIndex:580; }","duration":"186.966352ms","start":"2026-07-20T18:53:44.639323Z","end":"2026-07-20T18:53:44.826289Z","steps":["trace[1582374984] 'read index received' (duration: 129.214458ms)","trace[1582374984] 'applied index is now lower than readState.Index' (duration: 57.751144ms)"],"step_count":2} {"level":"info","ts":"2026-07-20T18:53:44.826352Z","caller":"traceutil/trace.go:171","msg":"trace[730362991] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"203.25961ms","start":"2026-07-20T18:53:44.623066Z","end":"2026-07-20T18:53:44.826326Z","steps":["trace[730362991] 'process raft request' (duration: 202.897926ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:44.826462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.106983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-07-20T18:53:44.826501Z","caller":"traceutil/trace.go:171","msg":"trace[561357941] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:563; }","duration":"187.196694ms","start":"2026-07-20T18:53:44.639294Z","end":"2026-07-20T18:53:44.826491Z","steps":["trace[561357941] 'agreement among raft nodes before linearized reading' (duration: 187.050492ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:44.826592Z","caller":"traceutil/trace.go:171","msg":"trace[687200347] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"160.437362ms","start":"2026-07-20T18:53:44.666137Z","end":"2026-07-20T18:53:44.826574Z","steps":["trace[687200347] 'process raft request' (duration: 159.984257ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:45.715527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.543122ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-20T18:53:45.715655Z","caller":"traceutil/trace.go:171","msg":"trace[2008946073] linearizableReadLoop","detail":"{readStateIndex:589; appliedIndex:588; }","duration":"345.990053ms","start":"2026-07-20T18:53:45.369648Z","end":"2026-07-20T18:53:45.715638Z","steps":["trace[2008946073] 'read index received' (duration: 161.195159ms)","trace[2008946073] 'applied index is now lower than readState.Index' (duration: 184.793804ms)"],"step_count":2} {"level":"info","ts":"2026-07-20T18:53:45.71569Z","caller":"traceutil/trace.go:171","msg":"trace[966582258] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"414.4026ms","start":"2026-07-20T18:53:45.301259Z","end":"2026-07-20T18:53:45.715661Z","steps":["trace[966582258] 'process raft request' (duration: 229.638616ms)","trace[966582258] 'compare' (duration: 184.38701ms)"],"step_count":2} {"level":"warn","ts":"2026-07-20T18:53:45.715819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:45.301247Z","time spent":"414.505251ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208470,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-20T18:53:45.715836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.184115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:15688"} {"level":"info","ts":"2026-07-20T18:53:45.71587Z","caller":"traceutil/trace.go:171","msg":"trace[1390115317] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:566; }","duration":"346.252596ms","start":"2026-07-20T18:53:45.369606Z","end":"2026-07-20T18:53:45.715859Z","steps":["trace[1390115317] 'agreement among raft nodes before linearized reading' (duration: 346.123315ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:45.715893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.426061ms","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-07-20T18:53:45.715957Z","caller":"traceutil/trace.go:171","msg":"trace[1959464591] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:566; }","duration":"312.525832ms","start":"2026-07-20T18:53:45.403413Z","end":"2026-07-20T18:53:45.715938Z","steps":["trace[1959464591] 'agreement among raft nodes before linearized reading' (duration: 312.413271ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:45.715987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.969257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-20T18:53:45.715999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:45.403397Z","time spent":"312.592183ms","remote":"127.0.0.1:38788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-07-20T18:53:45.716025Z","caller":"traceutil/trace.go:171","msg":"trace[354157034] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:566; }","duration":"216.028178ms","start":"2026-07-20T18:53:45.499988Z","end":"2026-07-20T18:53:45.716016Z","steps":["trace[354157034] 'agreement among raft nodes before linearized reading' (duration: 215.972668ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:45.716236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.426911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-20T18:53:45.716289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.696553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-20T18:53:45.716319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.016477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-20T18:53:45.716346Z","caller":"traceutil/trace.go:171","msg":"trace[1144583601] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:566; }","duration":"142.780635ms","start":"2026-07-20T18:53:45.573548Z","end":"2026-07-20T18:53:45.716329Z","steps":["trace[1144583601] 'agreement among raft nodes before linearized reading' (duration: 142.702674ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:45.716364Z","caller":"traceutil/trace.go:171","msg":"trace[1863925224] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:566; }","duration":"197.554412ms","start":"2026-07-20T18:53:45.518763Z","end":"2026-07-20T18:53:45.716317Z","steps":["trace[1863925224] 'agreement among raft nodes before linearized reading' (duration: 197.414511ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:45.71635Z","caller":"traceutil/trace.go:171","msg":"trace[1456643387] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:566; }","duration":"216.066588ms","start":"2026-07-20T18:53:45.500274Z","end":"2026-07-20T18:53:45.71634Z","steps":["trace[1456643387] 'agreement among raft nodes before linearized reading' (duration: 216.024247ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:45.715921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.126608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-20T18:53:45.716631Z","caller":"traceutil/trace.go:171","msg":"trace[1473321892] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:566; }","duration":"143.893188ms","start":"2026-07-20T18:53:45.572726Z","end":"2026-07-20T18:53:45.716619Z","steps":["trace[1473321892] 'agreement among raft nodes before linearized reading' (duration: 143.178549ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:45.715904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:45.369587Z","time spent":"346.308677ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":15710,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-07-20T18:53:45.716837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.813572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-20T18:53:45.716868Z","caller":"traceutil/trace.go:171","msg":"trace[668729903] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:566; }","duration":"267.911763ms","start":"2026-07-20T18:53:45.448948Z","end":"2026-07-20T18:53:45.716859Z","steps":["trace[668729903] 'agreement among raft nodes before linearized reading' (duration: 267.860973ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:45.7169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.065639ms","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-07-20T18:53:45.716931Z","caller":"traceutil/trace.go:171","msg":"trace[421673983] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:566; }","duration":"198.11246ms","start":"2026-07-20T18:53:45.518811Z","end":"2026-07-20T18:53:45.716923Z","steps":["trace[421673983] 'agreement among raft nodes before linearized reading' (duration: 198.066929ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:45.716917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.690523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-20T18:53:45.716917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.798342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-20T18:53:45.717012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.16054ms","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":"warn","ts":"2026-07-20T18:53:45.717024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.730053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-20T18:53:45.717034Z","caller":"traceutil/trace.go:171","msg":"trace[67360017] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:566; }","duration":"198.19342ms","start":"2026-07-20T18:53:45.518834Z","end":"2026-07-20T18:53:45.717028Z","steps":["trace[67360017] 'agreement among raft nodes before linearized reading' (duration: 198.16458ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:45.716276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.812785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-20T18:53:45.717052Z","caller":"traceutil/trace.go:171","msg":"trace[219298361] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:566; }","duration":"238.786803ms","start":"2026-07-20T18:53:45.478257Z","end":"2026-07-20T18:53:45.717044Z","steps":["trace[219298361] 'agreement among raft nodes before linearized reading' (duration: 238.744383ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:45.717062Z","caller":"traceutil/trace.go:171","msg":"trace[1601233965] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:566; }","duration":"216.614815ms","start":"2026-07-20T18:53:45.500438Z","end":"2026-07-20T18:53:45.717052Z","steps":["trace[1601233965] 'agreement among raft nodes before linearized reading' (duration: 215.798746ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:45.717025Z","caller":"traceutil/trace.go:171","msg":"trace[349056431] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:566; }","duration":"267.924613ms","start":"2026-07-20T18:53:45.449085Z","end":"2026-07-20T18:53:45.717009Z","steps":["trace[349056431] 'agreement among raft nodes before linearized reading' (duration: 267.788921ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:45.716716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.921438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-20T18:53:45.716977Z","caller":"traceutil/trace.go:171","msg":"trace[1240622679] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:566; }","duration":"238.779313ms","start":"2026-07-20T18:53:45.478183Z","end":"2026-07-20T18:53:45.716962Z","steps":["trace[1240622679] 'agreement among raft nodes before linearized reading' (duration: 238.687752ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:45.717135Z","caller":"traceutil/trace.go:171","msg":"trace[1567022662] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:566; }","duration":"144.364122ms","start":"2026-07-20T18:53:45.57276Z","end":"2026-07-20T18:53:45.717124Z","steps":["trace[1567022662] 'agreement among raft nodes before linearized reading' (duration: 143.916487ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:45.716977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.452533ms","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-07-20T18:53:45.7172Z","caller":"traceutil/trace.go:171","msg":"trace[1741438150] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:566; }","duration":"313.720927ms","start":"2026-07-20T18:53:45.403473Z","end":"2026-07-20T18:53:45.717194Z","steps":["trace[1741438150] 'agreement among raft nodes before linearized reading' (duration: 313.470874ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:45.717229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:45.403453Z","time spent":"313.769107ms","remote":"127.0.0.1:38788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-20T18:53:45.717648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.798832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-20T18:53:45.717701Z","caller":"traceutil/trace.go:171","msg":"trace[891898216] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:566; }","duration":"239.310659ms","start":"2026-07-20T18:53:45.478377Z","end":"2026-07-20T18:53:45.717688Z","steps":["trace[891898216] 'agreement among raft nodes before linearized reading' (duration: 237.780902ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:49.220102Z","caller":"traceutil/trace.go:171","msg":"trace[886893022] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"377.366362ms","start":"2026-07-20T18:53:48.84271Z","end":"2026-07-20T18:53:49.220076Z","steps":["trace[886893022] 'read index received' (duration: 376.590393ms)","trace[886893022] 'applied index is now lower than readState.Index' (duration: 775.159µs)"],"step_count":2} {"level":"info","ts":"2026-07-20T18:53:49.220912Z","caller":"traceutil/trace.go:171","msg":"trace[1755485193] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"505.32772ms","start":"2026-07-20T18:53:48.715573Z","end":"2026-07-20T18:53:49.220901Z","steps":["trace[1755485193] 'process raft request' (duration: 503.980996ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:49.221016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:48.715546Z","time spent":"505.399313ms","remote":"127.0.0.1:58254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036193,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-20T18:53:49.221303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.571097ms","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-07-20T18:53:49.221384Z","caller":"traceutil/trace.go:171","msg":"trace[1958138345] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:580; }","duration":"378.699479ms","start":"2026-07-20T18:53:48.842665Z","end":"2026-07-20T18:53:49.221364Z","steps":["trace[1958138345] 'agreement among raft nodes before linearized reading' (duration: 378.475356ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:49.221427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:48.842645Z","time spent":"378.773209ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-20T18:53:49.221976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.708238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-20T18:53:49.222046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.448353ms","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-07-20T18:53:49.222113Z","caller":"traceutil/trace.go:171","msg":"trace[673291035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:580; }","duration":"371.514084ms","start":"2026-07-20T18:53:48.850561Z","end":"2026-07-20T18:53:49.222075Z","steps":["trace[673291035] 'agreement among raft nodes before linearized reading' (duration: 371.362683ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:49.222112Z","caller":"traceutil/trace.go:171","msg":"trace[1313810255] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:580; }","duration":"372.846229ms","start":"2026-07-20T18:53:48.849212Z","end":"2026-07-20T18:53:49.222058Z","steps":["trace[1313810255] 'agreement among raft nodes before linearized reading' (duration: 372.557796ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:49.222151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:48.850548Z","time spent":"371.596355ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-20T18:53:49.222198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:48.849201Z","time spent":"372.98245ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-20T18:53:49.222402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.024393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-20T18:53:49.222439Z","caller":"traceutil/trace.go:171","msg":"trace[228960054] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:580; }","duration":"373.076523ms","start":"2026-07-20T18:53:48.849354Z","end":"2026-07-20T18:53:49.222431Z","steps":["trace[228960054] 'agreement among raft nodes before linearized reading' (duration: 372.985612ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:49.222472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:48.849347Z","time spent":"373.118353ms","remote":"127.0.0.1:58422","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-07-20T18:53:49.228642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.411529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.116\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-20T18:53:49.228717Z","caller":"traceutil/trace.go:171","msg":"trace[608227703] range","detail":"{range_begin:/registry/masterleases/199.204.45.116; range_end:; response_count:1; response_revision:580; }","duration":"216.51611ms","start":"2026-07-20T18:53:49.012187Z","end":"2026-07-20T18:53:49.228703Z","steps":["trace[608227703] 'agreement among raft nodes before linearized reading' (duration: 214.85265ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:49.332836Z","caller":"traceutil/trace.go:171","msg":"trace[834334162] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"107.355009ms","start":"2026-07-20T18:53:49.225446Z","end":"2026-07-20T18:53:49.332801Z","steps":["trace[834334162] 'process raft request' (duration: 103.646636ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:49.337395Z","caller":"traceutil/trace.go:171","msg":"trace[273353502] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"110.701808ms","start":"2026-07-20T18:53:49.22666Z","end":"2026-07-20T18:53:49.337361Z","steps":["trace[273353502] 'process raft request' (duration: 110.490756ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:49.337512Z","caller":"traceutil/trace.go:171","msg":"trace[1371420905] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"110.659747ms","start":"2026-07-20T18:53:49.226794Z","end":"2026-07-20T18:53:49.337453Z","steps":["trace[1371420905] 'process raft request' (duration: 110.491346ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:49.337739Z","caller":"traceutil/trace.go:171","msg":"trace[613379170] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"109.043449ms","start":"2026-07-20T18:53:49.228678Z","end":"2026-07-20T18:53:49.337721Z","steps":["trace[613379170] 'process raft request' (duration: 108.644865ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:50.47643Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853971964112090627,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-20T18:53:50.494825Z","caller":"traceutil/trace.go:171","msg":"trace[1779578794] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"518.773784ms","start":"2026-07-20T18:53:49.976022Z","end":"2026-07-20T18:53:50.494795Z","steps":["trace[1779578794] 'read index received' (duration: 517.881244ms)","trace[1779578794] 'applied index is now lower than readState.Index' (duration: 891.34µs)"],"step_count":2} {"level":"info","ts":"2026-07-20T18:53:50.494899Z","caller":"traceutil/trace.go:171","msg":"trace[511026314] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"738.283879ms","start":"2026-07-20T18:53:49.756585Z","end":"2026-07-20T18:53:50.494869Z","steps":["trace[511026314] 'process raft request' (duration: 737.619092ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:50.495857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:49.756559Z","time spent":"739.138569ms","remote":"127.0.0.1:58254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036225,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-20T18:53:50.496035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.006498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-fsw6q\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-20T18:53:50.496131Z","caller":"traceutil/trace.go:171","msg":"trace[401199235] range","detail":"{range_begin:/registry/pods/kube-system/cilium-fsw6q; range_end:; response_count:1; response_revision:590; }","duration":"520.094399ms","start":"2026-07-20T18:53:49.975983Z","end":"2026-07-20T18:53:50.496077Z","steps":["trace[401199235] 'agreement among raft nodes before linearized reading' (duration: 518.913925ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:50.496174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:49.975964Z","time spent":"520.19945ms","remote":"127.0.0.1:58340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-fsw6q\" "} {"level":"info","ts":"2026-07-20T18:53:50.643569Z","caller":"traceutil/trace.go:171","msg":"trace[1810444788] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"133.036098ms","start":"2026-07-20T18:53:50.510507Z","end":"2026-07-20T18:53:50.643543Z","steps":["trace[1810444788] 'process raft request' (duration: 132.763604ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:51.799767Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853971964112090632,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-20T18:53:52.246592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:50.966508Z","time spent":"1.280077042s","remote":"127.0.0.1:57530","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-20T18:53:52.28941Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.234511881s","expected-duration":"1s"} {"level":"info","ts":"2026-07-20T18:53:52.291227Z","caller":"traceutil/trace.go:171","msg":"trace[1048501891] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:616; }","duration":"992.273824ms","start":"2026-07-20T18:53:51.298931Z","end":"2026-07-20T18:53:52.291205Z","steps":["trace[1048501891] 'read index received' (duration: 990.784727ms)","trace[1048501891] 'applied index is now lower than readState.Index' (duration: 1.487877ms)"],"step_count":2} {"level":"info","ts":"2026-07-20T18:53:52.291329Z","caller":"traceutil/trace.go:171","msg":"trace[218077391] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"1.237342154s","start":"2026-07-20T18:53:51.05394Z","end":"2026-07-20T18:53:52.291282Z","steps":["trace[218077391] 'process raft request' (duration: 1.236749888s)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:52.291471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:51.05392Z","time spent":"1.237469356s","remote":"127.0.0.1:58254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-20T18:53:52.291494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"954.244574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-20T18:53:52.291531Z","caller":"traceutil/trace.go:171","msg":"trace[1120605474] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:593; }","duration":"954.337355ms","start":"2026-07-20T18:53:51.337181Z","end":"2026-07-20T18:53:52.291518Z","steps":["trace[1120605474] 'agreement among raft nodes before linearized reading' (duration: 954.192262ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:52.291481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"992.538318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-20T18:53:52.291587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:51.337157Z","time spent":"954.421035ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-20T18:53:52.291622Z","caller":"traceutil/trace.go:171","msg":"trace[1929865366] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:593; }","duration":"992.73772ms","start":"2026-07-20T18:53:51.298845Z","end":"2026-07-20T18:53:52.291583Z","steps":["trace[1929865366] 'agreement among raft nodes before linearized reading' (duration: 992.456746ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:52.291688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:51.298812Z","time spent":"992.865662ms","remote":"127.0.0.1:58158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-20T18:53:52.292032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"950.119355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-20T18:53:52.292083Z","caller":"traceutil/trace.go:171","msg":"trace[395630697] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:593; }","duration":"950.212927ms","start":"2026-07-20T18:53:51.341858Z","end":"2026-07-20T18:53:52.292071Z","steps":["trace[395630697] 'agreement among raft nodes before linearized reading' (duration: 950.032985ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:52.292117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:51.341838Z","time spent":"950.271747ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-20T18:53:52.29228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"950.222477ms","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-07-20T18:53:52.292313Z","caller":"traceutil/trace.go:171","msg":"trace[44216009] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:593; }","duration":"950.326848ms","start":"2026-07-20T18:53:51.341977Z","end":"2026-07-20T18:53:52.292304Z","steps":["trace[44216009] 'agreement among raft nodes before linearized reading' (duration: 950.234867ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:52.292339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:51.341935Z","time spent":"950.397769ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-20T18:53:52.292802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"950.328187ms","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-07-20T18:53:52.292847Z","caller":"traceutil/trace.go:171","msg":"trace[1550896680] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:593; }","duration":"950.424739ms","start":"2026-07-20T18:53:51.342411Z","end":"2026-07-20T18:53:52.292836Z","steps":["trace[1550896680] 'agreement among raft nodes before linearized reading' (duration: 949.467638ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:52.293575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:53:51.342401Z","time spent":"951.105546ms","remote":"127.0.0.1:58422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-20T18:53:52.548496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.969595ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-20T18:53:52.548896Z","caller":"traceutil/trace.go:171","msg":"trace[1720291235] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"197.614557ms","start":"2026-07-20T18:53:52.35126Z","end":"2026-07-20T18:53:52.548875Z","steps":["trace[1720291235] 'process raft request' (duration: 197.574306ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:52.548978Z","caller":"traceutil/trace.go:171","msg":"trace[2026565438] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"251.586183ms","start":"2026-07-20T18:53:52.297353Z","end":"2026-07-20T18:53:52.54894Z","steps":["trace[2026565438] 'process raft request' (duration: 251.362071ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:52.549147Z","caller":"traceutil/trace.go:171","msg":"trace[154080297] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:617; }","duration":"244.961517ms","start":"2026-07-20T18:53:52.304145Z","end":"2026-07-20T18:53:52.549106Z","steps":["trace[154080297] 'read index received' (duration: 13.211124ms)","trace[154080297] 'applied index is now lower than readState.Index' (duration: 231.744573ms)"],"step_count":2} {"level":"info","ts":"2026-07-20T18:53:52.549205Z","caller":"traceutil/trace.go:171","msg":"trace[1882903186] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"251.835337ms","start":"2026-07-20T18:53:52.297357Z","end":"2026-07-20T18:53:52.549193Z","steps":["trace[1882903186] 'process raft request' (duration: 143.085063ms)","trace[1882903186] 'compare' (duration: 107.819173ms)"],"step_count":2} {"level":"info","ts":"2026-07-20T18:53:52.549301Z","caller":"traceutil/trace.go:171","msg":"trace[630787368] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"251.056629ms","start":"2026-07-20T18:53:52.29819Z","end":"2026-07-20T18:53:52.549247Z","steps":["trace[630787368] 'process raft request' (duration: 250.600703ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:52.549428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.25151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-20T18:53:52.550011Z","caller":"traceutil/trace.go:171","msg":"trace[684641446] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:598; }","duration":"245.860477ms","start":"2026-07-20T18:53:52.304131Z","end":"2026-07-20T18:53:52.549991Z","steps":["trace[684641446] 'agreement among raft nodes before linearized reading' (duration: 245.095789ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:54.437115Z","caller":"traceutil/trace.go:171","msg":"trace[406965945] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:662; }","duration":"146.603113ms","start":"2026-07-20T18:53:54.290488Z","end":"2026-07-20T18:53:54.437091Z","steps":["trace[406965945] 'read index received' (duration: 145.125736ms)","trace[406965945] 'applied index is now lower than readState.Index' (duration: 1.476107ms)"],"step_count":2} {"level":"warn","ts":"2026-07-20T18:53:54.437301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.755984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-20T18:53:54.437378Z","caller":"traceutil/trace.go:171","msg":"trace[281084879] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:638; }","duration":"146.852755ms","start":"2026-07-20T18:53:54.290479Z","end":"2026-07-20T18:53:54.437332Z","steps":["trace[281084879] 'agreement among raft nodes before linearized reading' (duration: 146.733914ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:54.437659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.504481ms","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-07-20T18:53:54.43774Z","caller":"traceutil/trace.go:171","msg":"trace[79966349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:638; }","duration":"115.581882ms","start":"2026-07-20T18:53:54.322139Z","end":"2026-07-20T18:53:54.437721Z","steps":["trace[79966349] 'agreement among raft nodes before linearized reading' (duration: 115.40314ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:54.438155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.811522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-20T18:53:54.43827Z","caller":"traceutil/trace.go:171","msg":"trace[662259917] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"139.593262ms","start":"2026-07-20T18:53:54.29861Z","end":"2026-07-20T18:53:54.438203Z","steps":["trace[662259917] 'agreement among raft nodes before linearized reading' (duration: 138.800192ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:57.557787Z","caller":"traceutil/trace.go:171","msg":"trace[1440278244] linearizableReadLoop","detail":"{readStateIndex:701; appliedIndex:700; }","duration":"241.4383ms","start":"2026-07-20T18:53:57.316329Z","end":"2026-07-20T18:53:57.557767Z","steps":["trace[1440278244] 'read index received' (duration: 241.334909ms)","trace[1440278244] 'applied index is now lower than readState.Index' (duration: 102.271µs)"],"step_count":2} {"level":"info","ts":"2026-07-20T18:53:57.557831Z","caller":"traceutil/trace.go:171","msg":"trace[179519170] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"258.876903ms","start":"2026-07-20T18:53:57.298926Z","end":"2026-07-20T18:53:57.557803Z","steps":["trace[179519170] 'process raft request' (duration: 258.711421ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:53:57.557961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.958985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-20T18:53:57.558054Z","caller":"traceutil/trace.go:171","msg":"trace[1428293261] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:676; }","duration":"260.078657ms","start":"2026-07-20T18:53:57.297952Z","end":"2026-07-20T18:53:57.558031Z","steps":["trace[1428293261] 'agreement among raft nodes before linearized reading' (duration: 259.889045ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:53:57.614618Z","caller":"traceutil/trace.go:171","msg":"trace[1180586069] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"206.162041ms","start":"2026-07-20T18:53:57.408433Z","end":"2026-07-20T18:53:57.614595Z","steps":["trace[1180586069] 'process raft request' (duration: 205.528504ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:54:04.635601Z","caller":"traceutil/trace.go:171","msg":"trace[953597145] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"146.638266ms","start":"2026-07-20T18:54:04.488934Z","end":"2026-07-20T18:54:04.635573Z","steps":["trace[953597145] 'process raft request' (duration: 146.461954ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:54:07.619344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.448493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-kztgs\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-07-20T18:54:07.619418Z","caller":"traceutil/trace.go:171","msg":"trace[666011034] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-kztgs; range_end:; response_count:1; response_revision:753; }","duration":"545.576334ms","start":"2026-07-20T18:54:07.073825Z","end":"2026-07-20T18:54:07.619401Z","steps":["trace[666011034] 'range keys from in-memory index tree' (duration: 545.28792ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:54:07.619449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:54:07.073804Z","time spent":"545.638254ms","remote":"127.0.0.1:58340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-kztgs\" "} {"level":"info","ts":"2026-07-20T18:54:07.81888Z","caller":"traceutil/trace.go:171","msg":"trace[1187257258] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"191.198969ms","start":"2026-07-20T18:54:07.627656Z","end":"2026-07-20T18:54:07.818854Z","steps":["trace[1187257258] 'process raft request' (duration: 190.926395ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:54:11.949951Z","caller":"traceutil/trace.go:171","msg":"trace[1149365591] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"113.852253ms","start":"2026-07-20T18:54:11.83607Z","end":"2026-07-20T18:54:11.949922Z","steps":["trace[1149365591] 'process raft request' (duration: 113.55515ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:54:13.174419Z","caller":"traceutil/trace.go:171","msg":"trace[1626160195] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"142.862617ms","start":"2026-07-20T18:54:13.031512Z","end":"2026-07-20T18:54:13.174374Z","steps":["trace[1626160195] 'process raft request' (duration: 116.070687ms)","trace[1626160195] 'compare' (duration: 26.325274ms)"],"step_count":2} {"level":"info","ts":"2026-07-20T18:54:13.174457Z","caller":"traceutil/trace.go:171","msg":"trace[1663667684] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"141.966607ms","start":"2026-07-20T18:54:13.032448Z","end":"2026-07-20T18:54:13.174414Z","steps":["trace[1663667684] 'process raft request' (duration: 141.856046ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:54:13.174445Z","caller":"traceutil/trace.go:171","msg":"trace[1456313965] linearizableReadLoop","detail":"{readStateIndex:848; appliedIndex:846; }","duration":"136.08962ms","start":"2026-07-20T18:54:13.038282Z","end":"2026-07-20T18:54:13.174372Z","steps":["trace[1456313965] 'read index received' (duration: 109.413082ms)","trace[1456313965] 'applied index is now lower than readState.Index' (duration: 26.675178ms)"],"step_count":2} {"level":"warn","ts":"2026-07-20T18:54:13.1748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.468303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/\" range_end:\"/registry/serviceaccounts/envoy-gateway-system0\" limit:10000 ","response":"range_response_count:3 size:1862"} {"level":"info","ts":"2026-07-20T18:54:13.175181Z","caller":"traceutil/trace.go:171","msg":"trace[2021306617] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/; range_end:/registry/serviceaccounts/envoy-gateway-system0; response_count:3; response_revision:818; }","duration":"136.924469ms","start":"2026-07-20T18:54:13.038233Z","end":"2026-07-20T18:54:13.175158Z","steps":["trace[2021306617] 'agreement among raft nodes before linearized reading' (duration: 136.251482ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:54:21.845238Z","caller":"traceutil/trace.go:171","msg":"trace[177250285] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"122.540519ms","start":"2026-07-20T18:54:21.722669Z","end":"2026-07-20T18:54:21.845209Z","steps":["trace[177250285] 'process raft request' (duration: 122.494628ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:54:21.84528Z","caller":"traceutil/trace.go:171","msg":"trace[37793900] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"122.711471ms","start":"2026-07-20T18:54:21.722533Z","end":"2026-07-20T18:54:21.845245Z","steps":["trace[37793900] 'process raft request' (duration: 122.528338ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:54:23.034692Z","caller":"traceutil/trace.go:171","msg":"trace[504681051] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"187.617866ms","start":"2026-07-20T18:54:22.847051Z","end":"2026-07-20T18:54:23.034669Z","steps":["trace[504681051] 'process raft request' (duration: 187.472655ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:54:23.066802Z","caller":"traceutil/trace.go:171","msg":"trace[381466864] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"219.31875ms","start":"2026-07-20T18:54:22.847474Z","end":"2026-07-20T18:54:23.066792Z","steps":["trace[381466864] 'process raft request' (duration: 219.23775ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:54:30.961935Z","caller":"traceutil/trace.go:171","msg":"trace[115782915] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"109.343444ms","start":"2026-07-20T18:54:30.85256Z","end":"2026-07-20T18:54:30.961904Z","steps":["trace[115782915] 'process raft request' (duration: 109.140542ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:54:33.111254Z","caller":"traceutil/trace.go:171","msg":"trace[370595773] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"142.768155ms","start":"2026-07-20T18:54:32.96845Z","end":"2026-07-20T18:54:33.111218Z","steps":["trace[370595773] 'process raft request' (duration: 142.564583ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:54:33.111821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.349543ms","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-07-20T18:54:33.111923Z","caller":"traceutil/trace.go:171","msg":"trace[234937066] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:967; }","duration":"117.502105ms","start":"2026-07-20T18:54:32.994404Z","end":"2026-07-20T18:54:33.111906Z","steps":["trace[234937066] 'agreement among raft nodes before linearized reading' (duration: 117.1178ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:54:33.111183Z","caller":"traceutil/trace.go:171","msg":"trace[1816135217] linearizableReadLoop","detail":"{readStateIndex:1001; appliedIndex:1000; }","duration":"116.700396ms","start":"2026-07-20T18:54:32.99446Z","end":"2026-07-20T18:54:33.111161Z","steps":["trace[1816135217] 'read index received' (duration: 116.497293ms)","trace[1816135217] 'applied index is now lower than readState.Index' (duration: 202.123µs)"],"step_count":2} {"level":"info","ts":"2026-07-20T18:54:47.505136Z","caller":"traceutil/trace.go:171","msg":"trace[707243570] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"167.747243ms","start":"2026-07-20T18:54:47.337351Z","end":"2026-07-20T18:54:47.505098Z","steps":["trace[707243570] 'process raft request' (duration: 166.865653ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:55:03.622372Z","caller":"traceutil/trace.go:171","msg":"trace[1106355715] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"139.017108ms","start":"2026-07-20T18:55:03.483336Z","end":"2026-07-20T18:55:03.622353Z","steps":["trace[1106355715] 'process raft request' (duration: 138.793171ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:56:03.859978Z","caller":"traceutil/trace.go:171","msg":"trace[1545571129] linearizableReadLoop","detail":"{readStateIndex:1361; appliedIndex:1360; }","duration":"140.246077ms","start":"2026-07-20T18:56:03.719693Z","end":"2026-07-20T18:56:03.859939Z","steps":["trace[1545571129] 'read index received' (duration: 140.068542ms)","trace[1545571129] 'applied index is now lower than readState.Index' (duration: 176.165µs)"],"step_count":2} {"level":"info","ts":"2026-07-20T18:56:03.860015Z","caller":"traceutil/trace.go:171","msg":"trace[1324270063] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1306; }","duration":"175.003978ms","start":"2026-07-20T18:56:03.68497Z","end":"2026-07-20T18:56:03.859974Z","steps":["trace[1324270063] 'process raft request' (duration: 174.796562ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:56:03.860233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.503714ms","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-07-20T18:56:03.86033Z","caller":"traceutil/trace.go:171","msg":"trace[131932063] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1306; }","duration":"140.659739ms","start":"2026-07-20T18:56:03.719647Z","end":"2026-07-20T18:56:03.860307Z","steps":["trace[131932063] 'agreement among raft nodes before linearized reading' (duration: 140.393942ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:56:03.860379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.022802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2581"} {"level":"info","ts":"2026-07-20T18:56:03.860487Z","caller":"traceutil/trace.go:171","msg":"trace[1372788001] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1306; }","duration":"114.186176ms","start":"2026-07-20T18:56:03.746273Z","end":"2026-07-20T18:56:03.860459Z","steps":["trace[1372788001] 'agreement among raft nodes before linearized reading' (duration: 113.880268ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:56:05.030614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.778615ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-07-20T18:56:05.030752Z","caller":"traceutil/trace.go:171","msg":"trace[214619150] linearizableReadLoop","detail":"{readStateIndex:1368; appliedIndex:1367; }","duration":"545.056257ms","start":"2026-07-20T18:56:04.485669Z","end":"2026-07-20T18:56:05.030725Z","steps":["trace[214619150] 'read index received' (duration: 91.135498ms)","trace[214619150] 'applied index is now lower than readState.Index' (duration: 453.919089ms)"],"step_count":2} {"level":"warn","ts":"2026-07-20T18:56:05.031004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.331044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2769"} {"level":"info","ts":"2026-07-20T18:56:05.031041Z","caller":"traceutil/trace.go:171","msg":"trace[96564472] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1312; }","duration":"545.441967ms","start":"2026-07-20T18:56:04.485589Z","end":"2026-07-20T18:56:05.031031Z","steps":["trace[96564472] 'agreement among raft nodes before linearized reading' (duration: 545.250182ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:56:05.031081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:56:04.485561Z","time spent":"545.511159ms","remote":"127.0.0.1:58340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":2791,"request content":"key:\"/registry/pods/default/test-pvc-pod\" "} {"level":"warn","ts":"2026-07-20T18:56:05.031419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.40012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:500 ","response":"range_response_count:6 size:2185"} {"level":"info","ts":"2026-07-20T18:56:05.031622Z","caller":"traceutil/trace.go:171","msg":"trace[749548161] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:6; response_revision:1312; }","duration":"362.628197ms","start":"2026-07-20T18:56:04.668923Z","end":"2026-07-20T18:56:05.031551Z","steps":["trace[749548161] 'agreement among raft nodes before linearized reading' (duration: 361.960257ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:56:05.031971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-20T18:56:04.668869Z","time spent":"362.853652ms","remote":"127.0.0.1:58278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":6,"response size":2207,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:500 "} {"level":"info","ts":"2026-07-20T18:56:05.225881Z","caller":"traceutil/trace.go:171","msg":"trace[321604502] linearizableReadLoop","detail":"{readStateIndex:1370; appliedIndex:1369; }","duration":"133.869626ms","start":"2026-07-20T18:56:05.091971Z","end":"2026-07-20T18:56:05.22584Z","steps":["trace[321604502] 'read index received' (duration: 95.096255ms)","trace[321604502] 'applied index is now lower than readState.Index' (duration: 38.771951ms)"],"step_count":2} {"level":"info","ts":"2026-07-20T18:56:05.225948Z","caller":"traceutil/trace.go:171","msg":"trace[988273379] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"157.847654ms","start":"2026-07-20T18:56:05.068041Z","end":"2026-07-20T18:56:05.225889Z","steps":["trace[988273379] 'process raft request' (duration: 119.105223ms)","trace[988273379] 'compare' (duration: 38.476923ms)"],"step_count":2} {"level":"warn","ts":"2026-07-20T18:56:05.226093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.089913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/default/\" range_end:\"/registry/secrets/default0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-20T18:56:05.226153Z","caller":"traceutil/trace.go:171","msg":"trace[1619616584] range","detail":"{range_begin:/registry/secrets/default/; range_end:/registry/secrets/default0; response_count:0; response_revision:1314; }","duration":"134.242098ms","start":"2026-07-20T18:56:05.091895Z","end":"2026-07-20T18:56:05.226137Z","steps":["trace[1619616584] 'agreement among raft nodes before linearized reading' (duration: 134.100274ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:56:16.248808Z","caller":"traceutil/trace.go:171","msg":"trace[187094602] linearizableReadLoop","detail":"{readStateIndex:1410; appliedIndex:1409; }","duration":"198.535675ms","start":"2026-07-20T18:56:16.050246Z","end":"2026-07-20T18:56:16.248782Z","steps":["trace[187094602] 'read index received' (duration: 171.5961ms)","trace[187094602] 'applied index is now lower than readState.Index' (duration: 26.938635ms)"],"step_count":2} {"level":"info","ts":"2026-07-20T18:56:16.248981Z","caller":"traceutil/trace.go:171","msg":"trace[781664251] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"211.150798ms","start":"2026-07-20T18:56:16.037744Z","end":"2026-07-20T18:56:16.248894Z","steps":["trace[781664251] 'process raft request' (duration: 184.137131ms)","trace[781664251] 'compare' (duration: 26.792741ms)"],"step_count":2} {"level":"warn","ts":"2026-07-20T18:56:16.249173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.902135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:monitoring\" ","response":"range_response_count:1 size:634"} {"level":"info","ts":"2026-07-20T18:56:16.249485Z","caller":"traceutil/trace.go:171","msg":"trace[824745512] range","detail":"{range_begin:/registry/clusterroles/system:monitoring; range_end:; response_count:1; response_revision:1351; }","duration":"199.229885ms","start":"2026-07-20T18:56:16.050207Z","end":"2026-07-20T18:56:16.249437Z","steps":["trace[824745512] 'agreement among raft nodes before linearized reading' (duration: 198.695549ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:56:16.250093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.912939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:node\" ","response":"range_response_count:1 size:1486"} {"level":"warn","ts":"2026-07-20T18:56:16.250227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.0933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-20T18:56:16.250356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.140805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-20T18:56:16.250356Z","caller":"traceutil/trace.go:171","msg":"trace[1479038035] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1351; }","duration":"169.208133ms","start":"2026-07-20T18:56:16.081103Z","end":"2026-07-20T18:56:16.250311Z","steps":["trace[1479038035] 'agreement among raft nodes before linearized reading' (duration: 168.973776ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:56:16.250594Z","caller":"traceutil/trace.go:171","msg":"trace[1473651622] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1351; }","duration":"172.295989ms","start":"2026-07-20T18:56:16.078161Z","end":"2026-07-20T18:56:16.250457Z","steps":["trace[1473651622] 'agreement among raft nodes before linearized reading' (duration: 171.61513ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:56:16.250266Z","caller":"traceutil/trace.go:171","msg":"trace[158818640] range","detail":"{range_begin:/registry/clusterroles/system:node; range_end:; response_count:1; response_revision:1351; }","duration":"146.117805ms","start":"2026-07-20T18:56:16.104126Z","end":"2026-07-20T18:56:16.250244Z","steps":["trace[158818640] 'agreement among raft nodes before linearized reading' (duration: 145.897939ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:56:21.295811Z","caller":"traceutil/trace.go:171","msg":"trace[1890358034] linearizableReadLoop","detail":"{readStateIndex:1429; appliedIndex:1428; }","duration":"124.248848ms","start":"2026-07-20T18:56:21.171533Z","end":"2026-07-20T18:56:21.295782Z","steps":["trace[1890358034] 'read index received' (duration: 124.039072ms)","trace[1890358034] 'applied index is now lower than readState.Index' (duration: 208.556µs)"],"step_count":2} {"level":"info","ts":"2026-07-20T18:56:21.295895Z","caller":"traceutil/trace.go:171","msg":"trace[1516797726] transaction","detail":"{read_only:false; response_revision:1369; number_of_response:1; }","duration":"138.839482ms","start":"2026-07-20T18:56:21.157021Z","end":"2026-07-20T18:56:21.295861Z","steps":["trace[1516797726] 'process raft request' (duration: 138.599425ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:56:21.296013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.468693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-zv2db\" ","response":"range_response_count:1 size:5487"} {"level":"info","ts":"2026-07-20T18:56:21.296094Z","caller":"traceutil/trace.go:171","msg":"trace[41447545] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-zv2db; range_end:; response_count:1; response_revision:1369; }","duration":"124.554766ms","start":"2026-07-20T18:56:21.17152Z","end":"2026-07-20T18:56:21.296075Z","steps":["trace[41447545] 'agreement among raft nodes before linearized reading' (duration: 124.35834ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:56:21.553038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.585104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/default/\" range_end:\"/registry/roles/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-20T18:56:21.553145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.385477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"} {"level":"info","ts":"2026-07-20T18:56:21.553193Z","caller":"traceutil/trace.go:171","msg":"trace[1860625241] range","detail":"{range_begin:/registry/roles/default/; range_end:/registry/roles/default0; response_count:0; response_revision:1369; }","duration":"121.722827ms","start":"2026-07-20T18:56:21.43138Z","end":"2026-07-20T18:56:21.553103Z","steps":["trace[1860625241] 'range keys from in-memory index tree' (duration: 121.539552ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:56:21.553244Z","caller":"traceutil/trace.go:171","msg":"trace[1159583773] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1369; }","duration":"170.557793ms","start":"2026-07-20T18:56:21.382667Z","end":"2026-07-20T18:56:21.553225Z","steps":["trace[1159583773] 'range keys from in-memory index tree' (duration: 170.172262ms)"],"step_count":1} {"level":"warn","ts":"2026-07-20T18:56:21.553306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.829401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/default/\" range_end:\"/registry/rolebindings/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-20T18:56:21.553397Z","caller":"traceutil/trace.go:171","msg":"trace[878818333] range","detail":"{range_begin:/registry/rolebindings/default/; range_end:/registry/rolebindings/default0; response_count:0; response_revision:1369; }","duration":"156.996526ms","start":"2026-07-20T18:56:21.39638Z","end":"2026-07-20T18:56:21.553376Z","steps":["trace[878818333] 'range keys from in-memory index tree' (duration: 156.729869ms)"],"step_count":1} {"level":"info","ts":"2026-07-20T18:56:29.163437Z","caller":"traceutil/trace.go:171","msg":"trace[1001985014] transaction","detail":"{read_only:false; response_revision:1395; number_of_response:1; }","duration":"116.964024ms","start":"2026-07-20T18:56:29.046407Z","end":"2026-07-20T18:56:29.163371Z","steps":["trace[1001985014] 'process raft request' (duration: 84.375914ms)","trace[1001985014] 'compare' (duration: 32.426605ms)"],"step_count":2}