{"level":"warn","ts":"2026-04-27T19:41:03.090159Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T19:41:03.09025Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.130:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.130:2380","--initial-cluster=instance=https://199.19.213.130:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.130:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.130:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-27T19:41:03.090398Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T19:41:03.090414Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.130:2380"]} {"level":"info","ts":"2026-04-27T19:41:03.090433Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-27T19:41:03.09113Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.130:2379"]} {"level":"info","ts":"2026-04-27T19:41:03.091212Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.130:2380"],"listen-peer-urls":["https://199.19.213.130:2380"],"advertise-client-urls":["https://199.19.213.130:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.130:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.130:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-27T19:41:03.095864Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.447941ms"} {"level":"info","ts":"2026-04-27T19:41:03.102344Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a727d7e7ce5fe36a","cluster-id":"db8a5e7d54164af4"} {"level":"info","ts":"2026-04-27T19:41:03.102433Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a switched to configuration voters=()"} {"level":"info","ts":"2026-04-27T19:41:03.10246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a became follower at term 0"} {"level":"info","ts":"2026-04-27T19:41:03.102477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a727d7e7ce5fe36a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-27T19:41:03.102489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a became follower at term 1"} {"level":"info","ts":"2026-04-27T19:41:03.102534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a switched to configuration voters=(12044833119025488746)"} {"level":"warn","ts":"2026-04-27T19:41:03.10954Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-27T19:41:03.111004Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-27T19:41:03.112154Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-27T19:41:03.114547Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a727d7e7ce5fe36a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-27T19:41:03.114801Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a727d7e7ce5fe36a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-27T19:41:03.114874Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T19:41:03.115096Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T19:41:03.115152Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T19:41:03.115666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a switched to configuration voters=(12044833119025488746)"} {"level":"info","ts":"2026-04-27T19:41:03.118077Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"db8a5e7d54164af4","local-member-id":"a727d7e7ce5fe36a","added-peer-id":"a727d7e7ce5fe36a","added-peer-peer-urls":["https://199.19.213.130:2380"]} {"level":"info","ts":"2026-04-27T19:41:03.120937Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-27T19:41:03.121158Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.130:2380"} {"level":"info","ts":"2026-04-27T19:41:03.121192Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.130:2380"} {"level":"info","ts":"2026-04-27T19:41:03.12197Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a727d7e7ce5fe36a","initial-advertise-peer-urls":["https://199.19.213.130:2380"],"listen-peer-urls":["https://199.19.213.130:2380"],"advertise-client-urls":["https://199.19.213.130:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.130:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-27T19:41:03.122029Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-27T19:41:04.103406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a is starting a new election at term 1"} {"level":"info","ts":"2026-04-27T19:41:04.103479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a became pre-candidate at term 1"} {"level":"info","ts":"2026-04-27T19:41:04.103538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a received MsgPreVoteResp from a727d7e7ce5fe36a at term 1"} {"level":"info","ts":"2026-04-27T19:41:04.103561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a became candidate at term 2"} {"level":"info","ts":"2026-04-27T19:41:04.103574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a received MsgVoteResp from a727d7e7ce5fe36a at term 2"} {"level":"info","ts":"2026-04-27T19:41:04.103605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a became leader at term 2"} {"level":"info","ts":"2026-04-27T19:41:04.103622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a727d7e7ce5fe36a elected leader a727d7e7ce5fe36a at term 2"} {"level":"info","ts":"2026-04-27T19:41:04.104755Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T19:41:04.105628Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T19:41:04.105625Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a727d7e7ce5fe36a","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.130:2379]}","request-path":"/0/members/a727d7e7ce5fe36a/attributes","cluster-id":"db8a5e7d54164af4","publish-timeout":"7s"} {"level":"info","ts":"2026-04-27T19:41:04.105749Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T19:41:04.106266Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-27T19:41:04.106313Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-27T19:41:04.1067Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"db8a5e7d54164af4","local-member-id":"a727d7e7ce5fe36a","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T19:41:04.10684Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T19:41:04.106881Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T19:41:04.109906Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-27T19:41:04.110347Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.130:2379"} {"level":"info","ts":"2026-04-27T19:41:05.618495Z","caller":"traceutil/trace.go:171","msg":"trace[321415790] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"119.509086ms","start":"2026-04-27T19:41:05.498953Z","end":"2026-04-27T19:41:05.618462Z","steps":["trace[321415790] 'process raft request' (duration: 119.225904ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:05.618449Z","caller":"traceutil/trace.go:171","msg":"trace[1647159929] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"115.446937ms","start":"2026-04-27T19:41:05.502966Z","end":"2026-04-27T19:41:05.618413Z","steps":["trace[1647159929] 'read index received' (duration: 115.118295ms)","trace[1647159929] 'applied index is now lower than readState.Index' (duration: 327.612µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:41:05.619085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.075851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T19:41:05.619259Z","caller":"traceutil/trace.go:171","msg":"trace[1407177888] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:2; }","duration":"116.270233ms","start":"2026-04-27T19:41:05.502958Z","end":"2026-04-27T19:41:05.619228Z","steps":["trace[1407177888] 'agreement among raft nodes before linearized reading' (duration: 115.660619ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:05.924086Z","caller":"traceutil/trace.go:171","msg":"trace[1498901979] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"421.046952ms","start":"2026-04-27T19:41:05.502991Z","end":"2026-04-27T19:41:05.924038Z","steps":["trace[1498901979] 'process raft request' (duration: 420.68215ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:05.924149Z","caller":"traceutil/trace.go:171","msg":"trace[1402551689] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"344.162339ms","start":"2026-04-27T19:41:05.579929Z","end":"2026-04-27T19:41:05.924092Z","steps":["trace[1402551689] 'process raft request' (duration: 343.964717ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:05.92447Z","caller":"traceutil/trace.go:171","msg":"trace[1616676159] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:5; }","duration":"305.313423ms","start":"2026-04-27T19:41:05.619124Z","end":"2026-04-27T19:41:05.924437Z","steps":["trace[1616676159] 'read index received' (duration: 304.601418ms)","trace[1616676159] 'applied index is now lower than readState.Index' (duration: 710.145µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:41:05.924633Z","caller":"traceutil/trace.go:171","msg":"trace[1520226933] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"344.612931ms","start":"2026-04-27T19:41:05.580004Z","end":"2026-04-27T19:41:05.924617Z","steps":["trace[1520226933] 'process raft request' (duration: 343.961187ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:05.92468Z","caller":"traceutil/trace.go:171","msg":"trace[1258163809] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"323.572837ms","start":"2026-04-27T19:41:05.601091Z","end":"2026-04-27T19:41:05.924664Z","steps":["trace[1258163809] 'process raft request' (duration: 323.239075ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:05.924773Z","caller":"traceutil/trace.go:171","msg":"trace[2065690857] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"344.697372ms","start":"2026-04-27T19:41:05.580059Z","end":"2026-04-27T19:41:05.924756Z","steps":["trace[2065690857] 'process raft request' (duration: 343.961717ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:05.924956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.976958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"warn","ts":"2026-04-27T19:41:05.925007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.082389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T19:41:05.925022Z","caller":"traceutil/trace.go:171","msg":"trace[641473723] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"422.076769ms","start":"2026-04-27T19:41:05.502929Z","end":"2026-04-27T19:41:05.925006Z","steps":["trace[641473723] 'agreement among raft nodes before linearized reading' (duration: 421.979718ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:05.925046Z","caller":"traceutil/trace.go:171","msg":"trace[420464614] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"347.146209ms","start":"2026-04-27T19:41:05.577886Z","end":"2026-04-27T19:41:05.925032Z","steps":["trace[420464614] 'agreement among raft nodes before linearized reading' (duration: 347.100529ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:05.92487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.849368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-27T19:41:05.9251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.577787Z","time spent":"347.29246ms","remote":"127.0.0.1:47436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-27T19:41:05.92509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.502912Z","time spent":"422.15356ms","remote":"127.0.0.1:47502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3195,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-27T19:41:05.925189Z","caller":"traceutil/trace.go:171","msg":"trace[1900817232] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"344.969934ms","start":"2026-04-27T19:41:05.580203Z","end":"2026-04-27T19:41:05.925173Z","steps":["trace[1900817232] 'process raft request' (duration: 343.865547ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:05.92521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.070938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"warn","ts":"2026-04-27T19:41:05.925264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.580195Z","time spent":"345.018744ms","remote":"127.0.0.1:47850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T19:41:05.925315Z","caller":"traceutil/trace.go:171","msg":"trace[893330613] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"303.208278ms","start":"2026-04-27T19:41:05.622076Z","end":"2026-04-27T19:41:05.925285Z","steps":["trace[893330613] 'agreement among raft nodes before linearized reading' (duration: 302.970667ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:05.925338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.502976Z","time spent":"421.241884ms","remote":"127.0.0.1:47394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T19:41:05.925376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.622067Z","time spent":"303.299689ms","remote":"127.0.0.1:47502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3195,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-27T19:41:05.925399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.761943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.130\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T19:41:05.925435Z","caller":"traceutil/trace.go:171","msg":"trace[1959246093] range","detail":"{range_begin:/registry/masterleases/199.19.213.130; range_end:; response_count:0; response_revision:11; }","duration":"347.852993ms","start":"2026-04-27T19:41:05.57757Z","end":"2026-04-27T19:41:05.925423Z","steps":["trace[1959246093] 'agreement among raft nodes before linearized reading' (duration: 347.795913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:05.925464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.577539Z","time spent":"347.919234ms","remote":"127.0.0.1:47372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.19.213.130\" "} {"level":"info","ts":"2026-04-27T19:41:05.925469Z","caller":"traceutil/trace.go:171","msg":"trace[1421721446] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"344.950114ms","start":"2026-04-27T19:41:05.580504Z","end":"2026-04-27T19:41:05.925455Z","steps":["trace[1421721446] 'process raft request' (duration: 343.635485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:05.925521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.580493Z","time spent":"345.003124ms","remote":"127.0.0.1:47850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T19:41:05.92554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.576731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T19:41:05.92556Z","caller":"traceutil/trace.go:171","msg":"trace[1578053706] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"278.621921ms","start":"2026-04-27T19:41:05.646931Z","end":"2026-04-27T19:41:05.925553Z","steps":["trace[1578053706] 'agreement among raft nodes before linearized reading' (duration: 278.578231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:05.924965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.101914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-27T19:41:05.925605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.579915Z","time spent":"344.3226ms","remote":"127.0.0.1:47850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T19:41:05.925635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.57606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T19:41:05.925652Z","caller":"traceutil/trace.go:171","msg":"trace[1411515312] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"345.773039ms","start":"2026-04-27T19:41:05.579841Z","end":"2026-04-27T19:41:05.925614Z","steps":["trace[1411515312] 'agreement among raft nodes before linearized reading' (duration: 345.096454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:05.92572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.579833Z","time spent":"345.8676ms","remote":"127.0.0.1:47412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-04-27T19:41:05.925844Z","caller":"traceutil/trace.go:171","msg":"trace[942100503] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"343.502214ms","start":"2026-04-27T19:41:05.582327Z","end":"2026-04-27T19:41:05.925829Z","steps":["trace[942100503] 'process raft request' (duration: 341.871472ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:05.925867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.06545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-27T19:41:05.925855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.579995Z","time spent":"344.706772ms","remote":"127.0.0.1:47850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T19:41:05.925946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.582314Z","time spent":"343.558694ms","remote":"127.0.0.1:47764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T19:41:05.925138Z","caller":"traceutil/trace.go:171","msg":"trace[339171048] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11; }","duration":"422.153429ms","start":"2026-04-27T19:41:05.502971Z","end":"2026-04-27T19:41:05.925124Z","steps":["trace[339171048] 'agreement among raft nodes before linearized reading' (duration: 421.746657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:05.926019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.50296Z","time spent":"423.042056ms","remote":"127.0.0.1:47304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-27T19:41:05.924883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.809495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T19:41:05.92608Z","caller":"traceutil/trace.go:171","msg":"trace[402974914] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:11; }","duration":"421.037423ms","start":"2026-04-27T19:41:05.505031Z","end":"2026-04-27T19:41:05.926069Z","steps":["trace[402974914] 'agreement among raft nodes before linearized reading' (duration: 419.647694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:05.926115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.50501Z","time spent":"421.094734ms","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-27T19:41:05.925666Z","caller":"traceutil/trace.go:171","msg":"trace[640747396] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:11; }","duration":"420.612291ms","start":"2026-04-27T19:41:05.505045Z","end":"2026-04-27T19:41:05.925658Z","steps":["trace[640747396] 'agreement among raft nodes before linearized reading' (duration: 420.5679ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:05.926186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.601071Z","time spent":"323.665388ms","remote":"127.0.0.1:47586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T19:41:05.926227Z","caller":"traceutil/trace.go:171","msg":"trace[464075706] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"335.018246ms","start":"2026-04-27T19:41:05.591195Z","end":"2026-04-27T19:41:05.926213Z","steps":["trace[464075706] 'process raft request' (duration: 333.060623ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:05.925955Z","caller":"traceutil/trace.go:171","msg":"trace[1548576935] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"296.11867ms","start":"2026-04-27T19:41:05.629768Z","end":"2026-04-27T19:41:05.925887Z","steps":["trace[1548576935] 'agreement among raft nodes before linearized reading' (duration: 296.05128ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:05.925876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.580033Z","time spent":"344.945443ms","remote":"127.0.0.1:47850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T19:41:05.926749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.591157Z","time spent":"335.5512ms","remote":"127.0.0.1:47502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T19:41:05.926239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.505042Z","time spent":"421.171904ms","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-27T19:41:06.433967Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387083712793214596,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T19:41:06.934923Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387083712793214596,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T19:41:07.436079Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387083712793214596,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T19:41:07.931241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.997860775s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-27T19:41:07.93136Z","caller":"traceutil/trace.go:171","msg":"trace[368094955] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.998018966s","start":"2026-04-27T19:41:05.933317Z","end":"2026-04-27T19:41:07.931336Z","steps":["trace[368094955] 'agreement among raft nodes before linearized reading' (duration: 1.997870355s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:07.931429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.933308Z","time spent":"1.998107027s","remote":"127.0.0.1:47316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/27 19:41:07 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-27T19:41:07.936432Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387083712793214596,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T19:41:08.437301Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387083712793214596,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T19:41:08.754403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000357801s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-27T19:41:08.754578Z","caller":"traceutil/trace.go:171","msg":"trace[1165828079] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000608963s","start":"2026-04-27T19:41:06.753942Z","end":"2026-04-27T19:41:08.754551Z","steps":["trace[1165828079] 'agreement among raft nodes before linearized reading' (duration: 2.000403101s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:08.754648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:06.753902Z","time spent":"2.000727213s","remote":"127.0.0.1:47304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-27T19:41:08.933524Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.00026343s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-27T19:41:09.615014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"680.89085ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-27T19:41:09.615148Z","caller":"traceutil/trace.go:171","msg":"trace[1382384417] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"3.681982876s","start":"2026-04-27T19:41:05.933139Z","end":"2026-04-27T19:41:09.615122Z","steps":["trace[1382384417] 'process raft request' (duration: 3.000727283s)","trace[1382384417] 'compare' (duration: 680.345267ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:41:09.615217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.933122Z","time spent":"3.682065677s","remote":"127.0.0.1:47764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T19:41:10.033639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999993207s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-27T19:41:10.033727Z","caller":"traceutil/trace.go:171","msg":"trace[2053642920] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000142249s","start":"2026-04-27T19:41:08.033566Z","end":"2026-04-27T19:41:10.033708Z","steps":["trace[2053642920] 'agreement among raft nodes before linearized reading' (duration: 2.000035038s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:10.033797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:08.033543Z","time spent":"2.000244389s","remote":"127.0.0.1:47304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/27 19:41:10 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-27T19:41:10.214967Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.281162542s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-27T19:41:10.786101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.743993ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-27T19:41:10.78646Z","caller":"traceutil/trace.go:171","msg":"trace[1989350382] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"4.853078821s","start":"2026-04-27T19:41:05.933312Z","end":"2026-04-27T19:41:10.786391Z","steps":["trace[1989350382] 'process raft request' (duration: 4.281960605s)","trace[1989350382] 'compare' (duration: 569.294443ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:41:10.786636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.933284Z","time spent":"4.853269143s","remote":"127.0.0.1:47850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T19:41:10.786646Z","caller":"traceutil/trace.go:171","msg":"trace[1250300558] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"4.853135571s","start":"2026-04-27T19:41:05.933382Z","end":"2026-04-27T19:41:10.786517Z","steps":["trace[1250300558] 'process raft request' (duration: 4.852828029s)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:10.787172Z","caller":"traceutil/trace.go:171","msg":"trace[78573888] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"4.853626534s","start":"2026-04-27T19:41:05.933532Z","end":"2026-04-27T19:41:10.787158Z","steps":["trace[78573888] 'process raft request' (duration: 4.85295135s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:10.78724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.933524Z","time spent":"4.853689175s","remote":"127.0.0.1:47436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T19:41:10.787238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.933339Z","time spent":"4.853723235s","remote":"127.0.0.1:47706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T19:41:10.787362Z","caller":"traceutil/trace.go:171","msg":"trace[423806] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"1.168580728s","start":"2026-04-27T19:41:09.61873Z","end":"2026-04-27T19:41:10.78731Z","steps":["trace[423806] 'process raft request' (duration: 1.168499018s)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:10.787491Z","caller":"traceutil/trace.go:171","msg":"trace[1652478016] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"4.854062647s","start":"2026-04-27T19:41:05.933413Z","end":"2026-04-27T19:41:10.787476Z","steps":["trace[1652478016] 'process raft request' (duration: 4.853021311s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:10.787494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:09.618704Z","time spent":"1.168743729s","remote":"127.0.0.1:47764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T19:41:10.78756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.9334Z","time spent":"4.854131208s","remote":"127.0.0.1:47850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T19:41:10.787596Z","caller":"traceutil/trace.go:171","msg":"trace[1092709332] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"4.853915026s","start":"2026-04-27T19:41:05.933662Z","end":"2026-04-27T19:41:10.787577Z","steps":["trace[1092709332] 'process raft request' (duration: 4.85288951s)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:10.787716Z","caller":"traceutil/trace.go:171","msg":"trace[1173558230] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"4.853851526s","start":"2026-04-27T19:41:05.933854Z","end":"2026-04-27T19:41:10.787706Z","steps":["trace[1173558230] 'process raft request' (duration: 4.85292647s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:10.787764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.933651Z","time spent":"4.854061977s","remote":"127.0.0.1:47850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T19:41:10.787864Z","caller":"traceutil/trace.go:171","msg":"trace[446139997] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"4.85019411s","start":"2026-04-27T19:41:05.937656Z","end":"2026-04-27T19:41:10.78785Z","steps":["trace[446139997] 'process raft request' (duration: 4.849467535s)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:10.787638Z","caller":"traceutil/trace.go:171","msg":"trace[544632790] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"4.853943866s","start":"2026-04-27T19:41:05.933658Z","end":"2026-04-27T19:41:10.787602Z","steps":["trace[544632790] 'process raft request' (duration: 4.85298233s)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:10.787988Z","caller":"traceutil/trace.go:171","msg":"trace[959522124] transaction","detail":"{read_only:false; number_of_response:0; response_revision:16; }","duration":"4.85442954s","start":"2026-04-27T19:41:05.933549Z","end":"2026-04-27T19:41:10.787979Z","steps":["trace[959522124] 'process raft request' (duration: 4.85296563s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:10.787996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.933629Z","time spent":"4.854337069s","remote":"127.0.0.1:47850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T19:41:10.788014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.937646Z","time spent":"4.850286841s","remote":"127.0.0.1:47502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3479,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T19:41:10.788052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.933538Z","time spent":"4.85448743s","remote":"127.0.0.1:47436","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T19:41:10.788157Z","caller":"traceutil/trace.go:171","msg":"trace[348001963] linearizableReadLoop","detail":"{readStateIndex:24; appliedIndex:14; }","duration":"4.854744862s","start":"2026-04-27T19:41:05.9334Z","end":"2026-04-27T19:41:10.788145Z","steps":["trace[348001963] 'read index received' (duration: 3.000465731s)","trace[348001963] 'applied index is now lower than readState.Index' (duration: 1.854276301s)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:41:10.788309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.803539962s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-node-lease\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T19:41:10.788354Z","caller":"traceutil/trace.go:171","msg":"trace[1494676879] range","detail":"{range_begin:/registry/namespaces/kube-node-lease; range_end:; response_count:0; response_revision:21; }","duration":"4.803645422s","start":"2026-04-27T19:41:05.984698Z","end":"2026-04-27T19:41:10.788343Z","steps":["trace[1494676879] 'agreement among raft nodes before linearized reading' (duration: 4.803553661s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:10.787843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.933847Z","time spent":"4.853920146s","remote":"127.0.0.1:47850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T19:41:10.788385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.984672Z","time spent":"4.803705462s","remote":"127.0.0.1:47436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-node-lease\" "} {"level":"warn","ts":"2026-04-27T19:41:10.788612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.695344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-27T19:41:10.788652Z","caller":"traceutil/trace.go:171","msg":"trace[1033474468] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"468.736574ms","start":"2026-04-27T19:41:10.319906Z","end":"2026-04-27T19:41:10.788643Z","steps":["trace[1033474468] 'agreement among raft nodes before linearized reading' (duration: 468.667653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:10.788681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:10.319827Z","time spent":"468.847344ms","remote":"127.0.0.1:47436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-27T19:41:10.788692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.446029784s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-27T19:41:10.788738Z","caller":"traceutil/trace.go:171","msg":"trace[652530416] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"4.446143235s","start":"2026-04-27T19:41:06.342582Z","end":"2026-04-27T19:41:10.788725Z","steps":["trace[652530416] 'agreement among raft nodes before linearized reading' (duration: 4.446051175s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:10.788765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.53493873s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-27T19:41:10.788782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:06.342555Z","time spent":"4.446218897s","remote":"127.0.0.1:47436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-27T19:41:10.78881Z","caller":"traceutil/trace.go:171","msg":"trace[270997025] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21; }","duration":"1.535029681s","start":"2026-04-27T19:41:09.253767Z","end":"2026-04-27T19:41:10.788797Z","steps":["trace[270997025] 'agreement among raft nodes before linearized reading' (duration: 1.534939919s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:10.788812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.288868928s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-27T19:41:10.788849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.800755763s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-04-27T19:41:10.788857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:09.253745Z","time spent":"1.535106192s","remote":"127.0.0.1:47304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-27T19:41:10.788922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.800863395s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-04-27T19:41:10.788936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.289241581s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-27T19:41:10.788948Z","caller":"traceutil/trace.go:171","msg":"trace[1217836418] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"4.800915765s","start":"2026-04-27T19:41:05.988026Z","end":"2026-04-27T19:41:10.788941Z","steps":["trace[1217836418] 'agreement among raft nodes before linearized reading' (duration: 4.800876614s)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:10.788976Z","caller":"traceutil/trace.go:171","msg":"trace[522569820] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:21; }","duration":"4.289317762s","start":"2026-04-27T19:41:06.499648Z","end":"2026-04-27T19:41:10.788966Z","steps":["trace[522569820] 'agreement among raft nodes before linearized reading' (duration: 4.289263021s)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:10.788929Z","caller":"traceutil/trace.go:171","msg":"trace[643954330] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:21; }","duration":"4.28903344s","start":"2026-04-27T19:41:06.499819Z","end":"2026-04-27T19:41:10.788852Z","steps":["trace[643954330] 'agreement among raft nodes before linearized reading' (duration: 4.288892528s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:10.789015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:06.499626Z","time spent":"4.289383292s","remote":"127.0.0.1:47682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-04-27T19:41:10.789023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.801423057s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-04-27T19:41:10.789043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.953241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-27T19:41:10.789074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:06.499786Z","time spent":"4.289236441s","remote":"127.0.0.1:47664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"info","ts":"2026-04-27T19:41:10.789087Z","caller":"traceutil/trace.go:171","msg":"trace[1531933936] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21; }","duration":"755.035102ms","start":"2026-04-27T19:41:10.034042Z","end":"2026-04-27T19:41:10.789077Z","steps":["trace[1531933936] 'agreement among raft nodes before linearized reading' (duration: 754.975271ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:10.788981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.988011Z","time spent":"4.800964815s","remote":"127.0.0.1:47436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-27T19:41:10.789146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:10.034028Z","time spent":"755.105102ms","remote":"127.0.0.1:47316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-27T19:41:10.788885Z","caller":"traceutil/trace.go:171","msg":"trace[605519826] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"4.800799863s","start":"2026-04-27T19:41:05.98807Z","end":"2026-04-27T19:41:10.788869Z","steps":["trace[605519826] 'agreement among raft nodes before linearized reading' (duration: 4.800759433s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:10.789305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.988031Z","time spent":"4.801264597s","remote":"127.0.0.1:47436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-27T19:41:10.789052Z","caller":"traceutil/trace.go:171","msg":"trace[803264028] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"4.801509648s","start":"2026-04-27T19:41:05.987534Z","end":"2026-04-27T19:41:10.789043Z","steps":["trace[803264028] 'agreement among raft nodes before linearized reading' (duration: 4.801465718s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:10.788811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.645745581s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-27T19:41:10.789377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:05.987488Z","time spent":"4.80187735s","remote":"127.0.0.1:47436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-27T19:41:10.789485Z","caller":"traceutil/trace.go:171","msg":"trace[490587263] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:21; }","duration":"4.646376805s","start":"2026-04-27T19:41:06.142996Z","end":"2026-04-27T19:41:10.789373Z","steps":["trace[490587263] 'agreement among raft nodes before linearized reading' (duration: 4.645788662s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:10.789609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:06.142957Z","time spent":"4.646607827s","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-04-27T19:41:11.485223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.442669ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-27T19:41:11.485353Z","caller":"traceutil/trace.go:171","msg":"trace[517415435] transaction","detail":"{read_only:false; response_revision:125; number_of_response:1; }","duration":"191.104288ms","start":"2026-04-27T19:41:11.294226Z","end":"2026-04-27T19:41:11.48533Z","steps":["trace[517415435] 'process raft request' (duration: 70.466908ms)","trace[517415435] 'compare' (duration: 120.151957ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:41:12.502776Z","caller":"traceutil/trace.go:171","msg":"trace[313491755] linearizableReadLoop","detail":"{readStateIndex:223; appliedIndex:222; }","duration":"135.016352ms","start":"2026-04-27T19:41:12.367729Z","end":"2026-04-27T19:41:12.502746Z","steps":["trace[313491755] 'read index received' (duration: 122.791412ms)","trace[313491755] 'applied index is now lower than readState.Index' (duration: 12.22338ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:41:12.502863Z","caller":"traceutil/trace.go:171","msg":"trace[569020181] transaction","detail":"{read_only:false; response_revision:218; number_of_response:1; }","duration":"163.38412ms","start":"2026-04-27T19:41:12.339434Z","end":"2026-04-27T19:41:12.502818Z","steps":["trace[569020181] 'process raft request' (duration: 151.195039ms)","trace[569020181] 'compare' (duration: 11.988169ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:41:12.503084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.272104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:service-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:41:12.503324Z","caller":"traceutil/trace.go:171","msg":"trace[744619929] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:service-controller; range_end:; response_count:0; response_revision:218; }","duration":"135.616787ms","start":"2026-04-27T19:41:12.367676Z","end":"2026-04-27T19:41:12.503293Z","steps":["trace[744619929] 'agreement among raft nodes before linearized reading' (duration: 135.209883ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:12.503205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.839256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:41:12.503602Z","caller":"traceutil/trace.go:171","msg":"trace[1648035931] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:218; }","duration":"104.370401ms","start":"2026-04-27T19:41:12.399167Z","end":"2026-04-27T19:41:12.503538Z","steps":["trace[1648035931] 'agreement among raft nodes before linearized reading' (duration: 103.838627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:26.133207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.556574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4056"} {"level":"info","ts":"2026-04-27T19:41:26.133353Z","caller":"traceutil/trace.go:171","msg":"trace[362214789] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:423; }","duration":"172.692827ms","start":"2026-04-27T19:41:25.960579Z","end":"2026-04-27T19:41:26.133272Z","steps":["trace[362214789] 'range keys from in-memory index tree' (duration: 172.452142ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:26.42972Z","caller":"traceutil/trace.go:171","msg":"trace[876546257] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"280.827796ms","start":"2026-04-27T19:41:26.148861Z","end":"2026-04-27T19:41:26.429688Z","steps":["trace[876546257] 'process raft request' (duration: 280.669373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:26.679656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.685508ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-27T19:41:26.679781Z","caller":"traceutil/trace.go:171","msg":"trace[1260322615] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"239.994631ms","start":"2026-04-27T19:41:26.439762Z","end":"2026-04-27T19:41:26.679756Z","steps":["trace[1260322615] 'process raft request' (duration: 120.864904ms)","trace[1260322615] 'compare' (duration: 118.485424ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:41:27.059069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.282433ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-27T19:41:27.059311Z","caller":"traceutil/trace.go:171","msg":"trace[592812280] linearizableReadLoop","detail":"{readStateIndex:445; appliedIndex:442; }","duration":"355.130335ms","start":"2026-04-27T19:41:26.704157Z","end":"2026-04-27T19:41:27.059287Z","steps":["trace[592812280] 'read index received' (duration: 68.177632ms)","trace[592812280] 'applied index is now lower than readState.Index' (duration: 286.951333ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:41:27.059459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.297458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-27T19:41:27.059427Z","caller":"traceutil/trace.go:171","msg":"trace[628033439] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"370.471973ms","start":"2026-04-27T19:41:26.688877Z","end":"2026-04-27T19:41:27.059349Z","steps":["trace[628033439] 'process raft request' (duration: 370.31616ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:27.059521Z","caller":"traceutil/trace.go:171","msg":"trace[1815216572] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:428; }","duration":"355.39874ms","start":"2026-04-27T19:41:26.704109Z","end":"2026-04-27T19:41:27.059508Z","steps":["trace[1815216572] 'agreement among raft nodes before linearized reading' (duration: 355.283828ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:27.059472Z","caller":"traceutil/trace.go:171","msg":"trace[2038262728] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"373.20065ms","start":"2026-04-27T19:41:26.686192Z","end":"2026-04-27T19:41:27.059392Z","steps":["trace[2038262728] 'process raft request' (duration: 206.510838ms)","trace[2038262728] 'compare' (duration: 166.14402ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:41:27.05958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:26.704095Z","time spent":"355.470101ms","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-27T19:41:27.059916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:26.686155Z","time spent":"373.474176ms","remote":"127.0.0.1:47410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T19:41:27.060463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:26.688867Z","time spent":"370.708128ms","remote":"127.0.0.1:47766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T19:41:27.064288Z","caller":"traceutil/trace.go:171","msg":"trace[261673071] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"283.720634ms","start":"2026-04-27T19:41:26.780546Z","end":"2026-04-27T19:41:27.064267Z","steps":["trace[261673071] 'process raft request' (duration: 283.402988ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:27.064453Z","caller":"traceutil/trace.go:171","msg":"trace[1514414966] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"283.627133ms","start":"2026-04-27T19:41:26.780813Z","end":"2026-04-27T19:41:27.06444Z","steps":["trace[1514414966] 'process raft request' (duration: 283.402988ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:27.064696Z","caller":"traceutil/trace.go:171","msg":"trace[432949561] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"284.075762ms","start":"2026-04-27T19:41:26.780579Z","end":"2026-04-27T19:41:27.064655Z","steps":["trace[432949561] 'process raft request' (duration: 283.53803ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:27.064858Z","caller":"traceutil/trace.go:171","msg":"trace[790558587] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"283.979881ms","start":"2026-04-27T19:41:26.780858Z","end":"2026-04-27T19:41:27.064837Z","steps":["trace[790558587] 'process raft request' (duration: 283.416318ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:27.265053Z","caller":"traceutil/trace.go:171","msg":"trace[581953326] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"117.109062ms","start":"2026-04-27T19:41:27.147913Z","end":"2026-04-27T19:41:27.265022Z","steps":["trace[581953326] 'process raft request' (duration: 84.630085ms)","trace[581953326] 'compare' (duration: 32.333244ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:41:40.159366Z","caller":"traceutil/trace.go:171","msg":"trace[1650219738] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"235.374659ms","start":"2026-04-27T19:41:39.923949Z","end":"2026-04-27T19:41:40.159324Z","steps":["trace[1650219738] 'process raft request' (duration: 235.107225ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:41.30864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.236553ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T19:41:41.308713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.018926026s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:41:41.30879Z","caller":"traceutil/trace.go:171","msg":"trace[857582293] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:517; }","duration":"1.019077538s","start":"2026-04-27T19:41:40.289692Z","end":"2026-04-27T19:41:41.308769Z","steps":["trace[857582293] 'range keys from in-memory index tree' (duration: 1.01871322s)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:41.308799Z","caller":"traceutil/trace.go:171","msg":"trace[1386786049] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:517; }","duration":"250.397966ms","start":"2026-04-27T19:41:41.058368Z","end":"2026-04-27T19:41:41.308766Z","steps":["trace[1386786049] 'range keys from in-memory index tree' (duration: 250.217743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:41.308828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:40.289664Z","time spent":"1.019154739s","remote":"127.0.0.1:47418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"info","ts":"2026-04-27T19:41:41.32581Z","caller":"traceutil/trace.go:171","msg":"trace[1861695502] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:537; }","duration":"181.949538ms","start":"2026-04-27T19:41:41.143841Z","end":"2026-04-27T19:41:41.325791Z","steps":["trace[1861695502] 'read index received' (duration: 181.797225ms)","trace[1861695502] 'applied index is now lower than readState.Index' (duration: 151.083µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:41:41.325852Z","caller":"traceutil/trace.go:171","msg":"trace[503047728] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"221.276924ms","start":"2026-04-27T19:41:41.104541Z","end":"2026-04-27T19:41:41.325818Z","steps":["trace[503047728] 'process raft request' (duration: 221.104431ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:41.325932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.07508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-27T19:41:41.325984Z","caller":"traceutil/trace.go:171","msg":"trace[1987435907] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:518; }","duration":"182.249323ms","start":"2026-04-27T19:41:41.143719Z","end":"2026-04-27T19:41:41.325968Z","steps":["trace[1987435907] 'agreement among raft nodes before linearized reading' (duration: 182.114771ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:41.326001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.960974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-27T19:41:41.326029Z","caller":"traceutil/trace.go:171","msg":"trace[1288514432] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:518; }","duration":"179.007655ms","start":"2026-04-27T19:41:41.147009Z","end":"2026-04-27T19:41:41.326017Z","steps":["trace[1288514432] 'agreement among raft nodes before linearized reading' (duration: 178.950304ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:41.326103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.271126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-27T19:41:41.326124Z","caller":"traceutil/trace.go:171","msg":"trace[1982395344] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:518; }","duration":"122.384567ms","start":"2026-04-27T19:41:41.203734Z","end":"2026-04-27T19:41:41.326119Z","steps":["trace[1982395344] 'agreement among raft nodes before linearized reading' (duration: 122.347416ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:41.840677Z","caller":"traceutil/trace.go:171","msg":"trace[1703059469] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"325.862431ms","start":"2026-04-27T19:41:41.514785Z","end":"2026-04-27T19:41:41.840647Z","steps":["trace[1703059469] 'process raft request' (duration: 325.724609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:41.840852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:41.514754Z","time spent":"326.013034ms","remote":"127.0.0.1:47378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T19:41:41.920931Z","caller":"traceutil/trace.go:171","msg":"trace[782646303] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"398.539327ms","start":"2026-04-27T19:41:41.522353Z","end":"2026-04-27T19:41:41.920892Z","steps":["trace[782646303] 'process raft request' (duration: 398.247042ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:41.92107Z","caller":"traceutil/trace.go:171","msg":"trace[1971541404] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"381.220666ms","start":"2026-04-27T19:41:41.539807Z","end":"2026-04-27T19:41:41.921027Z","steps":["trace[1971541404] 'process raft request' (duration: 381.075663ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:41.921175Z","caller":"traceutil/trace.go:171","msg":"trace[235742747] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"398.445925ms","start":"2026-04-27T19:41:41.522706Z","end":"2026-04-27T19:41:41.921152Z","steps":["trace[235742747] 'process raft request' (duration: 398.061388ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:41.92112Z","caller":"traceutil/trace.go:171","msg":"trace[31319816] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"376.280958ms","start":"2026-04-27T19:41:41.544788Z","end":"2026-04-27T19:41:41.921069Z","steps":["trace[31319816] 'process raft request' (duration: 376.128355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:41.921287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:41.522323Z","time spent":"398.708291ms","remote":"127.0.0.1:47378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T19:41:41.921332Z","caller":"traceutil/trace.go:171","msg":"trace[1607424698] linearizableReadLoop","detail":"{readStateIndex:544; appliedIndex:542; }","duration":"394.217129ms","start":"2026-04-27T19:41:41.527069Z","end":"2026-04-27T19:41:41.921286Z","steps":["trace[1607424698] 'read index received' (duration: 313.591371ms)","trace[1607424698] 'applied index is now lower than readState.Index' (duration: 80.624758ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:41:41.921355Z","caller":"traceutil/trace.go:171","msg":"trace[2009210330] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"349.761131ms","start":"2026-04-27T19:41:41.571579Z","end":"2026-04-27T19:41:41.92134Z","steps":["trace[2009210330] 'process raft request' (duration: 349.458926ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:41.921364Z","caller":"traceutil/trace.go:171","msg":"trace[1775578521] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"323.934487ms","start":"2026-04-27T19:41:41.597416Z","end":"2026-04-27T19:41:41.92135Z","steps":["trace[1775578521] 'process raft request' (duration: 323.674233ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:41.921301Z","caller":"traceutil/trace.go:171","msg":"trace[1918612270] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"376.411579ms","start":"2026-04-27T19:41:41.544847Z","end":"2026-04-27T19:41:41.921259Z","steps":["trace[1918612270] 'process raft request' (duration: 376.102013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:41.921411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:41.5974Z","time spent":"323.988938ms","remote":"127.0.0.1:47378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T19:41:41.921441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.358232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T19:41:41.921456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:41.571563Z","time spent":"349.846113ms","remote":"127.0.0.1:47378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T19:41:41.92148Z","caller":"traceutil/trace.go:171","msg":"trace[1657386997] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:533; }","duration":"394.406223ms","start":"2026-04-27T19:41:41.527062Z","end":"2026-04-27T19:41:41.921468Z","steps":["trace[1657386997] 'agreement among raft nodes before linearized reading' (duration: 394.308671ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:41.921512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:41.527029Z","time spent":"394.473214ms","remote":"127.0.0.1:47316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-27T19:41:41.921284Z","caller":"traceutil/trace.go:171","msg":"trace[674968094] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"385.092796ms","start":"2026-04-27T19:41:41.536169Z","end":"2026-04-27T19:41:41.921262Z","steps":["trace[674968094] 'process raft request' (duration: 384.674319ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:41.921654Z","caller":"traceutil/trace.go:171","msg":"trace[304166972] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"364.650309ms","start":"2026-04-27T19:41:41.55699Z","end":"2026-04-27T19:41:41.92164Z","steps":["trace[304166972] 'process raft request' (duration: 363.999977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:41.921656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:41.53616Z","time spent":"385.456672ms","remote":"127.0.0.1:47378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T19:41:41.92152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:41.54478Z","time spent":"376.577103ms","remote":"127.0.0.1:47378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T19:41:41.921706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:41.55698Z","time spent":"364.703609ms","remote":"127.0.0.1:47378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T19:41:41.921726Z","caller":"traceutil/trace.go:171","msg":"trace[554603565] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"224.688755ms","start":"2026-04-27T19:41:41.697026Z","end":"2026-04-27T19:41:41.921715Z","steps":["trace[554603565] 'process raft request' (duration: 224.196336ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:41.921299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:41.522699Z","time spent":"398.513596ms","remote":"127.0.0.1:47378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T19:41:41.921773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:41.544832Z","time spent":"376.652505ms","remote":"127.0.0.1:47378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T19:41:41.921811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:41.539778Z","time spent":"381.41764ms","remote":"127.0.0.1:47378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T19:41:41.92107Z","caller":"traceutil/trace.go:171","msg":"trace[2112574853] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"393.66351ms","start":"2026-04-27T19:41:41.527335Z","end":"2026-04-27T19:41:41.920999Z","steps":["trace[2112574853] 'process raft request' (duration: 393.473267ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:41.922051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:41.527326Z","time spent":"394.687838ms","remote":"127.0.0.1:47378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T19:41:42.150324Z","caller":"traceutil/trace.go:171","msg":"trace[1429687371] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"123.715452ms","start":"2026-04-27T19:41:42.025773Z","end":"2026-04-27T19:41:42.149488Z","steps":["trace[1429687371] 'process raft request' (duration: 122.47269ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:42.155772Z","caller":"traceutil/trace.go:171","msg":"trace[1133650590] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"102.991223ms","start":"2026-04-27T19:41:42.052747Z","end":"2026-04-27T19:41:42.155738Z","steps":["trace[1133650590] 'process raft request' (duration: 102.593035ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:42.156307Z","caller":"traceutil/trace.go:171","msg":"trace[450839870] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"102.401943ms","start":"2026-04-27T19:41:42.053689Z","end":"2026-04-27T19:41:42.156091Z","steps":["trace[450839870] 'process raft request' (duration: 101.882934ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:42.893529Z","caller":"traceutil/trace.go:171","msg":"trace[1729458252] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"114.828134ms","start":"2026-04-27T19:41:42.778624Z","end":"2026-04-27T19:41:42.893452Z","steps":["trace[1729458252] 'process raft request' (duration: 100.528539ms)","trace[1729458252] 'compare' (duration: 14.01558ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:41:47.86451Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387083712793215752,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T19:41:48.024083Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.214798339s","expected-duration":"1s"} {"level":"info","ts":"2026-04-27T19:41:48.02893Z","caller":"traceutil/trace.go:171","msg":"trace[392355452] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"1.221706897s","start":"2026-04-27T19:41:46.807195Z","end":"2026-04-27T19:41:48.028902Z","steps":["trace[392355452] 'process raft request' (duration: 1.217414265s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:48.029241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:46.807162Z","time spent":"1.221979961s","remote":"127.0.0.1:47418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036197,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T19:41:48.028918Z","caller":"traceutil/trace.go:171","msg":"trace[1997776723] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"664.897067ms","start":"2026-04-27T19:41:47.363957Z","end":"2026-04-27T19:41:48.028855Z","steps":["trace[1997776723] 'read index received' (duration: 660.241648ms)","trace[1997776723] 'applied index is now lower than readState.Index' (duration: 4.654269ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:41:48.029089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.109211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-27T19:41:48.029604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.458953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-27T19:41:48.029651Z","caller":"traceutil/trace.go:171","msg":"trace[1179749653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:616; }","duration":"639.524805ms","start":"2026-04-27T19:41:47.390113Z","end":"2026-04-27T19:41:48.029638Z","steps":["trace[1179749653] 'agreement among raft nodes before linearized reading' (duration: 639.433534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:48.029686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:47.390102Z","time spent":"639.576726ms","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-27T19:41:48.029724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.417164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-27T19:41:48.029574Z","caller":"traceutil/trace.go:171","msg":"trace[853372113] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:616; }","duration":"665.63636ms","start":"2026-04-27T19:41:47.363906Z","end":"2026-04-27T19:41:48.029542Z","steps":["trace[853372113] 'agreement among raft nodes before linearized reading' (duration: 665.06281ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:48.029769Z","caller":"traceutil/trace.go:171","msg":"trace[888422915] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:616; }","duration":"635.478275ms","start":"2026-04-27T19:41:47.394275Z","end":"2026-04-27T19:41:48.029753Z","steps":["trace[888422915] 'agreement among raft nodes before linearized reading' (duration: 635.361543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:48.029772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:47.363882Z","time spent":"665.883513ms","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-27T19:41:48.029806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:47.394265Z","time spent":"635.531576ms","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-27T19:41:48.029828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.289745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:41:48.029946Z","caller":"traceutil/trace.go:171","msg":"trace[2135256383] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"594.448017ms","start":"2026-04-27T19:41:47.435442Z","end":"2026-04-27T19:41:48.02989Z","steps":["trace[2135256383] 'agreement among raft nodes before linearized reading' (duration: 594.187013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:48.030023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:47.435429Z","time spent":"594.537809ms","remote":"127.0.0.1:47304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-27T19:41:48.246443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.270703ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-27T19:41:48.246687Z","caller":"traceutil/trace.go:171","msg":"trace[793093360] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"101.110347ms","start":"2026-04-27T19:41:48.145557Z","end":"2026-04-27T19:41:48.246667Z","steps":["trace[793093360] 'read index received' (duration: 60.811µs)","trace[793093360] 'applied index is now lower than readState.Index' (duration: 101.047686ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:41:48.246723Z","caller":"traceutil/trace.go:171","msg":"trace[803374892] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"145.819981ms","start":"2026-04-27T19:41:48.100745Z","end":"2026-04-27T19:41:48.246565Z","steps":["trace[803374892] 'process raft request' (duration: 32.334055ms)","trace[803374892] 'compare' (duration: 113.008798ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:41:48.293613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.021549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:41:48.293699Z","caller":"traceutil/trace.go:171","msg":"trace[476283397] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:620; }","duration":"148.128931ms","start":"2026-04-27T19:41:48.145552Z","end":"2026-04-27T19:41:48.293681Z","steps":["trace[476283397] 'agreement among raft nodes before linearized reading' (duration: 101.210588ms)","trace[476283397] 'count revisions from in-memory index tree' (duration: 46.78461ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:41:48.293653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.278367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:41:48.293847Z","caller":"traceutil/trace.go:171","msg":"trace[941973523] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:620; }","duration":"147.535061ms","start":"2026-04-27T19:41:48.146289Z","end":"2026-04-27T19:41:48.293824Z","steps":["trace[941973523] 'agreement among raft nodes before linearized reading' (duration: 147.277977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:48.293919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.163892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:41:48.29395Z","caller":"traceutil/trace.go:171","msg":"trace[784955854] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:620; }","duration":"148.212362ms","start":"2026-04-27T19:41:48.14573Z","end":"2026-04-27T19:41:48.293942Z","steps":["trace[784955854] 'agreement among raft nodes before linearized reading' (duration: 148.159541ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:49.93566Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387083712793215824,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T19:41:50.053127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"861.576783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:41:50.053233Z","caller":"traceutil/trace.go:171","msg":"trace[1202989399] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:626; }","duration":"861.718675ms","start":"2026-04-27T19:41:49.191486Z","end":"2026-04-27T19:41:50.053205Z","steps":["trace[1202989399] 'range keys from in-memory index tree' (duration: 861.536161ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.053213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.961957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T19:41:50.053285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.000464446s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:41:50.053333Z","caller":"traceutil/trace.go:171","msg":"trace[702503172] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"795.120679ms","start":"2026-04-27T19:41:49.258184Z","end":"2026-04-27T19:41:50.053305Z","steps":["trace[702503172] 'range keys from in-memory index tree' (duration: 794.866616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.053356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"967.957122ms","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-04-27T19:41:50.053374Z","caller":"traceutil/trace.go:171","msg":"trace[1736391625] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:626; }","duration":"1.000616218s","start":"2026-04-27T19:41:49.052734Z","end":"2026-04-27T19:41:50.05335Z","steps":["trace[1736391625] 'range keys from in-memory index tree' (duration: 1.000402975s)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:50.053403Z","caller":"traceutil/trace.go:171","msg":"trace[1600304986] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:626; }","duration":"968.010223ms","start":"2026-04-27T19:41:49.085381Z","end":"2026-04-27T19:41:50.053392Z","steps":["trace[1600304986] 'range keys from in-memory index tree' (duration: 967.928212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.05342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.25818Z","time spent":"795.215761ms","remote":"127.0.0.1:41400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T19:41:50.053449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"813.346425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T19:41:50.053455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"835.865831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T19:41:50.053489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.051652443s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T19:41:50.05352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"813.398936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:41:50.05353Z","caller":"traceutil/trace.go:171","msg":"trace[310550491] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:626; }","duration":"835.955784ms","start":"2026-04-27T19:41:49.217557Z","end":"2026-04-27T19:41:50.053512Z","steps":["trace[310550491] 'range keys from in-memory index tree' (duration: 835.837111ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:50.053547Z","caller":"traceutil/trace.go:171","msg":"trace[121477994] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"813.429566ms","start":"2026-04-27T19:41:49.240111Z","end":"2026-04-27T19:41:50.05354Z","steps":["trace[121477994] 'range keys from in-memory index tree' (duration: 813.376876ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:50.053532Z","caller":"traceutil/trace.go:171","msg":"trace[764298138] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:626; }","duration":"1.051694974s","start":"2026-04-27T19:41:49.001823Z","end":"2026-04-27T19:41:50.053518Z","steps":["trace[764298138] 'count revisions from in-memory index tree' (duration: 1.051567522s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.053574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.240097Z","time spent":"813.470698ms","remote":"127.0.0.1:41394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T19:41:50.053581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.217551Z","time spent":"836.015445ms","remote":"127.0.0.1:41386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-04-27T19:41:50.053599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.001799Z","time spent":"1.051790026s","remote":"127.0.0.1:41308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-27T19:41:50.053637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"960.490438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-x2z49\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-27T19:41:50.053786Z","caller":"traceutil/trace.go:171","msg":"trace[1278617864] range","detail":"{range_begin:/registry/pods/kube-system/cilium-x2z49; range_end:; response_count:1; response_revision:626; }","duration":"960.64619ms","start":"2026-04-27T19:41:49.09313Z","end":"2026-04-27T19:41:50.053776Z","steps":["trace[1278617864] 'range keys from in-memory index tree' (duration: 960.338625ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.053844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.093123Z","time spent":"960.711561ms","remote":"127.0.0.1:47510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-x2z49\" "} {"level":"warn","ts":"2026-04-27T19:41:50.053927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"862.449406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:41:50.05398Z","caller":"traceutil/trace.go:171","msg":"trace[1201230107] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:626; }","duration":"862.523508ms","start":"2026-04-27T19:41:49.19144Z","end":"2026-04-27T19:41:50.053963Z","steps":["trace[1201230107] 'count revisions from in-memory index tree' (duration: 862.358865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.054008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.052137062s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T19:41:50.054026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.191432Z","time spent":"862.579839ms","remote":"127.0.0.1:41372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-27T19:41:50.054047Z","caller":"traceutil/trace.go:171","msg":"trace[1083351990] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:626; }","duration":"1.052177952s","start":"2026-04-27T19:41:49.001858Z","end":"2026-04-27T19:41:50.054036Z","steps":["trace[1083351990] 'range keys from in-memory index tree' (duration: 1.05202279s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.05407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.75217ms","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":"warn","ts":"2026-04-27T19:41:50.054083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.001832Z","time spent":"1.052241043s","remote":"127.0.0.1:41308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-27T19:41:50.0541Z","caller":"traceutil/trace.go:171","msg":"trace[1540551647] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:626; }","duration":"881.79535ms","start":"2026-04-27T19:41:49.172296Z","end":"2026-04-27T19:41:50.054091Z","steps":["trace[1540551647] 'count revisions from in-memory index tree' (duration: 881.72656ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.054101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.828661ms","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":"warn","ts":"2026-04-27T19:41:50.054129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.172292Z","time spent":"881.830651ms","remote":"127.0.0.1:41370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-27T19:41:50.054138Z","caller":"traceutil/trace.go:171","msg":"trace[714049524] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:626; }","duration":"881.875322ms","start":"2026-04-27T19:41:49.172248Z","end":"2026-04-27T19:41:50.054124Z","steps":["trace[714049524] 'range keys from in-memory index tree' (duration: 881.746209ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.054171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.17224Z","time spent":"881.921862ms","remote":"127.0.0.1:41370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T19:41:50.054218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.051830655s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T19:41:50.05424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"940.096085ms","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-04-27T19:41:50.054254Z","caller":"traceutil/trace.go:171","msg":"trace[1321688457] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:626; }","duration":"1.051862926s","start":"2026-04-27T19:41:49.002377Z","end":"2026-04-27T19:41:50.05424Z","steps":["trace[1321688457] 'range keys from in-memory index tree' (duration: 1.051683923s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.054249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.002401418s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T19:41:50.054303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.002371Z","time spent":"1.051921286s","remote":"127.0.0.1:41308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-27T19:41:50.05431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"880.901525ms","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-04-27T19:41:50.054317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"939.894052ms","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-04-27T19:41:50.05432Z","caller":"traceutil/trace.go:171","msg":"trace[115441714] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:626; }","duration":"1.002496751s","start":"2026-04-27T19:41:49.051808Z","end":"2026-04-27T19:41:50.054304Z","steps":["trace[115441714] 'range keys from in-memory index tree' (duration: 1.002348618s)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:50.054347Z","caller":"traceutil/trace.go:171","msg":"trace[47913039] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:626; }","duration":"939.937392ms","start":"2026-04-27T19:41:49.114403Z","end":"2026-04-27T19:41:50.05434Z","steps":["trace[47913039] 'count revisions from in-memory index tree' (duration: 939.866792ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:50.054345Z","caller":"traceutil/trace.go:171","msg":"trace[1895546780] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:626; }","duration":"880.950335ms","start":"2026-04-27T19:41:49.173386Z","end":"2026-04-27T19:41:50.054336Z","steps":["trace[1895546780] 'range keys from in-memory index tree' (duration: 880.871005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.054359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.370256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T19:41:50.054376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.17338Z","time spent":"880.987716ms","remote":"127.0.0.1:41370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-27T19:41:50.054398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"939.679818ms","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-04-27T19:41:50.054403Z","caller":"traceutil/trace.go:171","msg":"trace[844021863] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:626; }","duration":"837.422427ms","start":"2026-04-27T19:41:49.216967Z","end":"2026-04-27T19:41:50.05439Z","steps":["trace[844021863] 'range keys from in-memory index tree' (duration: 837.343386ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:50.054419Z","caller":"traceutil/trace.go:171","msg":"trace[666239875] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:626; }","duration":"939.712278ms","start":"2026-04-27T19:41:49.1147Z","end":"2026-04-27T19:41:50.054412Z","steps":["trace[666239875] 'range keys from in-memory index tree' (duration: 939.653618ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.054424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.027342816s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T19:41:50.054441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.114695Z","time spent":"939.739849ms","remote":"127.0.0.1:41354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-27T19:41:50.054451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.216962Z","time spent":"837.475068ms","remote":"127.0.0.1:41386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"info","ts":"2026-04-27T19:41:50.054462Z","caller":"traceutil/trace.go:171","msg":"trace[2000019165] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:626; }","duration":"1.027442058s","start":"2026-04-27T19:41:49.027008Z","end":"2026-04-27T19:41:50.05445Z","steps":["trace[2000019165] 'range keys from in-memory index tree' (duration: 1.027248704s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.054448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.002206196s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:41:50.054501Z","caller":"traceutil/trace.go:171","msg":"trace[2083165610] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:626; }","duration":"1.002275227s","start":"2026-04-27T19:41:49.052215Z","end":"2026-04-27T19:41:50.05449Z","steps":["trace[2083165610] 'count revisions from in-memory index tree' (duration: 1.002166025s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.054304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"862.599159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T19:41:50.054539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.052208Z","time spent":"1.002322947s","remote":"127.0.0.1:41334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-04-27T19:41:50.054546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.027461517s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:41:50.054572Z","caller":"traceutil/trace.go:171","msg":"trace[631023668] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:626; }","duration":"862.884474ms","start":"2026-04-27T19:41:49.191677Z","end":"2026-04-27T19:41:50.054561Z","steps":["trace[631023668] 'range keys from in-memory index tree' (duration: 862.497617ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:50.054585Z","caller":"traceutil/trace.go:171","msg":"trace[611172652] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:626; }","duration":"1.027526059s","start":"2026-04-27T19:41:49.027046Z","end":"2026-04-27T19:41:50.054572Z","steps":["trace[611172652] 'count revisions from in-memory index tree' (duration: 1.027355916s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.054609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.191671Z","time spent":"862.927294ms","remote":"127.0.0.1:41372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-27T19:41:50.054633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.027033Z","time spent":"1.02758615s","remote":"127.0.0.1:41324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-27T19:41:50.054637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.501399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:41:50.054686Z","caller":"traceutil/trace.go:171","msg":"trace[328171700] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:626; }","duration":"837.56099ms","start":"2026-04-27T19:41:49.21711Z","end":"2026-04-27T19:41:50.054671Z","steps":["trace[328171700] 'count revisions from in-memory index tree' (duration: 837.474658ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:50.054283Z","caller":"traceutil/trace.go:171","msg":"trace[403181764] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:626; }","duration":"940.154916ms","start":"2026-04-27T19:41:49.11412Z","end":"2026-04-27T19:41:50.054275Z","steps":["trace[403181764] 'range keys from in-memory index tree' (duration: 940.069464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.054727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.217106Z","time spent":"837.6079ms","remote":"127.0.0.1:41386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-04-27T19:41:50.054741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.114114Z","time spent":"940.617635ms","remote":"127.0.0.1:41354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T19:41:50.054502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.026996Z","time spent":"1.027493069s","remote":"127.0.0.1:41324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T19:41:50.053478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"967.695068ms","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-04-27T19:41:50.054854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.02707796s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T19:41:50.054375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.051796Z","time spent":"1.002563232s","remote":"127.0.0.1:41334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"info","ts":"2026-04-27T19:41:50.054898Z","caller":"traceutil/trace.go:171","msg":"trace[1613968802] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:626; }","duration":"1.027143892s","start":"2026-04-27T19:41:49.027742Z","end":"2026-04-27T19:41:50.054886Z","steps":["trace[1613968802] 'range keys from in-memory index tree' (duration: 1.02702056s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.053921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.894632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T19:41:50.053438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.052726Z","time spent":"1.00069745s","remote":"127.0.0.1:41334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"info","ts":"2026-04-27T19:41:50.054988Z","caller":"traceutil/trace.go:171","msg":"trace[968398197] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"796.97857ms","start":"2026-04-27T19:41:49.257996Z","end":"2026-04-27T19:41:50.054975Z","steps":["trace[968398197] 'range keys from in-memory index tree' (duration: 795.833501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.053981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.731239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T19:41:50.055039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.257989Z","time spent":"797.03139ms","remote":"127.0.0.1:41394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"info","ts":"2026-04-27T19:41:50.055073Z","caller":"traceutil/trace.go:171","msg":"trace[478537096] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"796.821447ms","start":"2026-04-27T19:41:49.258239Z","end":"2026-04-27T19:41:50.05506Z","steps":["trace[478537096] 'count revisions from in-memory index tree' (duration: 795.708139ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.055122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.258225Z","time spent":"796.877519ms","remote":"127.0.0.1:41400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-04-27T19:41:50.053489Z","caller":"traceutil/trace.go:171","msg":"trace[637454424] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"813.421186ms","start":"2026-04-27T19:41:49.240058Z","end":"2026-04-27T19:41:50.053479Z","steps":["trace[637454424] 'count revisions from in-memory index tree' (duration: 813.267094ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.055319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.240051Z","time spent":"815.256016ms","remote":"127.0.0.1:41394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-04-27T19:41:50.055323Z","caller":"traceutil/trace.go:171","msg":"trace[431480492] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"620.642449ms","start":"2026-04-27T19:41:49.43462Z","end":"2026-04-27T19:41:50.055262Z","steps":["trace[431480492] 'read index received' (duration: 554.915407ms)","trace[431480492] 'applied index is now lower than readState.Index' (duration: 65.725902ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:41:50.055628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.995456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:41:50.05571Z","caller":"traceutil/trace.go:171","msg":"trace[707420897] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"621.098067ms","start":"2026-04-27T19:41:49.434599Z","end":"2026-04-27T19:41:50.055697Z","steps":["trace[707420897] 'agreement among raft nodes before linearized reading' (duration: 620.817303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.055788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.434515Z","time spent":"621.26035ms","remote":"127.0.0.1:47316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-27T19:41:50.054371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.114398Z","time spent":"939.966093ms","remote":"127.0.0.1:41354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-27T19:41:50.053311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.191481Z","time spent":"861.811796ms","remote":"127.0.0.1:41372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-27T19:41:50.053442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.085374Z","time spent":"968.058274ms","remote":"127.0.0.1:41344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"info","ts":"2026-04-27T19:41:50.054897Z","caller":"traceutil/trace.go:171","msg":"trace[582305182] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:626; }","duration":"969.114981ms","start":"2026-04-27T19:41:49.085765Z","end":"2026-04-27T19:41:50.054879Z","steps":["trace[582305182] 'count revisions from in-memory index tree' (duration: 967.672558ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:50.054948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.027732Z","time spent":"1.027201043s","remote":"127.0.0.1:41324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-27T19:41:50.058445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.08576Z","time spent":"972.662521ms","remote":"127.0.0.1:41344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-04-27T19:41:50.057368Z","caller":"traceutil/trace.go:171","msg":"trace[1275264353] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"757.726663ms","start":"2026-04-27T19:41:49.299617Z","end":"2026-04-27T19:41:50.057344Z","steps":["trace[1275264353] 'process raft request' (duration: 690.213031ms)","trace[1275264353] 'compare' (duration: 64.687275ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:41:50.05879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:49.299575Z","time spent":"759.146557ms","remote":"127.0.0.1:47418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T19:41:50.573676Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387083712793215826,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T19:41:51.078335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.90287ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T19:41:51.078571Z","caller":"traceutil/trace.go:171","msg":"trace[787033893] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:651; }","duration":"1.005954631s","start":"2026-04-27T19:41:50.072599Z","end":"2026-04-27T19:41:51.078553Z","steps":["trace[787033893] 'read index received' (duration: 800.741795ms)","trace[787033893] 'applied index is now lower than readState.Index' (duration: 205.211916ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:41:51.078688Z","caller":"traceutil/trace.go:171","msg":"trace[1902925205] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"1.006960858s","start":"2026-04-27T19:41:50.071686Z","end":"2026-04-27T19:41:51.078647Z","steps":["trace[1902925205] 'process raft request' (duration: 801.637531ms)","trace[1902925205] 'compare' (duration: 204.371441ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:41:51.078913Z","caller":"traceutil/trace.go:171","msg":"trace[1895719629] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"969.864202ms","start":"2026-04-27T19:41:50.109032Z","end":"2026-04-27T19:41:51.078896Z","steps":["trace[1895719629] 'process raft request' (duration: 969.431515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:51.078927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:50.07167Z","time spent":"1.007154372s","remote":"127.0.0.1:47510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T19:41:51.079933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:50.109002Z","time spent":"970.892618ms","remote":"127.0.0.1:47678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T19:41:51.079858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"998.400896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-27T19:41:51.080207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.007575238s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-27T19:41:51.080313Z","caller":"traceutil/trace.go:171","msg":"trace[1901281529] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:629; }","duration":"1.00771315s","start":"2026-04-27T19:41:50.072575Z","end":"2026-04-27T19:41:51.080288Z","steps":["trace[1901281529] 'agreement among raft nodes before linearized reading' (duration: 1.006308227s)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:51.080295Z","caller":"traceutil/trace.go:171","msg":"trace[426022930] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:629; }","duration":"998.822322ms","start":"2026-04-27T19:41:50.081428Z","end":"2026-04-27T19:41:51.08025Z","steps":["trace[426022930] 'agreement among raft nodes before linearized reading' (duration: 997.509391ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:51.080381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:50.072536Z","time spent":"1.007817881s","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-27T19:41:51.080505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.278666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T19:41:51.080506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.239232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-27T19:41:51.080572Z","caller":"traceutil/trace.go:171","msg":"trace[1117329946] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"645.349837ms","start":"2026-04-27T19:41:50.43519Z","end":"2026-04-27T19:41:51.08054Z","steps":["trace[1117329946] 'agreement among raft nodes before linearized reading' (duration: 645.272585ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:51.080598Z","caller":"traceutil/trace.go:171","msg":"trace[1475841542] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:629; }","duration":"693.358844ms","start":"2026-04-27T19:41:50.387195Z","end":"2026-04-27T19:41:51.080554Z","steps":["trace[1475841542] 'agreement among raft nodes before linearized reading' (duration: 692.869656ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:51.080615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:50.435178Z","time spent":"645.428508ms","remote":"127.0.0.1:47304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-27T19:41:51.08064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:50.387168Z","time spent":"693.460655ms","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-27T19:41:51.080647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:50.08142Z","time spent":"998.959364ms","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-27T19:41:51.08132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"999.793028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-27T19:41:51.081372Z","caller":"traceutil/trace.go:171","msg":"trace[1352531025] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:629; }","duration":"999.86673ms","start":"2026-04-27T19:41:50.081489Z","end":"2026-04-27T19:41:51.081356Z","steps":["trace[1352531025] 'agreement among raft nodes before linearized reading' (duration: 999.723688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:51.081418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:50.081474Z","time spent":"999.935281ms","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-27T19:41:52.935498Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387083712793215832,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T19:41:53.436615Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387083712793215832,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T19:41:53.937303Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387083712793215832,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T19:41:54.43554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000130251s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-27T19:41:54.435621Z","caller":"traceutil/trace.go:171","msg":"trace[576360603] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000224642s","start":"2026-04-27T19:41:52.435378Z","end":"2026-04-27T19:41:54.435603Z","steps":["trace[576360603] 'agreement among raft nodes before linearized reading' (duration: 2.000125821s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:54.435659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:52.435314Z","time spent":"2.000336464s","remote":"127.0.0.1:47304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/27 19:41:54 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-27T19:41:54.438217Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387083712793215832,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-27T19:41:54.457388Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.946271409s","expected-duration":"1s"} {"level":"info","ts":"2026-04-27T19:41:54.458379Z","caller":"traceutil/trace.go:171","msg":"trace[573593093] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"2.948351682s","start":"2026-04-27T19:41:51.509995Z","end":"2026-04-27T19:41:54.458347Z","steps":["trace[573593093] 'process raft request' (duration: 2.947791013s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:54.458572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:51.509959Z","time spent":"2.948506264s","remote":"127.0.0.1:47418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T19:41:54.572693Z","caller":"traceutil/trace.go:171","msg":"trace[983852039] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:657; }","duration":"2.137278881s","start":"2026-04-27T19:41:52.435393Z","end":"2026-04-27T19:41:54.572672Z","steps":["trace[983852039] 'read index received' (duration: 2.022229655s)","trace[983852039] 'applied index is now lower than readState.Index' (duration: 115.047836ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:41:54.572921Z","caller":"traceutil/trace.go:171","msg":"trace[857728975] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"3.059834469s","start":"2026-04-27T19:41:51.513034Z","end":"2026-04-27T19:41:54.572868Z","steps":["trace[857728975] 'process raft request' (duration: 3.033268074s)","trace[857728975] 'compare' (duration: 26.183269ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:41:54.573173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:51.513008Z","time spent":"3.060031742s","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T19:41:54.577081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.740137881s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.130\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-27T19:41:54.577157Z","caller":"traceutil/trace.go:171","msg":"trace[458506203] range","detail":"{range_begin:/registry/masterleases/199.19.213.130; range_end:; response_count:1; response_revision:636; }","duration":"1.740217742s","start":"2026-04-27T19:41:52.83692Z","end":"2026-04-27T19:41:54.577138Z","steps":["trace[458506203] 'agreement among raft nodes before linearized reading' (duration: 1.739944418s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:54.577179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.396429697s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T19:41:54.577271Z","caller":"traceutil/trace.go:171","msg":"trace[1070849471] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:636; }","duration":"1.396591619s","start":"2026-04-27T19:41:53.180658Z","end":"2026-04-27T19:41:54.577249Z","steps":["trace[1070849471] 'agreement among raft nodes before linearized reading' (duration: 1.396298415s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:54.57733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:53.180631Z","time spent":"1.396688921s","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-27T19:41:54.577334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.471364559s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-27T19:41:54.57738Z","caller":"traceutil/trace.go:171","msg":"trace[394386661] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:636; }","duration":"1.471455191s","start":"2026-04-27T19:41:53.105912Z","end":"2026-04-27T19:41:54.577367Z","steps":["trace[394386661] 'agreement among raft nodes before linearized reading' (duration: 1.471331879s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:54.577429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:53.105879Z","time spent":"1.471539422s","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-27T19:41:54.577216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:52.836848Z","time spent":"1.740355064s","remote":"127.0.0.1:47372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.19.213.130\" "} {"level":"warn","ts":"2026-04-27T19:41:54.577448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.39664989s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-27T19:41:54.577527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.44215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:41:54.577718Z","caller":"traceutil/trace.go:171","msg":"trace[1586978384] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"141.618723ms","start":"2026-04-27T19:41:54.436042Z","end":"2026-04-27T19:41:54.577661Z","steps":["trace[1586978384] 'agreement among raft nodes before linearized reading' (duration: 141.44861ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:54.577934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.397126958s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-27T19:41:54.57811Z","caller":"traceutil/trace.go:171","msg":"trace[1729626740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:636; }","duration":"1.397323411s","start":"2026-04-27T19:41:53.180717Z","end":"2026-04-27T19:41:54.578041Z","steps":["trace[1729626740] 'agreement among raft nodes before linearized reading' (duration: 1.396229363s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:54.578259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:53.180704Z","time spent":"1.397526374s","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-27T19:41:54.578834Z","caller":"traceutil/trace.go:171","msg":"trace[859638064] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:636; }","duration":"1.396837253s","start":"2026-04-27T19:41:53.180726Z","end":"2026-04-27T19:41:54.577563Z","steps":["trace[859638064] 'agreement among raft nodes before linearized reading' (duration: 1.396522808s)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:54.578939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:53.180695Z","time spent":"1.398231705s","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-27T19:41:55.629926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.04073ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-27T19:41:55.630154Z","caller":"traceutil/trace.go:171","msg":"trace[923622118] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"219.721147ms","start":"2026-04-27T19:41:55.410418Z","end":"2026-04-27T19:41:55.630139Z","steps":["trace[923622118] 'process raft request' (duration: 219.620804ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:55.630326Z","caller":"traceutil/trace.go:171","msg":"trace[1811239406] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"415.788368ms","start":"2026-04-27T19:41:55.21453Z","end":"2026-04-27T19:41:55.630318Z","steps":["trace[1811239406] 'process raft request' (duration: 36.932138ms)","trace[1811239406] 'compare' (duration: 376.747216ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:41:55.630353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:41:55.214496Z","time spent":"415.842318ms","remote":"127.0.0.1:47410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":700,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T19:41:56.608029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.690245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:41:56.60811Z","caller":"traceutil/trace.go:171","msg":"trace[2049810287] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:661; }","duration":"170.791446ms","start":"2026-04-27T19:41:56.437299Z","end":"2026-04-27T19:41:56.608091Z","steps":["trace[2049810287] 'range keys from in-memory index tree' (duration: 170.579582ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:57.369905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.178209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:41:57.369993Z","caller":"traceutil/trace.go:171","msg":"trace[1151447843] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:694; }","duration":"107.354151ms","start":"2026-04-27T19:41:57.262618Z","end":"2026-04-27T19:41:57.369972Z","steps":["trace[1151447843] 'range keys from in-memory index tree' (duration: 107.035957ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:59.457408Z","caller":"traceutil/trace.go:171","msg":"trace[2101059999] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"192.07839ms","start":"2026-04-27T19:41:59.265297Z","end":"2026-04-27T19:41:59.457375Z","steps":["trace[2101059999] 'process raft request' (duration: 191.808836ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:59.754994Z","caller":"traceutil/trace.go:171","msg":"trace[277953887] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"290.198202ms","start":"2026-04-27T19:41:59.464772Z","end":"2026-04-27T19:41:59.75497Z","steps":["trace[277953887] 'process raft request' (duration: 290.134151ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:59.755089Z","caller":"traceutil/trace.go:171","msg":"trace[208417155] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"290.978854ms","start":"2026-04-27T19:41:59.464062Z","end":"2026-04-27T19:41:59.755041Z","steps":["trace[208417155] 'process raft request' (duration: 290.71772ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:42:11.376474Z","caller":"traceutil/trace.go:171","msg":"trace[2020077468] linearizableReadLoop","detail":"{readStateIndex:831; appliedIndex:830; }","duration":"162.265202ms","start":"2026-04-27T19:42:11.214166Z","end":"2026-04-27T19:42:11.376431Z","steps":["trace[2020077468] 'read index received' (duration: 161.945998ms)","trace[2020077468] 'applied index is now lower than readState.Index' (duration: 317.014µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:42:11.376626Z","caller":"traceutil/trace.go:171","msg":"trace[1421870403] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"190.340868ms","start":"2026-04-27T19:42:11.186243Z","end":"2026-04-27T19:42:11.376584Z","steps":["trace[1421870403] 'process raft request' (duration: 189.861461ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:42:11.376993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.634968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-qvsxz\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-27T19:42:11.377078Z","caller":"traceutil/trace.go:171","msg":"trace[795950713] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-qvsxz; range_end:; response_count:1; response_revision:802; }","duration":"162.944532ms","start":"2026-04-27T19:42:11.214112Z","end":"2026-04-27T19:42:11.377057Z","steps":["trace[795950713] 'agreement among raft nodes before linearized reading' (duration: 162.494806ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:42:11.494712Z","caller":"traceutil/trace.go:171","msg":"trace[1302001173] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"108.892542ms","start":"2026-04-27T19:42:11.385775Z","end":"2026-04-27T19:42:11.494668Z","steps":["trace[1302001173] 'process raft request' (duration: 85.656755ms)","trace[1302001173] 'compare' (duration: 23.024784ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:42:11.528342Z","caller":"traceutil/trace.go:171","msg":"trace[108276965] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"141.741594ms","start":"2026-04-27T19:42:11.386547Z","end":"2026-04-27T19:42:11.528289Z","steps":["trace[108276965] 'process raft request' (duration: 141.316878ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:42:11.694376Z","caller":"traceutil/trace.go:171","msg":"trace[1181908096] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"139.086277ms","start":"2026-04-27T19:42:11.55526Z","end":"2026-04-27T19:42:11.694347Z","steps":["trace[1181908096] 'process raft request' (duration: 138.452798ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:42:13.290466Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387083712793216170,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-27T19:42:13.42413Z","caller":"traceutil/trace.go:171","msg":"trace[511923037] linearizableReadLoop","detail":"{readStateIndex:836; appliedIndex:835; }","duration":"634.535101ms","start":"2026-04-27T19:42:12.789572Z","end":"2026-04-27T19:42:13.424107Z","steps":["trace[511923037] 'read index received' (duration: 634.280277ms)","trace[511923037] 'applied index is now lower than readState.Index' (duration: 254.134µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:42:13.424182Z","caller":"traceutil/trace.go:171","msg":"trace[1244332472] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"886.928016ms","start":"2026-04-27T19:42:12.537232Z","end":"2026-04-27T19:42:13.42416Z","steps":["trace[1244332472] 'process raft request' (duration: 886.682122ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:42:13.424323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:42:12.537202Z","time spent":"887.028228ms","remote":"127.0.0.1:47568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T19:42:13.424732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.1553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T19:42:13.424793Z","caller":"traceutil/trace.go:171","msg":"trace[1083002192] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:807; }","duration":"635.261651ms","start":"2026-04-27T19:42:12.789517Z","end":"2026-04-27T19:42:13.424779Z","steps":["trace[1083002192] 'agreement among raft nodes before linearized reading' (duration: 634.707652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:42:13.424904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.86034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-27T19:42:13.424948Z","caller":"traceutil/trace.go:171","msg":"trace[705633885] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:807; }","duration":"625.953651ms","start":"2026-04-27T19:42:12.798984Z","end":"2026-04-27T19:42:13.424937Z","steps":["trace[705633885] 'agreement among raft nodes before linearized reading' (duration: 625.829279ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:42:13.424986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:42:12.79896Z","time spent":"626.016643ms","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-27T19:42:13.424944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:42:12.789494Z","time spent":"635.394923ms","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-27T19:42:13.425214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.662712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T19:42:13.425251Z","caller":"traceutil/trace.go:171","msg":"trace[244449044] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:807; }","duration":"166.745303ms","start":"2026-04-27T19:42:13.258497Z","end":"2026-04-27T19:42:13.425242Z","steps":["trace[244449044] 'agreement among raft nodes before linearized reading' (duration: 166.637572ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:42:13.425439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.489684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-27T19:42:13.425472Z","caller":"traceutil/trace.go:171","msg":"trace[1142636297] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:807; }","duration":"617.535104ms","start":"2026-04-27T19:42:12.807929Z","end":"2026-04-27T19:42:13.425464Z","steps":["trace[1142636297] 'agreement among raft nodes before linearized reading' (duration: 617.446043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:42:13.425498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:42:12.807923Z","time spent":"617.568795ms","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-27T19:42:13.4255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.626886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.130\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-04-27T19:42:13.425608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.695716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-27T19:42:13.425638Z","caller":"traceutil/trace.go:171","msg":"trace[1284549037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:807; }","duration":"617.740316ms","start":"2026-04-27T19:42:12.807889Z","end":"2026-04-27T19:42:13.42563Z","steps":["trace[1284549037] 'agreement among raft nodes before linearized reading' (duration: 617.670515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:42:13.425662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:42:12.807881Z","time spent":"617.775738ms","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-27T19:42:13.425653Z","caller":"traceutil/trace.go:171","msg":"trace[351661805] range","detail":"{range_begin:/registry/masterleases/199.19.213.130; range_end:; response_count:1; response_revision:807; }","duration":"587.839289ms","start":"2026-04-27T19:42:12.837779Z","end":"2026-04-27T19:42:13.425618Z","steps":["trace[351661805] 'agreement among raft nodes before linearized reading' (duration: 587.383653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:42:13.425723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:42:12.837769Z","time spent":"587.94079ms","remote":"127.0.0.1:47372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.19.213.130\" "} {"level":"warn","ts":"2026-04-27T19:42:13.425825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.661169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-27T19:42:13.42586Z","caller":"traceutil/trace.go:171","msg":"trace[1016495098] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:807; }","duration":"618.72454ms","start":"2026-04-27T19:42:12.807127Z","end":"2026-04-27T19:42:13.425851Z","steps":["trace[1016495098] 'agreement among raft nodes before linearized reading' (duration: 618.642009ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:42:13.425887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:42:12.80707Z","time spent":"618.811322ms","remote":"127.0.0.1:47598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-27T19:42:13.425995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.125308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T19:42:13.426414Z","caller":"traceutil/trace.go:171","msg":"trace[1717825365] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:807; }","duration":"453.620275ms","start":"2026-04-27T19:42:12.972773Z","end":"2026-04-27T19:42:13.426393Z","steps":["trace[1717825365] 'agreement among raft nodes before linearized reading' (duration: 452.785593ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:42:13.426523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:42:12.972748Z","time spent":"453.758566ms","remote":"127.0.0.1:47410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":94,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-04-27T19:42:13.4261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.32108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:42:13.426931Z","caller":"traceutil/trace.go:171","msg":"trace[678053889] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:807; }","duration":"570.163132ms","start":"2026-04-27T19:42:12.856751Z","end":"2026-04-27T19:42:13.426914Z","steps":["trace[678053889] 'agreement among raft nodes before linearized reading' (duration: 569.32436ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:42:13.426999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:42:12.856741Z","time spent":"570.242593ms","remote":"127.0.0.1:47776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-04-27T19:42:13.426141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.145831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:42:13.428221Z","caller":"traceutil/trace.go:171","msg":"trace[1474580278] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:807; }","duration":"534.20038ms","start":"2026-04-27T19:42:12.893968Z","end":"2026-04-27T19:42:13.428168Z","steps":["trace[1474580278] 'agreement among raft nodes before linearized reading' (duration: 532.153651ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:42:13.426196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.201575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T19:42:13.428462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:42:12.893958Z","time spent":"534.376912ms","remote":"127.0.0.1:47714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":29,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"info","ts":"2026-04-27T19:42:13.428528Z","caller":"traceutil/trace.go:171","msg":"trace[569558424] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:807; }","duration":"444.541127ms","start":"2026-04-27T19:42:12.98395Z","end":"2026-04-27T19:42:13.428491Z","steps":["trace[569558424] 'agreement among raft nodes before linearized reading' (duration: 442.200824ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:42:13.428655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:42:12.98394Z","time spent":"444.666829ms","remote":"127.0.0.1:47686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-27T19:42:25.716918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.454033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-27T19:42:25.716984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.86253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-27T19:42:25.716977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.233281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-27T19:42:25.717018Z","caller":"traceutil/trace.go:171","msg":"trace[1012408068] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:956; }","duration":"182.908711ms","start":"2026-04-27T19:42:25.534099Z","end":"2026-04-27T19:42:25.717008Z","steps":["trace[1012408068] 'agreement among raft nodes before linearized reading' (duration: 182.82374ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:42:25.717001Z","caller":"traceutil/trace.go:171","msg":"trace[1053294698] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:956; }","duration":"178.562815ms","start":"2026-04-27T19:42:25.538419Z","end":"2026-04-27T19:42:25.716982Z","steps":["trace[1053294698] 'agreement among raft nodes before linearized reading' (duration: 178.339882ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:42:25.717052Z","caller":"traceutil/trace.go:171","msg":"trace[935359782] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:956; }","duration":"182.335732ms","start":"2026-04-27T19:42:25.534698Z","end":"2026-04-27T19:42:25.717034Z","steps":["trace[935359782] 'agreement among raft nodes before linearized reading' (duration: 182.086729ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:42:25.717132Z","caller":"traceutil/trace.go:171","msg":"trace[758754950] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"182.838359ms","start":"2026-04-27T19:42:25.533884Z","end":"2026-04-27T19:42:25.716722Z","steps":["trace[758754950] 'process raft request' (duration: 100.170001ms)","trace[758754950] 'compare' (duration: 82.364124ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:42:25.717531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.892998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-27T19:42:25.717595Z","caller":"traceutil/trace.go:171","msg":"trace[1057662539] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:956; }","duration":"178.948699ms","start":"2026-04-27T19:42:25.538616Z","end":"2026-04-27T19:42:25.717565Z","steps":["trace[1057662539] 'agreement among raft nodes before linearized reading' (duration: 178.186889ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:42:25.716746Z","caller":"traceutil/trace.go:171","msg":"trace[4375203] linearizableReadLoop","detail":"{readStateIndex:989; appliedIndex:988; }","duration":"152.072206ms","start":"2026-04-27T19:42:25.564644Z","end":"2026-04-27T19:42:25.716716Z","steps":["trace[4375203] 'read index received' (duration: 69.441229ms)","trace[4375203] 'applied index is now lower than readState.Index' (duration: 82.629197ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:42:25.721525Z","caller":"traceutil/trace.go:171","msg":"trace[760638213] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"146.146149ms","start":"2026-04-27T19:42:25.575364Z","end":"2026-04-27T19:42:25.72151Z","steps":["trace[760638213] 'process raft request' (duration: 146.110098ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:42:25.721755Z","caller":"traceutil/trace.go:171","msg":"trace[1396129371] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"152.917106ms","start":"2026-04-27T19:42:25.568831Z","end":"2026-04-27T19:42:25.721749Z","steps":["trace[1396129371] 'process raft request' (duration: 152.558131ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:42:46.243102Z","caller":"traceutil/trace.go:171","msg":"trace[913392341] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"100.270017ms","start":"2026-04-27T19:42:46.142803Z","end":"2026-04-27T19:42:46.243073Z","steps":["trace[913392341] 'process raft request' (duration: 100.126666ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:43:08.203955Z","caller":"traceutil/trace.go:171","msg":"trace[642720045] linearizableReadLoop","detail":"{readStateIndex:1161; appliedIndex:1160; }","duration":"157.217491ms","start":"2026-04-27T19:43:08.046722Z","end":"2026-04-27T19:43:08.20394Z","steps":["trace[642720045] 'read index received' (duration: 157.07827ms)","trace[642720045] 'applied index is now lower than readState.Index' (duration: 138.331µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:43:08.204105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.374753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-27T19:43:08.204125Z","caller":"traceutil/trace.go:171","msg":"trace[1244276410] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1119; }","duration":"157.427934ms","start":"2026-04-27T19:43:08.046691Z","end":"2026-04-27T19:43:08.204119Z","steps":["trace[1244276410] 'agreement among raft nodes before linearized reading' (duration: 157.334613ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:43:08.204038Z","caller":"traceutil/trace.go:171","msg":"trace[1195948539] transaction","detail":"{read_only:false; response_revision:1119; number_of_response:1; }","duration":"209.876781ms","start":"2026-04-27T19:43:07.994142Z","end":"2026-04-27T19:43:08.204018Z","steps":["trace[1195948539] 'process raft request' (duration: 209.709689ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:43:08.204237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.336449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-04-27T19:43:08.204266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.407891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-27T19:43:08.204304Z","caller":"traceutil/trace.go:171","msg":"trace[570833938] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1119; }","duration":"141.41764ms","start":"2026-04-27T19:43:08.062871Z","end":"2026-04-27T19:43:08.204289Z","steps":["trace[570833938] 'agreement among raft nodes before linearized reading' (duration: 141.245298ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:43:08.204343Z","caller":"traceutil/trace.go:171","msg":"trace[1690332389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1119; }","duration":"150.528303ms","start":"2026-04-27T19:43:08.053795Z","end":"2026-04-27T19:43:08.204323Z","steps":["trace[1690332389] 'agreement among raft nodes before linearized reading' (duration: 150.29086ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:43:30.624998Z","caller":"traceutil/trace.go:171","msg":"trace[272157037] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"100.330231ms","start":"2026-04-27T19:43:30.524623Z","end":"2026-04-27T19:43:30.624954Z","steps":["trace[272157037] 'process raft request' (duration: 86.288478ms)","trace[272157037] 'compare' (duration: 13.844142ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:43:30.625997Z","caller":"traceutil/trace.go:171","msg":"trace[546257511] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"100.780306ms","start":"2026-04-27T19:43:30.525202Z","end":"2026-04-27T19:43:30.625982Z","steps":["trace[546257511] 'process raft request' (duration: 100.745595ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:43:30.626211Z","caller":"traceutil/trace.go:171","msg":"trace[1527703234] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"101.130379ms","start":"2026-04-27T19:43:30.525066Z","end":"2026-04-27T19:43:30.626197Z","steps":["trace[1527703234] 'process raft request' (duration: 100.832156ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:43:30.626201Z","caller":"traceutil/trace.go:171","msg":"trace[1113384748] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"101.048208ms","start":"2026-04-27T19:43:30.525013Z","end":"2026-04-27T19:43:30.626061Z","steps":["trace[1113384748] 'process raft request' (duration: 100.800156ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:43:32.644696Z","caller":"traceutil/trace.go:171","msg":"trace[1886038369] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"116.457938ms","start":"2026-04-27T19:43:32.528194Z","end":"2026-04-27T19:43:32.644652Z","steps":["trace[1886038369] 'process raft request' (duration: 116.074494ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:43:40.91397Z","caller":"traceutil/trace.go:171","msg":"trace[1032506450] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"111.919541ms","start":"2026-04-27T19:43:40.802017Z","end":"2026-04-27T19:43:40.913936Z","steps":["trace[1032506450] 'process raft request' (duration: 96.164895ms)","trace[1032506450] 'compare' (duration: 15.402803ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:43:40.914021Z","caller":"traceutil/trace.go:171","msg":"trace[872533537] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"111.468707ms","start":"2026-04-27T19:43:40.802512Z","end":"2026-04-27T19:43:40.91398Z","steps":["trace[872533537] 'process raft request' (duration: 111.228135ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:43:40.914132Z","caller":"traceutil/trace.go:171","msg":"trace[1760529826] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"111.037193ms","start":"2026-04-27T19:43:40.803087Z","end":"2026-04-27T19:43:40.914124Z","steps":["trace[1760529826] 'process raft request' (duration: 110.70059ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:43:53.081397Z","caller":"traceutil/trace.go:171","msg":"trace[236623284] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"128.842ms","start":"2026-04-27T19:43:52.952532Z","end":"2026-04-27T19:43:53.081374Z","steps":["trace[236623284] 'process raft request' (duration: 128.595148ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:43:53.16326Z","caller":"traceutil/trace.go:171","msg":"trace[1752227196] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"149.896417ms","start":"2026-04-27T19:43:53.013319Z","end":"2026-04-27T19:43:53.163215Z","steps":["trace[1752227196] 'process raft request' (duration: 149.597214ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:43:53.16334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.689247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-27T19:43:53.163429Z","caller":"traceutil/trace.go:171","msg":"trace[1329429679] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1265; }","duration":"148.818998ms","start":"2026-04-27T19:43:53.014591Z","end":"2026-04-27T19:43:53.16341Z","steps":["trace[1329429679] 'agreement among raft nodes before linearized reading' (duration: 148.612886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:43:53.163828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.682883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T19:43:53.163862Z","caller":"traceutil/trace.go:171","msg":"trace[1272892463] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1265; }","duration":"151.797714ms","start":"2026-04-27T19:43:53.012058Z","end":"2026-04-27T19:43:53.163855Z","steps":["trace[1272892463] 'agreement among raft nodes before linearized reading' (duration: 151.066717ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:43:55.145589Z","caller":"traceutil/trace.go:171","msg":"trace[2088811886] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"188.995849ms","start":"2026-04-27T19:43:54.956546Z","end":"2026-04-27T19:43:55.145542Z","steps":["trace[2088811886] 'process raft request' (duration: 188.696366ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:43:56.812806Z","caller":"traceutil/trace.go:171","msg":"trace[205413142] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"149.15771ms","start":"2026-04-27T19:43:56.663618Z","end":"2026-04-27T19:43:56.812775Z","steps":["trace[205413142] 'process raft request' (duration: 148.163042ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:43:57.620481Z","caller":"traceutil/trace.go:171","msg":"trace[1861722265] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"100.422569ms","start":"2026-04-27T19:43:57.520031Z","end":"2026-04-27T19:43:57.620454Z","steps":["trace[1861722265] 'process raft request' (duration: 100.252767ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:43:57.82335Z","caller":"traceutil/trace.go:171","msg":"trace[1397874287] linearizableReadLoop","detail":"{readStateIndex:1339; appliedIndex:1337; }","duration":"195.790031ms","start":"2026-04-27T19:43:57.627537Z","end":"2026-04-27T19:43:57.823327Z","steps":["trace[1397874287] 'read index received' (duration: 5.806031ms)","trace[1397874287] 'applied index is now lower than readState.Index' (duration: 189.98297ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:43:57.823571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.015983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:1490"} {"level":"info","ts":"2026-04-27T19:43:57.823602Z","caller":"traceutil/trace.go:171","msg":"trace[554279473] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1286; }","duration":"196.071593ms","start":"2026-04-27T19:43:57.627523Z","end":"2026-04-27T19:43:57.823594Z","steps":["trace[554279473] 'agreement among raft nodes before linearized reading' (duration: 195.897852ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:43:57.823806Z","caller":"traceutil/trace.go:171","msg":"trace[1047075242] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"198.07674ms","start":"2026-04-27T19:43:57.625721Z","end":"2026-04-27T19:43:57.823797Z","steps":["trace[1047075242] 'process raft request' (duration: 197.259633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:43:58.175387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.361011ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T19:43:58.175577Z","caller":"traceutil/trace.go:171","msg":"trace[2106849709] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"210.208294ms","start":"2026-04-27T19:43:57.965335Z","end":"2026-04-27T19:43:58.175543Z","steps":["trace[2106849709] 'process raft request' (duration: 105.585691ms)","trace[2106849709] 'compare' (duration: 104.21228ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:43:58.175812Z","caller":"traceutil/trace.go:171","msg":"trace[2021870065] linearizableReadLoop","detail":"{readStateIndex:1345; appliedIndex:1344; }","duration":"207.622701ms","start":"2026-04-27T19:43:57.968139Z","end":"2026-04-27T19:43:58.175762Z","steps":["trace[2021870065] 'read index received' (duration: 102.634865ms)","trace[2021870065] 'applied index is now lower than readState.Index' (duration: 104.983236ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:43:58.175926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.772143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d1f958ae-4285-4e16-8135-5d3800f52362\" ","response":"range_response_count:1 size:3579"} {"level":"info","ts":"2026-04-27T19:43:58.176017Z","caller":"traceutil/trace.go:171","msg":"trace[953510822] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d1f958ae-4285-4e16-8135-5d3800f52362; range_end:; response_count:1; response_revision:1292; }","duration":"207.849583ms","start":"2026-04-27T19:43:57.968116Z","end":"2026-04-27T19:43:58.175965Z","steps":["trace[953510822] 'agreement among raft nodes before linearized reading' (duration: 207.753512ms)"],"step_count":1}