{"level":"warn","ts":"2026-04-03T01:32:25.804576Z","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-03T01:32:25.804675Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.233:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.233:2380","--initial-cluster=instance=https://199.204.45.233:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.233:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.233: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-03T01:32:25.804762Z","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-03T01:32:25.804776Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.233:2380"]} {"level":"info","ts":"2026-04-03T01:32:25.804793Z","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-03T01:32:25.806288Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"]} {"level":"info","ts":"2026-04-03T01:32:25.806368Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.233:2380"],"listen-peer-urls":["https://199.204.45.233:2380"],"advertise-client-urls":["https://199.204.45.233:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.233: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-03T01:32:25.811704Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.126208ms"} {"level":"info","ts":"2026-04-03T01:32:25.820535Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"90a0cb2044183f95","cluster-id":"782fef34d5ea94f9"} {"level":"info","ts":"2026-04-03T01:32:25.820632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=()"} {"level":"info","ts":"2026-04-03T01:32:25.820668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became follower at term 0"} {"level":"info","ts":"2026-04-03T01:32:25.820694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 90a0cb2044183f95 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-03T01:32:25.820707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became follower at term 1"} {"level":"info","ts":"2026-04-03T01:32:25.820791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=(10421552877177159573)"} {"level":"warn","ts":"2026-04-03T01:32:25.839342Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-03T01:32:25.84058Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-03T01:32:25.84164Z","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-03T01:32:25.843824Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"90a0cb2044183f95","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-03T01:32:25.846904Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"90a0cb2044183f95","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-03T01:32:25.846975Z","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-03T01:32:25.847059Z","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-03T01:32:25.847075Z","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-03T01:32:25.84988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=(10421552877177159573)"} {"level":"info","ts":"2026-04-03T01:32:25.850013Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"782fef34d5ea94f9","local-member-id":"90a0cb2044183f95","added-peer-id":"90a0cb2044183f95","added-peer-peer-urls":["https://199.204.45.233:2380"]} {"level":"info","ts":"2026-04-03T01:32:25.851745Z","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-03T01:32:25.851917Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.233:2380"} {"level":"info","ts":"2026-04-03T01:32:25.851968Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.233:2380"} {"level":"info","ts":"2026-04-03T01:32:25.851973Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"90a0cb2044183f95","initial-advertise-peer-urls":["https://199.204.45.233:2380"],"listen-peer-urls":["https://199.204.45.233:2380"],"advertise-client-urls":["https://199.204.45.233:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-03T01:32:25.852008Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-03T01:32:26.721638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 is starting a new election at term 1"} {"level":"info","ts":"2026-04-03T01:32:26.721723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-03T01:32:26.721758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 received MsgPreVoteResp from 90a0cb2044183f95 at term 1"} {"level":"info","ts":"2026-04-03T01:32:26.721774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became candidate at term 2"} {"level":"info","ts":"2026-04-03T01:32:26.72178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 received MsgVoteResp from 90a0cb2044183f95 at term 2"} {"level":"info","ts":"2026-04-03T01:32:26.72179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became leader at term 2"} {"level":"info","ts":"2026-04-03T01:32:26.721801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 90a0cb2044183f95 elected leader 90a0cb2044183f95 at term 2"} {"level":"info","ts":"2026-04-03T01:32:26.724895Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-03T01:32:26.725724Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"90a0cb2044183f95","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.233:2379]}","request-path":"/0/members/90a0cb2044183f95/attributes","cluster-id":"782fef34d5ea94f9","publish-timeout":"7s"} {"level":"info","ts":"2026-04-03T01:32:26.725867Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-03T01:32:26.726007Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-03T01:32:26.728346Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.233:2379"} {"level":"info","ts":"2026-04-03T01:32:26.729318Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-03T01:32:26.739155Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"782fef34d5ea94f9","local-member-id":"90a0cb2044183f95","cluster-version":"3.5"} {"level":"info","ts":"2026-04-03T01:32:26.739466Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-03T01:32:26.739616Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-03T01:32:26.739713Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-03T01:32:26.73982Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-03T01:32:28.566956Z","caller":"traceutil/trace.go:171","msg":"trace[1671450844] transaction","detail":"{read_only:false; response_revision:60; number_of_response:1; }","duration":"126.441066ms","start":"2026-04-03T01:32:28.440479Z","end":"2026-04-03T01:32:28.56692Z","steps":["trace[1671450844] 'process raft request' (duration: 99.135702ms)","trace[1671450844] 'compare' (duration: 26.87185ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:32:28.567063Z","caller":"traceutil/trace.go:171","msg":"trace[338497224] transaction","detail":"{read_only:false; response_revision:61; number_of_response:1; }","duration":"105.9003ms","start":"2026-04-03T01:32:28.461139Z","end":"2026-04-03T01:32:28.567039Z","steps":["trace[338497224] 'process raft request' (duration: 105.472597ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:32:29.751831Z","caller":"traceutil/trace.go:171","msg":"trace[1747712232] transaction","detail":"{read_only:false; response_revision:92; number_of_response:1; }","duration":"116.488296ms","start":"2026-04-03T01:32:29.635307Z","end":"2026-04-03T01:32:29.751795Z","steps":["trace[1747712232] 'process raft request' (duration: 70.838006ms)","trace[1747712232] 'compare' (duration: 45.542069ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:32:30.243856Z","caller":"traceutil/trace.go:171","msg":"trace[407868477] linearizableReadLoop","detail":"{readStateIndex:109; appliedIndex:108; }","duration":"259.762604ms","start":"2026-04-03T01:32:29.984065Z","end":"2026-04-03T01:32:30.243827Z","steps":["trace[407868477] 'read index received' (duration: 240.878074ms)","trace[407868477] 'applied index is now lower than readState.Index' (duration: 18.88271ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:32:30.243956Z","caller":"traceutil/trace.go:171","msg":"trace[1558070551] transaction","detail":"{read_only:false; response_revision:104; number_of_response:1; }","duration":"313.547752ms","start":"2026-04-03T01:32:29.930379Z","end":"2026-04-03T01:32:30.243927Z","steps":["trace[1558070551] 'process raft request' (duration: 294.583131ms)","trace[1558070551] 'compare' (duration: 18.698829ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T01:32:30.244166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.450232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-03T01:32:30.244276Z","caller":"traceutil/trace.go:171","msg":"trace[766039420] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:104; }","duration":"141.622574ms","start":"2026-04-03T01:32:30.102622Z","end":"2026-04-03T01:32:30.244245Z","steps":["trace[766039420] 'agreement among raft nodes before linearized reading' (duration: 141.369701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:32:30.244269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.166348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18a2b4c12e54f5e6\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-04-03T01:32:30.244391Z","caller":"traceutil/trace.go:171","msg":"trace[251132324] range","detail":"{range_begin:/registry/events/default/instance.18a2b4c12e54f5e6; range_end:; response_count:1; response_revision:104; }","duration":"260.354399ms","start":"2026-04-03T01:32:29.984Z","end":"2026-04-03T01:32:30.244354Z","steps":["trace[251132324] 'agreement among raft nodes before linearized reading' (duration: 259.985585ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:32:30.244549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:32:29.930365Z","time spent":"313.653332ms","remote":"127.0.0.1:57650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":666,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T01:32:31.576714Z","caller":"traceutil/trace.go:171","msg":"trace[621728290] transaction","detail":"{read_only:false; response_revision:200; number_of_response:1; }","duration":"109.820735ms","start":"2026-04-03T01:32:31.466871Z","end":"2026-04-03T01:32:31.576691Z","steps":["trace[621728290] 'process raft request' (duration: 21.066465ms)","trace[621728290] 'compare' (duration: 88.637139ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:32:31.900978Z","caller":"traceutil/trace.go:171","msg":"trace[2056106836] transaction","detail":"{read_only:false; response_revision:202; number_of_response:1; }","duration":"276.417641ms","start":"2026-04-03T01:32:31.624513Z","end":"2026-04-03T01:32:31.900931Z","steps":["trace[2056106836] 'process raft request' (duration: 187.724201ms)","trace[2056106836] 'compare' (duration: 88.503019ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T01:32:33.12366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"948.578593ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-03T01:32:33.123874Z","caller":"traceutil/trace.go:171","msg":"trace[788053699] linearizableReadLoop","detail":"{readStateIndex:210; appliedIndex:207; }","duration":"921.691451ms","start":"2026-04-03T01:32:32.202164Z","end":"2026-04-03T01:32:33.123855Z","steps":["trace[788053699] 'read index received' (duration: 65.936589ms)","trace[788053699] 'applied index is now lower than readState.Index' (duration: 855.753852ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T01:32:33.124002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"921.837872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:32:33.124033Z","caller":"traceutil/trace.go:171","msg":"trace[956074016] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:205; }","duration":"921.924492ms","start":"2026-04-03T01:32:32.202101Z","end":"2026-04-03T01:32:33.124025Z","steps":["trace[956074016] 'agreement among raft nodes before linearized reading' (duration: 921.815571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:32:33.124064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:32:32.202078Z","time spent":"921.979352ms","remote":"127.0.0.1:57264","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-03T01:32:33.124186Z","caller":"traceutil/trace.go:171","msg":"trace[451915767] transaction","detail":"{read_only:false; response_revision:204; number_of_response:1; }","duration":"1.219517197s","start":"2026-04-03T01:32:31.904639Z","end":"2026-04-03T01:32:33.124156Z","steps":["trace[451915767] 'process raft request' (duration: 1.219124954s)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:32:33.124201Z","caller":"traceutil/trace.go:171","msg":"trace[268864574] transaction","detail":"{read_only:false; response_revision:203; number_of_response:1; }","duration":"1.219628197s","start":"2026-04-03T01:32:31.904537Z","end":"2026-04-03T01:32:33.124165Z","steps":["trace[268864574] 'process raft request' (duration: 269.326252ms)","trace[268864574] 'compare' (duration: 948.307522ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:32:33.12429Z","caller":"traceutil/trace.go:171","msg":"trace[1498758783] transaction","detail":"{read_only:false; response_revision:205; number_of_response:1; }","duration":"1.217974436s","start":"2026-04-03T01:32:31.906279Z","end":"2026-04-03T01:32:33.124254Z","steps":["trace[1498758783] 'process raft request' (duration: 1.217538933s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:32:33.124332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:32:31.904521Z","time spent":"1.21975092s","remote":"127.0.0.1:57574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T01:32:33.124323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:32:31.904617Z","time spent":"1.219647059s","remote":"127.0.0.1:57574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T01:32:33.124417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:32:31.906265Z","time spent":"1.218094157s","remote":"127.0.0.1:57658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T01:32:33.736869Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581741167008767709,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-03T01:32:34.237864Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581741167008767709,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-03T01:32:34.738791Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581741167008767709,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-03T01:32:35.239317Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581741167008767709,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-03T01:32:35.296751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00020532s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-03T01:32:35.296877Z","caller":"traceutil/trace.go:171","msg":"trace[146178098] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000399512s","start":"2026-04-03T01:32:33.296446Z","end":"2026-04-03T01:32:35.296846Z","steps":["trace[146178098] 'agreement among raft nodes before linearized reading' (duration: 2.000234421s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:32:35.296959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:32:33.296423Z","time spent":"2.000524013s","remote":"127.0.0.1:57264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/03 01:32:35 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-03T01:32:35.38681Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.256870854s","expected-duration":"1s"} {"level":"info","ts":"2026-04-03T01:32:35.471305Z","caller":"traceutil/trace.go:171","msg":"trace[792262443] transaction","detail":"{read_only:false; response_revision:206; number_of_response:1; }","duration":"2.341428795s","start":"2026-04-03T01:32:33.129839Z","end":"2026-04-03T01:32:35.471268Z","steps":["trace[792262443] 'process raft request' (duration: 2.257228916s)","trace[792262443] 'compare' (duration: 84.043788ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T01:32:35.471518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:32:33.12982Z","time spent":"2.341582245s","remote":"127.0.0.1:57658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":740,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-03T01:32:36.15066Z","caller":"traceutil/trace.go:171","msg":"trace[849396034] transaction","detail":"{read_only:false; response_revision:207; number_of_response:1; }","duration":"3.019135213s","start":"2026-04-03T01:32:33.131498Z","end":"2026-04-03T01:32:36.150634Z","steps":["trace[849396034] 'process raft request' (duration: 2.977056876s)","trace[849396034] 'compare' (duration: 41.876355ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:32:36.151004Z","caller":"traceutil/trace.go:171","msg":"trace[351116994] transaction","detail":"{read_only:false; response_revision:208; number_of_response:1; }","duration":"3.019249382s","start":"2026-04-03T01:32:33.131716Z","end":"2026-04-03T01:32:36.150965Z","steps":["trace[351116994] 'process raft request' (duration: 3.01885735s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:32:36.151248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:32:33.131709Z","time spent":"3.019418023s","remote":"127.0.0.1:57574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T01:32:36.151263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:32:33.131489Z","time spent":"3.019276533s","remote":"127.0.0.1:57574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T01:32:36.151358Z","caller":"traceutil/trace.go:171","msg":"trace[1801404322] transaction","detail":"{read_only:false; response_revision:209; number_of_response:1; }","duration":"2.894668423s","start":"2026-04-03T01:32:33.256642Z","end":"2026-04-03T01:32:36.15131Z","steps":["trace[1801404322] 'process raft request' (duration: 2.894220579s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:32:36.151522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:32:33.256627Z","time spent":"2.894821513s","remote":"127.0.0.1:57470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T01:32:36.151554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.915326832s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:32:36.151656Z","caller":"traceutil/trace.go:171","msg":"trace[1918763701] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:209; }","duration":"2.915477863s","start":"2026-04-03T01:32:33.236163Z","end":"2026-04-03T01:32:36.151641Z","steps":["trace[1918763701] 'agreement among raft nodes before linearized reading' (duration: 2.915252732s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:32:36.151692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:32:33.236133Z","time spent":"2.915552204s","remote":"127.0.0.1:57574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-03T01:32:36.151283Z","caller":"traceutil/trace.go:171","msg":"trace[1210690889] linearizableReadLoop","detail":"{readStateIndex:214; appliedIndex:210; }","duration":"2.915045169s","start":"2026-04-03T01:32:33.236219Z","end":"2026-04-03T01:32:36.151264Z","steps":["trace[1210690889] 'read index received' (duration: 2.150863607s)","trace[1210690889] 'applied index is now lower than readState.Index' (duration: 764.179772ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T01:32:36.15193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.94924058s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:32:36.151974Z","caller":"traceutil/trace.go:171","msg":"trace[364255238] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:209; }","duration":"1.94932838s","start":"2026-04-03T01:32:34.202634Z","end":"2026-04-03T01:32:36.151962Z","steps":["trace[364255238] 'agreement among raft nodes before linearized reading' (duration: 1.94924458s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:32:36.152004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:32:34.202612Z","time spent":"1.949386361s","remote":"127.0.0.1:57278","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-03T01:32:36.152024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.020238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:32:36.152056Z","caller":"traceutil/trace.go:171","msg":"trace[1784291701] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:209; }","duration":"355.099228ms","start":"2026-04-03T01:32:35.796947Z","end":"2026-04-03T01:32:36.152046Z","steps":["trace[1784291701] 'agreement among raft nodes before linearized reading' (duration: 355.045928ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:32:36.152081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:32:35.796924Z","time spent":"355.153159ms","remote":"127.0.0.1:57264","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-03T01:32:36.152158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.990399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:node-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:32:36.152248Z","caller":"traceutil/trace.go:171","msg":"trace[275205289] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:node-controller; range_end:; response_count:0; response_revision:209; }","duration":"678.1193ms","start":"2026-04-03T01:32:35.474111Z","end":"2026-04-03T01:32:36.15223Z","steps":["trace[275205289] 'agreement among raft nodes before linearized reading' (duration: 677.949519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:32:36.15218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.144244834s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3978"} {"level":"warn","ts":"2026-04-03T01:32:36.152364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:32:35.47409Z","time spent":"678.263542ms","remote":"127.0.0.1:57658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":0,"response size":28,"request content":"key:\"/registry/clusterrolebindings/system:controller:node-controller\" "} {"level":"info","ts":"2026-04-03T01:32:36.152447Z","caller":"traceutil/trace.go:171","msg":"trace[248589386] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:209; }","duration":"1.144507625s","start":"2026-04-03T01:32:35.007896Z","end":"2026-04-03T01:32:36.152404Z","steps":["trace[248589386] 'agreement among raft nodes before linearized reading' (duration: 1.144236363s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:32:36.152684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:32:35.00788Z","time spent":"1.144746946s","remote":"127.0.0.1:57470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4001,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"info","ts":"2026-04-03T01:32:42.091294Z","caller":"traceutil/trace.go:171","msg":"trace[2055127459] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"104.604647ms","start":"2026-04-03T01:32:41.986658Z","end":"2026-04-03T01:32:42.091263Z","steps":["trace[2055127459] 'process raft request' (duration: 80.979189ms)","trace[2055127459] 'compare' (duration: 23.470367ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:32:42.269919Z","caller":"traceutil/trace.go:171","msg":"trace[1607914499] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"124.546542ms","start":"2026-04-03T01:32:42.145343Z","end":"2026-04-03T01:32:42.269889Z","steps":["trace[1607914499] 'process raft request' (duration: 98.689619ms)","trace[1607914499] 'compare' (duration: 25.731952ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:32:42.333005Z","caller":"traceutil/trace.go:171","msg":"trace[367317532] linearizableReadLoop","detail":"{readStateIndex:382; appliedIndex:379; }","duration":"158.767477ms","start":"2026-04-03T01:32:42.174217Z","end":"2026-04-03T01:32:42.332985Z","steps":["trace[367317532] 'read index received' (duration: 69.820278ms)","trace[367317532] 'applied index is now lower than readState.Index' (duration: 88.946209ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:32:42.333108Z","caller":"traceutil/trace.go:171","msg":"trace[2025366343] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"187.391037ms","start":"2026-04-03T01:32:42.145698Z","end":"2026-04-03T01:32:42.333089Z","steps":["trace[2025366343] 'process raft request' (duration: 187.234016ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:32:42.333291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.063489ms","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-03T01:32:42.333362Z","caller":"traceutil/trace.go:171","msg":"trace[267758919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:369; }","duration":"159.154279ms","start":"2026-04-03T01:32:42.174171Z","end":"2026-04-03T01:32:42.333326Z","steps":["trace[267758919] 'agreement among raft nodes before linearized reading' (duration: 159.023878ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:32:42.333496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.176984ms","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-03T01:32:42.333622Z","caller":"traceutil/trace.go:171","msg":"trace[1206601789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:369; }","duration":"158.435995ms","start":"2026-04-03T01:32:42.175163Z","end":"2026-04-03T01:32:42.333599Z","steps":["trace[1206601789] 'agreement among raft nodes before linearized reading' (duration: 158.168783ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:32:42.333827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.567313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"warn","ts":"2026-04-03T01:32:42.333635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.956717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-03T01:32:42.335622Z","caller":"traceutil/trace.go:171","msg":"trace[1568487881] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:369; }","duration":"136.94101ms","start":"2026-04-03T01:32:42.198642Z","end":"2026-04-03T01:32:42.335583Z","steps":["trace[1568487881] 'agreement among raft nodes before linearized reading' (duration: 134.931847ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:32:42.333043Z","caller":"traceutil/trace.go:171","msg":"trace[1438433808] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"187.540047ms","start":"2026-04-03T01:32:42.145474Z","end":"2026-04-03T01:32:42.333014Z","steps":["trace[1438433808] 'process raft request' (duration: 187.349866ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:32:42.333894Z","caller":"traceutil/trace.go:171","msg":"trace[718985157] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:369; }","duration":"156.665773ms","start":"2026-04-03T01:32:42.177209Z","end":"2026-04-03T01:32:42.333875Z","steps":["trace[718985157] 'agreement among raft nodes before linearized reading' (duration: 156.577213ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:32:42.33358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.171976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-04-03T01:32:42.336201Z","caller":"traceutil/trace.go:171","msg":"trace[1313571151] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:369; }","duration":"108.833804ms","start":"2026-04-03T01:32:42.227317Z","end":"2026-04-03T01:32:42.336151Z","steps":["trace[1313571151] 'agreement among raft nodes before linearized reading' (duration: 106.170187ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:32:42.497501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.010956ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-03T01:32:42.497636Z","caller":"traceutil/trace.go:171","msg":"trace[597004468] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"159.017847ms","start":"2026-04-03T01:32:42.338598Z","end":"2026-04-03T01:32:42.497616Z","steps":["trace[597004468] 'process raft request' (duration: 44.72211ms)","trace[597004468] 'compare' (duration: 113.735844ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:32:42.49835Z","caller":"traceutil/trace.go:171","msg":"trace[2070053815] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"156.686633ms","start":"2026-04-03T01:32:42.341636Z","end":"2026-04-03T01:32:42.498322Z","steps":["trace[2070053815] 'process raft request' (duration: 156.598423ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:32:42.498427Z","caller":"traceutil/trace.go:171","msg":"trace[1862286860] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"156.377882ms","start":"2026-04-03T01:32:42.341992Z","end":"2026-04-03T01:32:42.49837Z","steps":["trace[1862286860] 'process raft request' (duration: 156.288231ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:32:42.498505Z","caller":"traceutil/trace.go:171","msg":"trace[289241674] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"159.567272ms","start":"2026-04-03T01:32:42.338725Z","end":"2026-04-03T01:32:42.498292Z","steps":["trace[289241674] 'process raft request' (duration: 159.438331ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:32:42.498534Z","caller":"traceutil/trace.go:171","msg":"trace[18139278] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"156.412732ms","start":"2026-04-03T01:32:42.342109Z","end":"2026-04-03T01:32:42.498522Z","steps":["trace[18139278] 'process raft request' (duration: 156.208611ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:32:42.498791Z","caller":"traceutil/trace.go:171","msg":"trace[892992346] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"156.414172ms","start":"2026-04-03T01:32:42.342353Z","end":"2026-04-03T01:32:42.498767Z","steps":["trace[892992346] 'process raft request' (duration: 156.08787ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:32:42.499005Z","caller":"traceutil/trace.go:171","msg":"trace[154742461] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"156.497523ms","start":"2026-04-03T01:32:42.342491Z","end":"2026-04-03T01:32:42.498989Z","steps":["trace[154742461] 'process raft request' (duration: 156.376892ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:32:42.498993Z","caller":"traceutil/trace.go:171","msg":"trace[180122348] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"156.538413ms","start":"2026-04-03T01:32:42.342435Z","end":"2026-04-03T01:32:42.498973Z","steps":["trace[180122348] 'process raft request' (duration: 156.259091ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:32:42.498963Z","caller":"traceutil/trace.go:171","msg":"trace[1831357937] linearizableReadLoop","detail":"{readStateIndex:390; appliedIndex:382; }","duration":"121.684344ms","start":"2026-04-03T01:32:42.377257Z","end":"2026-04-03T01:32:42.498942Z","steps":["trace[1831357937] 'read index received' (duration: 6.073588ms)","trace[1831357937] 'applied index is now lower than readState.Index' (duration: 115.609346ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T01:32:42.501133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.861928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-04-03T01:32:42.501201Z","caller":"traceutil/trace.go:171","msg":"trace[1257081587] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:377; }","duration":"123.933538ms","start":"2026-04-03T01:32:42.377251Z","end":"2026-04-03T01:32:42.501185Z","steps":["trace[1257081587] 'agreement among raft nodes before linearized reading' (duration: 121.750864ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:32:42.848176Z","caller":"traceutil/trace.go:171","msg":"trace[109879301] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"170.37109ms","start":"2026-04-03T01:32:42.677778Z","end":"2026-04-03T01:32:42.848149Z","steps":["trace[109879301] 'process raft request' (duration: 73.819804ms)","trace[109879301] 'compare' (duration: 96.380454ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T01:32:45.0166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.940755ms","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-03T01:32:45.016721Z","caller":"traceutil/trace.go:171","msg":"trace[894156536] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:408; }","duration":"164.059705ms","start":"2026-04-03T01:32:44.852601Z","end":"2026-04-03T01:32:45.01666Z","steps":["trace[894156536] 'range keys from in-memory index tree' (duration: 163.836014ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:32:49.878475Z","caller":"traceutil/trace.go:171","msg":"trace[830886238] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"391.724908ms","start":"2026-04-03T01:32:49.486724Z","end":"2026-04-03T01:32:49.878449Z","steps":["trace[830886238] 'process raft request' (duration: 391.557817ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:32:49.87864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:32:49.486704Z","time spent":"391.849989ms","remote":"127.0.0.1:57470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7096,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T01:32:52.002771Z","caller":"traceutil/trace.go:171","msg":"trace[2057218247] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"164.963028ms","start":"2026-04-03T01:32:51.837753Z","end":"2026-04-03T01:32:52.002716Z","steps":["trace[2057218247] 'process raft request' (duration: 133.30249ms)","trace[2057218247] 'compare' (duration: 31.416417ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:32:52.03827Z","caller":"traceutil/trace.go:171","msg":"trace[844302924] transaction","detail":"{read_only:false; number_of_response:1; response_revision:444; }","duration":"150.027648ms","start":"2026-04-03T01:32:51.888227Z","end":"2026-04-03T01:32:52.038255Z","steps":["trace[844302924] 'process raft request' (duration: 149.907477ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:32:52.03835Z","caller":"traceutil/trace.go:171","msg":"trace[808604962] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"147.679163ms","start":"2026-04-03T01:32:51.890653Z","end":"2026-04-03T01:32:52.038332Z","steps":["trace[808604962] 'process raft request' (duration: 147.532973ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:32:52.323895Z","caller":"traceutil/trace.go:171","msg":"trace[4477531] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"156.964474ms","start":"2026-04-03T01:32:52.166908Z","end":"2026-04-03T01:32:52.323873Z","steps":["trace[4477531] 'process raft request' (duration: 99.352365ms)","trace[4477531] 'compare' (duration: 57.502049ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:32:52.324466Z","caller":"traceutil/trace.go:171","msg":"trace[946064666] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"102.464143ms","start":"2026-04-03T01:32:52.221979Z","end":"2026-04-03T01:32:52.324443Z","steps":["trace[946064666] 'process raft request' (duration: 102.349133ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:05.25034Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581741167008768373,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-03T01:33:05.446465Z","caller":"traceutil/trace.go:171","msg":"trace[132015468] linearizableReadLoop","detail":"{readStateIndex:541; appliedIndex:540; }","duration":"696.895706ms","start":"2026-04-03T01:33:04.749549Z","end":"2026-04-03T01:33:05.446445Z","steps":["trace[132015468] 'read index received' (duration: 696.748805ms)","trace[132015468] 'applied index is now lower than readState.Index' (duration: 146.311µs)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:33:05.44665Z","caller":"traceutil/trace.go:171","msg":"trace[481677311] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"701.389101ms","start":"2026-04-03T01:33:04.745254Z","end":"2026-04-03T01:33:05.446643Z","steps":["trace[481677311] 'process raft request' (duration: 701.097679ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:05.44672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:04.745227Z","time spent":"701.438521ms","remote":"127.0.0.1:57574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T01:33:05.446853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.303557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-03T01:33:05.44687Z","caller":"traceutil/trace.go:171","msg":"trace[1359472674] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:522; }","duration":"697.352888ms","start":"2026-04-03T01:33:04.749512Z","end":"2026-04-03T01:33:05.446865Z","steps":["trace[1359472674] 'agreement among raft nodes before linearized reading' (duration: 697.316857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:05.446886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:04.749498Z","time spent":"697.385158ms","remote":"127.0.0.1:57574","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-03T01:33:05.446994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"688.71969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-03T01:33:05.447006Z","caller":"traceutil/trace.go:171","msg":"trace[402951846] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:522; }","duration":"688.76601ms","start":"2026-04-03T01:33:04.758236Z","end":"2026-04-03T01:33:05.447002Z","steps":["trace[402951846] 'agreement among raft nodes before linearized reading' (duration: 688.70536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:05.447017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:04.758221Z","time spent":"688.79315ms","remote":"127.0.0.1:57574","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-03T01:33:05.447102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.022643ms","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-03T01:33:05.447117Z","caller":"traceutil/trace.go:171","msg":"trace[3061317] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:522; }","duration":"181.077373ms","start":"2026-04-03T01:33:05.266035Z","end":"2026-04-03T01:33:05.447113Z","steps":["trace[3061317] 'agreement among raft nodes before linearized reading' (duration: 181.053343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:05.960317Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581741167008768376,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-03T01:33:06.301424Z","caller":"traceutil/trace.go:171","msg":"trace[760836978] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"846.540223ms","start":"2026-04-03T01:33:05.454852Z","end":"2026-04-03T01:33:06.301392Z","steps":["trace[760836978] 'process raft request' (duration: 846.236021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:06.301596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:05.454833Z","time spent":"846.671234ms","remote":"127.0.0.1:57574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T01:33:06.32387Z","caller":"traceutil/trace.go:171","msg":"trace[1250202711] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"867.225457ms","start":"2026-04-03T01:33:05.456618Z","end":"2026-04-03T01:33:06.323843Z","steps":["trace[1250202711] 'process raft request' (duration: 867.073356ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:33:06.324029Z","caller":"traceutil/trace.go:171","msg":"trace[1688327479] linearizableReadLoop","detail":"{readStateIndex:544; appliedIndex:541; }","duration":"864.620473ms","start":"2026-04-03T01:33:05.459387Z","end":"2026-04-03T01:33:06.324008Z","steps":["trace[1688327479] 'read index received' (duration: 841.812186ms)","trace[1688327479] 'applied index is now lower than readState.Index' (duration: 22.806587ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T01:33:06.324142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:05.456601Z","time spent":"867.337079ms","remote":"127.0.0.1:57574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T01:33:06.324187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.360715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:33:06.324246Z","caller":"traceutil/trace.go:171","msg":"trace[1280389171] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:525; }","duration":"435.455985ms","start":"2026-04-03T01:33:05.888774Z","end":"2026-04-03T01:33:06.32423Z","steps":["trace[1280389171] 'agreement among raft nodes before linearized reading' (duration: 435.370265ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:06.324306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:05.888754Z","time spent":"435.538326ms","remote":"127.0.0.1:57264","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-03T01:33:06.324161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.758364ms","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-03T01:33:06.324551Z","caller":"traceutil/trace.go:171","msg":"trace[1867145362] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:525; }","duration":"865.148966ms","start":"2026-04-03T01:33:05.45937Z","end":"2026-04-03T01:33:06.324519Z","steps":["trace[1867145362] 'agreement among raft nodes before linearized reading' (duration: 864.739644ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:06.324721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:05.459363Z","time spent":"865.303666ms","remote":"127.0.0.1:57380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"info","ts":"2026-04-03T01:33:06.324145Z","caller":"traceutil/trace.go:171","msg":"trace[858730101] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"867.408759ms","start":"2026-04-03T01:33:05.456689Z","end":"2026-04-03T01:33:06.324098Z","steps":["trace[858730101] 'process raft request' (duration: 867.109457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:06.324932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:05.456683Z","time spent":"868.189352ms","remote":"127.0.0.1:57574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T01:33:12.137136Z","caller":"traceutil/trace.go:171","msg":"trace[513526117] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"248.574016ms","start":"2026-04-03T01:33:11.888543Z","end":"2026-04-03T01:33:12.137117Z","steps":["trace[513526117] 'read index received' (duration: 247.6435ms)","trace[513526117] 'applied index is now lower than readState.Index' (duration: 929.756µs)"],"step_count":2} {"level":"warn","ts":"2026-04-03T01:33:12.137285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.720626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:33:12.137265Z","caller":"traceutil/trace.go:171","msg":"trace[1573481422] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"356.010168ms","start":"2026-04-03T01:33:11.781217Z","end":"2026-04-03T01:33:12.137227Z","steps":["trace[1573481422] 'process raft request' (duration: 355.138813ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:33:12.137319Z","caller":"traceutil/trace.go:171","msg":"trace[2138971370] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:626; }","duration":"248.797037ms","start":"2026-04-03T01:33:11.888507Z","end":"2026-04-03T01:33:12.137304Z","steps":["trace[2138971370] 'agreement among raft nodes before linearized reading' (duration: 248.718306ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:12.137443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:11.7812Z","time spent":"356.142439ms","remote":"127.0.0.1:57380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036253,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T01:33:12.200651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.158125ms","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":"info","ts":"2026-04-03T01:33:12.200713Z","caller":"traceutil/trace.go:171","msg":"trace[198724139] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:626; }","duration":"197.241766ms","start":"2026-04-03T01:33:12.003457Z","end":"2026-04-03T01:33:12.200699Z","steps":["trace[198724139] 'agreement among raft nodes before linearized reading' (duration: 197.122925ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:12.200889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.790729ms","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-03T01:33:12.200911Z","caller":"traceutil/trace.go:171","msg":"trace[2120006983] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:626; }","duration":"197.831069ms","start":"2026-04-03T01:33:12.003076Z","end":"2026-04-03T01:33:12.200907Z","steps":["trace[2120006983] 'agreement among raft nodes before linearized reading' (duration: 197.797198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:12.200972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.010089ms","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-03T01:33:12.201023Z","caller":"traceutil/trace.go:171","msg":"trace[748807717] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:626; }","duration":"198.093389ms","start":"2026-04-03T01:33:12.002924Z","end":"2026-04-03T01:33:12.201018Z","steps":["trace[748807717] 'agreement among raft nodes before linearized reading' (duration: 198.035759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:12.201097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.206972ms","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":"warn","ts":"2026-04-03T01:33:12.201097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.112399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-03T01:33:12.201179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.483206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:33:12.201195Z","caller":"traceutil/trace.go:171","msg":"trace[188934707] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:626; }","duration":"256.530667ms","start":"2026-04-03T01:33:11.944658Z","end":"2026-04-03T01:33:12.201189Z","steps":["trace[188934707] 'agreement among raft nodes before linearized reading' (duration: 256.509467ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:33:12.201211Z","caller":"traceutil/trace.go:171","msg":"trace[1547410643] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:626; }","duration":"111.22224ms","start":"2026-04-03T01:33:12.089967Z","end":"2026-04-03T01:33:12.20119Z","steps":["trace[1547410643] 'agreement among raft nodes before linearized reading' (duration: 111.085159ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:12.201288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.937868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:33:12.201308Z","caller":"traceutil/trace.go:171","msg":"trace[1675294843] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:626; }","duration":"256.961238ms","start":"2026-04-03T01:33:11.944342Z","end":"2026-04-03T01:33:12.201303Z","steps":["trace[1675294843] 'agreement among raft nodes before linearized reading' (duration: 256.929878ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:12.201365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.073509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:33:12.201382Z","caller":"traceutil/trace.go:171","msg":"trace[319016810] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:626; }","duration":"257.12279ms","start":"2026-04-03T01:33:11.944256Z","end":"2026-04-03T01:33:12.201379Z","steps":["trace[319016810] 'agreement among raft nodes before linearized reading' (duration: 257.09485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:12.20144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.335828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:33:12.201457Z","caller":"traceutil/trace.go:171","msg":"trace[1547417485] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:626; }","duration":"284.360458ms","start":"2026-04-03T01:33:11.917092Z","end":"2026-04-03T01:33:12.201453Z","steps":["trace[1547417485] 'agreement among raft nodes before linearized reading' (duration: 284.335708ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:12.201534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.60288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:33:12.20155Z","caller":"traceutil/trace.go:171","msg":"trace[447063432] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:626; }","duration":"284.6346ms","start":"2026-04-03T01:33:11.916912Z","end":"2026-04-03T01:33:12.201547Z","steps":["trace[447063432] 'agreement among raft nodes before linearized reading' (duration: 284.61024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:12.200685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.89056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:33:12.201603Z","caller":"traceutil/trace.go:171","msg":"trace[695189048] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:626; }","duration":"176.870676ms","start":"2026-04-03T01:33:12.02471Z","end":"2026-04-03T01:33:12.201581Z","steps":["trace[695189048] 'agreement among raft nodes before linearized reading' (duration: 175.81036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:12.201764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.398707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:33:12.201838Z","caller":"traceutil/trace.go:171","msg":"trace[1045322053] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:626; }","duration":"112.530849ms","start":"2026-04-03T01:33:12.089289Z","end":"2026-04-03T01:33:12.20182Z","steps":["trace[1045322053] 'agreement among raft nodes before linearized reading' (duration: 112.373188ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:12.201867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.067661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:33:12.201893Z","caller":"traceutil/trace.go:171","msg":"trace[1258953310] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:626; }","duration":"176.104751ms","start":"2026-04-03T01:33:12.025781Z","end":"2026-04-03T01:33:12.201886Z","steps":["trace[1258953310] 'agreement among raft nodes before linearized reading' (duration: 176.055511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:12.201982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.668349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:33:12.202002Z","caller":"traceutil/trace.go:171","msg":"trace[390636399] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:626; }","duration":"112.7047ms","start":"2026-04-03T01:33:12.089293Z","end":"2026-04-03T01:33:12.201997Z","steps":["trace[390636399] 'agreement among raft nodes before linearized reading' (duration: 112.67156ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:12.202052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.293018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:33:12.202071Z","caller":"traceutil/trace.go:171","msg":"trace[1292808130] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:626; }","duration":"177.329678ms","start":"2026-04-03T01:33:12.024737Z","end":"2026-04-03T01:33:12.202067Z","steps":["trace[1292808130] 'agreement among raft nodes before linearized reading' (duration: 177.293418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:12.202076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.014474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:33:12.202091Z","caller":"traceutil/trace.go:171","msg":"trace[1213993165] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:626; }","duration":"145.030414ms","start":"2026-04-03T01:33:12.057056Z","end":"2026-04-03T01:33:12.202087Z","steps":["trace[1213993165] 'agreement among raft nodes before linearized reading' (duration: 145.004954ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:33:12.201116Z","caller":"traceutil/trace.go:171","msg":"trace[1818755153] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:626; }","duration":"211.242582ms","start":"2026-04-03T01:33:11.989869Z","end":"2026-04-03T01:33:12.201112Z","steps":["trace[1818755153] 'agreement among raft nodes before linearized reading' (duration: 211.208861ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:12.202247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.391256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:33:12.202265Z","caller":"traceutil/trace.go:171","msg":"trace[478939711] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:626; }","duration":"145.439156ms","start":"2026-04-03T01:33:12.05682Z","end":"2026-04-03T01:33:12.202259Z","steps":["trace[478939711] 'agreement among raft nodes before linearized reading' (duration: 145.407656ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:12.201138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.508883ms","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":"warn","ts":"2026-04-03T01:33:12.20116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.542053ms","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-03T01:33:12.202361Z","caller":"traceutil/trace.go:171","msg":"trace[1934701399] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:626; }","duration":"212.764819ms","start":"2026-04-03T01:33:11.989589Z","end":"2026-04-03T01:33:12.202354Z","steps":["trace[1934701399] 'agreement among raft nodes before linearized reading' (duration: 211.558113ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:33:12.202419Z","caller":"traceutil/trace.go:171","msg":"trace[1364404892] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:626; }","duration":"212.718489ms","start":"2026-04-03T01:33:11.989624Z","end":"2026-04-03T01:33:12.202343Z","steps":["trace[1364404892] 'agreement among raft nodes before linearized reading' (duration: 211.500333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:13.503161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.319667ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-03T01:33:13.503282Z","caller":"traceutil/trace.go:171","msg":"trace[143194269] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"669.773159ms","start":"2026-04-03T01:33:12.833488Z","end":"2026-04-03T01:33:13.503261Z","steps":["trace[143194269] 'read index received' (duration: 280.146161ms)","trace[143194269] 'applied index is now lower than readState.Index' (duration: 389.625568ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:33:13.503441Z","caller":"traceutil/trace.go:171","msg":"trace[1215326628] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"683.436454ms","start":"2026-04-03T01:33:12.819935Z","end":"2026-04-03T01:33:13.503371Z","steps":["trace[1215326628] 'process raft request' (duration: 293.824986ms)","trace[1215326628] 'compare' (duration: 389.159386ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T01:33:13.50348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.98224ms","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":"info","ts":"2026-04-03T01:33:13.503519Z","caller":"traceutil/trace.go:171","msg":"trace[325811640] 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:635; }","duration":"670.043802ms","start":"2026-04-03T01:33:12.833464Z","end":"2026-04-03T01:33:13.503508Z","steps":["trace[325811640] 'agreement among raft nodes before linearized reading' (duration: 669.90737ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:13.503556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:12.833453Z","time spent":"670.093952ms","remote":"127.0.0.1:59782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-04-03T01:33:13.503588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:12.819918Z","time spent":"683.599026ms","remote":"127.0.0.1:57810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T01:33:13.503758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.189893ms","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-03T01:33:13.50383Z","caller":"traceutil/trace.go:171","msg":"trace[952429609] 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:635; }","duration":"670.298583ms","start":"2026-04-03T01:33:12.833515Z","end":"2026-04-03T01:33:13.503813Z","steps":["trace[952429609] 'agreement among raft nodes before linearized reading' (duration: 670.172542ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:13.503852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.35838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-03T01:33:13.503875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:12.833502Z","time spent":"670.363813ms","remote":"127.0.0.1:59782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"info","ts":"2026-04-03T01:33:13.503907Z","caller":"traceutil/trace.go:171","msg":"trace[1743588017] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"614.495481ms","start":"2026-04-03T01:33:12.889396Z","end":"2026-04-03T01:33:13.503892Z","steps":["trace[1743588017] 'agreement among raft nodes before linearized reading' (duration: 614.391771ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:13.50393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:12.889378Z","time spent":"614.547951ms","remote":"127.0.0.1:57264","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-03T01:33:13.503991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.999491ms","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":"info","ts":"2026-04-03T01:33:13.50412Z","caller":"traceutil/trace.go:171","msg":"trace[801836061] 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:635; }","duration":"670.177732ms","start":"2026-04-03T01:33:12.833914Z","end":"2026-04-03T01:33:13.504092Z","steps":["trace[801836061] 'agreement among raft nodes before linearized reading' (duration: 669.897211ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:13.50419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:12.833821Z","time spent":"670.350464ms","remote":"127.0.0.1:59782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"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-03T01:33:14.876006Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581741167008768599,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-03T01:33:15.376804Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581741167008768599,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-03T01:33:15.528532Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.91349609s","expected-duration":"1s"} {"level":"info","ts":"2026-04-03T01:33:15.529896Z","caller":"traceutil/trace.go:171","msg":"trace[1313961866] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"1.915122978s","start":"2026-04-03T01:33:13.614727Z","end":"2026-04-03T01:33:15.52985Z","steps":["trace[1313961866] 'process raft request' (duration: 1.913966682s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:15.5301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:13.614691Z","time spent":"1.915288769s","remote":"127.0.0.1:57470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T01:33:15.848243Z","caller":"traceutil/trace.go:171","msg":"trace[991942019] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:660; }","duration":"1.473196603s","start":"2026-04-03T01:33:14.374995Z","end":"2026-04-03T01:33:15.848192Z","steps":["trace[991942019] 'read index received' (duration: 1.154007285s)","trace[991942019] 'applied index is now lower than readState.Index' (duration: 319.188338ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T01:33:15.848866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.473833217s","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-03T01:33:15.849005Z","caller":"traceutil/trace.go:171","msg":"trace[1800194264] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:638; }","duration":"1.474027829s","start":"2026-04-03T01:33:14.374946Z","end":"2026-04-03T01:33:15.848974Z","steps":["trace[1800194264] 'agreement among raft nodes before linearized reading' (duration: 1.473604006s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:15.84905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:14.374923Z","time spent":"1.474118019s","remote":"127.0.0.1:57574","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-03T01:33:15.84916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.438658659s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-03T01:33:15.849212Z","caller":"traceutil/trace.go:171","msg":"trace[755629095] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:638; }","duration":"1.4387474s","start":"2026-04-03T01:33:14.41045Z","end":"2026-04-03T01:33:15.849197Z","steps":["trace[755629095] 'agreement among raft nodes before linearized reading' (duration: 1.438577069s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:15.849247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:14.410439Z","time spent":"1.43880084s","remote":"127.0.0.1:57574","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-03T01:33:15.849419Z","caller":"traceutil/trace.go:171","msg":"trace[225563780] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"1.869666453s","start":"2026-04-03T01:33:13.979676Z","end":"2026-04-03T01:33:15.849342Z","steps":["trace[225563780] 'process raft request' (duration: 1.861179787s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:15.849501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.107591ms","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-03T01:33:15.849583Z","caller":"traceutil/trace.go:171","msg":"trace[449125198] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:638; }","duration":"245.226252ms","start":"2026-04-03T01:33:15.604327Z","end":"2026-04-03T01:33:15.849554Z","steps":["trace[449125198] 'agreement among raft nodes before linearized reading' (duration: 245.014161ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:15.849616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:13.979648Z","time spent":"1.869872824s","remote":"127.0.0.1:57380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T01:33:15.849774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"961.762049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:33:15.849818Z","caller":"traceutil/trace.go:171","msg":"trace[501225000] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"961.837349ms","start":"2026-04-03T01:33:14.887971Z","end":"2026-04-03T01:33:15.849808Z","steps":["trace[501225000] 'agreement among raft nodes before linearized reading' (duration: 961.758798ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:15.849847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:14.887955Z","time spent":"961.886529ms","remote":"127.0.0.1:57264","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-03T01:33:15.850204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.420359461s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-03T01:33:15.850408Z","caller":"traceutil/trace.go:171","msg":"trace[161057096] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:638; }","duration":"1.420580032s","start":"2026-04-03T01:33:14.429806Z","end":"2026-04-03T01:33:15.850386Z","steps":["trace[161057096] 'agreement among raft nodes before linearized reading' (duration: 1.419900647s)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:15.850696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:14.42978Z","time spent":"1.420904283s","remote":"127.0.0.1:57574","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-03T01:33:17.070506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.012714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:33:17.07059Z","caller":"traceutil/trace.go:171","msg":"trace[882437735] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:653; }","duration":"181.166016ms","start":"2026-04-03T01:33:16.889404Z","end":"2026-04-03T01:33:17.07057Z","steps":["trace[882437735] 'range keys from in-memory index tree' (duration: 180.877274ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:33:20.863713Z","caller":"traceutil/trace.go:171","msg":"trace[1977402255] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"122.315296ms","start":"2026-04-03T01:33:20.741372Z","end":"2026-04-03T01:33:20.863687Z","steps":["trace[1977402255] 'process raft request' (duration: 122.139165ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:32.389749Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4581741167008768920,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-03T01:33:32.414851Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.00023827s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-03T01:33:32.546732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.491596ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-03T01:33:32.547835Z","caller":"traceutil/trace.go:171","msg":"trace[1415180499] linearizableReadLoop","detail":"{readStateIndex:834; appliedIndex:832; }","duration":"658.476108ms","start":"2026-04-03T01:33:31.889337Z","end":"2026-04-03T01:33:32.547814Z","steps":["trace[1415180499] 'read index received' (duration: 525.751976ms)","trace[1415180499] 'applied index is now lower than readState.Index' (duration: 132.723202ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T01:33:32.547968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.624109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:33:32.547921Z","caller":"traceutil/trace.go:171","msg":"trace[1957754723] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"893.315028ms","start":"2026-04-03T01:33:31.65455Z","end":"2026-04-03T01:33:32.547865Z","steps":["trace[1957754723] 'process raft request' (duration: 893.126576ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:33:32.548011Z","caller":"traceutil/trace.go:171","msg":"trace[998136110] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:803; }","duration":"658.7266ms","start":"2026-04-03T01:33:31.889272Z","end":"2026-04-03T01:33:32.547999Z","steps":["trace[998136110] 'agreement among raft nodes before linearized reading' (duration: 658.653539ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:32.548044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:31.889247Z","time spent":"658.79132ms","remote":"127.0.0.1:57264","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-03T01:33:32.548209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:31.654509Z","time spent":"893.515969ms","remote":"127.0.0.1:57542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T01:33:32.548238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.726044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-03T01:33:32.548234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.394868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-03T01:33:32.548332Z","caller":"traceutil/trace.go:171","msg":"trace[2093484352] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:803; }","duration":"622.856614ms","start":"2026-04-03T01:33:31.925448Z","end":"2026-04-03T01:33:32.548305Z","steps":["trace[2093484352] 'agreement among raft nodes before linearized reading' (duration: 622.571903ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:33:32.548347Z","caller":"traceutil/trace.go:171","msg":"trace[130098372] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:803; }","duration":"625.574568ms","start":"2026-04-03T01:33:31.922758Z","end":"2026-04-03T01:33:32.548333Z","steps":["trace[130098372] 'agreement among raft nodes before linearized reading' (duration: 625.214087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:32.548338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.408397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-03T01:33:32.548407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:31.925439Z","time spent":"622.954954ms","remote":"127.0.0.1:57574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-03T01:33:32.548432Z","caller":"traceutil/trace.go:171","msg":"trace[1950343059] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:803; }","duration":"623.567398ms","start":"2026-04-03T01:33:31.924844Z","end":"2026-04-03T01:33:32.548412Z","steps":["trace[1950343059] 'agreement among raft nodes before linearized reading' (duration: 623.301496ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:32.548517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:31.924811Z","time spent":"623.695268ms","remote":"127.0.0.1:57574","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-03T01:33:32.548652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.143554ms","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-03T01:33:32.54885Z","caller":"traceutil/trace.go:171","msg":"trace[580618425] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:803; }","duration":"615.243224ms","start":"2026-04-03T01:33:31.933472Z","end":"2026-04-03T01:33:32.548715Z","steps":["trace[580618425] 'agreement among raft nodes before linearized reading' (duration: 614.745702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:32.549025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:31.933462Z","time spent":"615.421746ms","remote":"127.0.0.1:57574","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-03T01:33:32.549624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:33:31.922713Z","time spent":"625.686308ms","remote":"127.0.0.1:57574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-03T01:33:35.843506Z","caller":"traceutil/trace.go:171","msg":"trace[90498049] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"173.895349ms","start":"2026-04-03T01:33:35.669587Z","end":"2026-04-03T01:33:35.843482Z","steps":["trace[90498049] 'process raft request' (duration: 173.723129ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:33:36.003603Z","caller":"traceutil/trace.go:171","msg":"trace[1643273192] linearizableReadLoop","detail":"{readStateIndex:850; appliedIndex:849; }","duration":"108.131544ms","start":"2026-04-03T01:33:35.895447Z","end":"2026-04-03T01:33:36.003579Z","steps":["trace[1643273192] 'read index received' (duration: 105.901422ms)","trace[1643273192] 'applied index is now lower than readState.Index' (duration: 2.229052ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:33:36.003679Z","caller":"traceutil/trace.go:171","msg":"trace[314164666] transaction","detail":"{read_only:false; response_revision:819; number_of_response:1; }","duration":"150.932843ms","start":"2026-04-03T01:33:35.852715Z","end":"2026-04-03T01:33:36.003648Z","steps":["trace[314164666] 'process raft request' (duration: 148.64504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:33:36.003731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.258745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:33:36.003766Z","caller":"traceutil/trace.go:171","msg":"trace[107170036] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:819; }","duration":"108.314395ms","start":"2026-04-03T01:33:35.895441Z","end":"2026-04-03T01:33:36.003755Z","steps":["trace[107170036] 'agreement among raft nodes before linearized reading' (duration: 108.232885ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:34:16.927997Z","caller":"traceutil/trace.go:171","msg":"trace[678361436] linearizableReadLoop","detail":"{readStateIndex:1122; appliedIndex:1121; }","duration":"114.196063ms","start":"2026-04-03T01:34:16.813785Z","end":"2026-04-03T01:34:16.927981Z","steps":["trace[678361436] 'read index received' (duration: 91.454101ms)","trace[678361436] 'applied index is now lower than readState.Index' (duration: 22.741312ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:34:16.928045Z","caller":"traceutil/trace.go:171","msg":"trace[989220601] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"115.054396ms","start":"2026-04-03T01:34:16.812964Z","end":"2026-04-03T01:34:16.928018Z","steps":["trace[989220601] 'process raft request' (duration: 114.930195ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:34:16.928221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.406874ms","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-03T01:34:16.928254Z","caller":"traceutil/trace.go:171","msg":"trace[1596629693] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1081; }","duration":"114.485724ms","start":"2026-04-03T01:34:16.813761Z","end":"2026-04-03T01:34:16.928247Z","steps":["trace[1596629693] 'agreement among raft nodes before linearized reading' (duration: 114.328613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:34:16.928332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.668989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-03T01:34:16.928411Z","caller":"traceutil/trace.go:171","msg":"trace[457194496] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1081; }","duration":"113.76757ms","start":"2026-04-03T01:34:16.814625Z","end":"2026-04-03T01:34:16.928393Z","steps":["trace[457194496] 'agreement among raft nodes before linearized reading' (duration: 113.541419ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:35:16.221868Z","caller":"traceutil/trace.go:171","msg":"trace[1716256273] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"223.825568ms","start":"2026-04-03T01:35:15.997986Z","end":"2026-04-03T01:35:16.221812Z","steps":["trace[1716256273] 'process raft request' (duration: 223.669457ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:35:16.624749Z","caller":"traceutil/trace.go:171","msg":"trace[1681854823] linearizableReadLoop","detail":"{readStateIndex:1367; appliedIndex:1366; }","duration":"113.393942ms","start":"2026-04-03T01:35:16.511324Z","end":"2026-04-03T01:35:16.624718Z","steps":["trace[1681854823] 'read index received' (duration: 22.407639ms)","trace[1681854823] 'applied index is now lower than readState.Index' (duration: 90.984502ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:35:16.624768Z","caller":"traceutil/trace.go:171","msg":"trace[251668405] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"138.225893ms","start":"2026-04-03T01:35:16.486508Z","end":"2026-04-03T01:35:16.624734Z","steps":["trace[251668405] 'process raft request' (duration: 47.20985ms)","trace[251668405] 'compare' (duration: 90.717891ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T01:35:16.625009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.664453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:35:16.625048Z","caller":"traceutil/trace.go:171","msg":"trace[478873463] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1312; }","duration":"113.783213ms","start":"2026-04-03T01:35:16.511252Z","end":"2026-04-03T01:35:16.625035Z","steps":["trace[478873463] 'agreement among raft nodes before linearized reading' (duration: 113.611212ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:35:17.590287Z","caller":"traceutil/trace.go:171","msg":"trace[951203175] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"151.180135ms","start":"2026-04-03T01:35:17.439072Z","end":"2026-04-03T01:35:17.590252Z","steps":["trace[951203175] 'process raft request' (duration: 147.037215ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:35:17.59049Z","caller":"traceutil/trace.go:171","msg":"trace[587576000] linearizableReadLoop","detail":"{readStateIndex:1373; appliedIndex:1371; }","duration":"120.393606ms","start":"2026-04-03T01:35:17.470026Z","end":"2026-04-03T01:35:17.59042Z","steps":["trace[587576000] 'read index received' (duration: 116.183215ms)","trace[587576000] 'applied index is now lower than readState.Index' (duration: 4.209501ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T01:35:17.590588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.532746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:35:17.590581Z","caller":"traceutil/trace.go:171","msg":"trace[1273444842] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"151.266365ms","start":"2026-04-03T01:35:17.439225Z","end":"2026-04-03T01:35:17.590491Z","steps":["trace[1273444842] 'process raft request' (duration: 151.123724ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:35:17.590674Z","caller":"traceutil/trace.go:171","msg":"trace[1341947401] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1318; }","duration":"120.654377ms","start":"2026-04-03T01:35:17.47Z","end":"2026-04-03T01:35:17.590655Z","steps":["trace[1341947401] 'agreement among raft nodes before linearized reading' (duration: 120.528536ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:35:21.812966Z","caller":"traceutil/trace.go:171","msg":"trace[2056904086] linearizableReadLoop","detail":"{readStateIndex:1384; appliedIndex:1383; }","duration":"362.731673ms","start":"2026-04-03T01:35:21.450213Z","end":"2026-04-03T01:35:21.812945Z","steps":["trace[2056904086] 'read index received' (duration: 362.524252ms)","trace[2056904086] 'applied index is now lower than readState.Index' (duration: 206.671µs)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:35:21.813063Z","caller":"traceutil/trace.go:171","msg":"trace[718679806] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"454.181418ms","start":"2026-04-03T01:35:21.358871Z","end":"2026-04-03T01:35:21.813053Z","steps":["trace[718679806] 'process raft request' (duration: 453.936607ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:35:21.813185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:35:21.358848Z","time spent":"454.255298ms","remote":"127.0.0.1:57574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T01:35:21.813279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.043085ms","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-03T01:35:21.813363Z","caller":"traceutil/trace.go:171","msg":"trace[700115347] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1329; }","duration":"363.164345ms","start":"2026-04-03T01:35:21.45018Z","end":"2026-04-03T01:35:21.813344Z","steps":["trace[700115347] 'agreement among raft nodes before linearized reading' (duration: 362.894704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:35:21.813412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:35:21.450168Z","time spent":"363.235105ms","remote":"127.0.0.1:57574","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":"info","ts":"2026-04-03T01:35:21.874783Z","caller":"traceutil/trace.go:171","msg":"trace[1960195593] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"347.940771ms","start":"2026-04-03T01:35:21.526821Z","end":"2026-04-03T01:35:21.874761Z","steps":["trace[1960195593] 'process raft request' (duration: 347.74674ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:35:21.874903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:35:21.526795Z","time spent":"348.043702ms","remote":"127.0.0.1:57574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T01:35:21.885999Z","caller":"traceutil/trace.go:171","msg":"trace[1688989411] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"205.021817ms","start":"2026-04-03T01:35:21.680961Z","end":"2026-04-03T01:35:21.885983Z","steps":["trace[1688989411] 'process raft request' (duration: 204.937367ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:35:21.886008Z","caller":"traceutil/trace.go:171","msg":"trace[243334922] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"319.662994ms","start":"2026-04-03T01:35:21.566304Z","end":"2026-04-03T01:35:21.885967Z","steps":["trace[243334922] 'process raft request' (duration: 319.494723ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:35:21.886141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.83822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-03T01:35:21.886174Z","caller":"traceutil/trace.go:171","msg":"trace[878843066] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1333; }","duration":"281.91085ms","start":"2026-04-03T01:35:21.604253Z","end":"2026-04-03T01:35:21.886164Z","steps":["trace[878843066] 'agreement among raft nodes before linearized reading' (duration: 281.802529ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:35:21.88644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.158841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-03T01:35:21.886542Z","caller":"traceutil/trace.go:171","msg":"trace[771623308] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1333; }","duration":"282.258041ms","start":"2026-04-03T01:35:21.604262Z","end":"2026-04-03T01:35:21.88652Z","steps":["trace[771623308] 'agreement among raft nodes before linearized reading' (duration: 281.99545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:35:21.886805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:35:21.566279Z","time spent":"319.811846ms","remote":"127.0.0.1:57574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}