{"level":"warn","ts":"2026-04-08T01:16:16.882274Z","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-08T01:16:16.882404Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.141: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.141:2380","--initial-cluster=instance=https://199.204.45.141:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.141:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.141: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-08T01:16:16.882502Z","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-08T01:16:16.88252Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-04-08T01:16:16.882554Z","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-08T01:16:16.883474Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"]} {"level":"info","ts":"2026-04-08T01:16:16.883812Z","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.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.141: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-08T01:16:17.042023Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"157.764578ms"} {"level":"info","ts":"2026-04-08T01:16:17.204412Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9ef3b4f68930dc2","cluster-id":"b19a5957e6e65747"} {"level":"info","ts":"2026-04-08T01:16:17.204539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T01:16:17.204581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 0"} {"level":"info","ts":"2026-04-08T01:16:17.204667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9ef3b4f68930dc2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T01:16:17.204723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 1"} {"level":"info","ts":"2026-04-08T01:16:17.204806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"warn","ts":"2026-04-08T01:16:17.207594Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T01:16:17.209178Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T01:16:17.210384Z","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-08T01:16:17.214064Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9ef3b4f68930dc2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T01:16:17.220569Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9ef3b4f68930dc2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T01:16:17.232751Z","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-08T01:16:17.23284Z","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-08T01:16:17.232872Z","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-08T01:16:17.233415Z","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-08T01:16:17.233561Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-04-08T01:16:17.233589Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-04-08T01:16:17.233834Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9ef3b4f68930dc2","initial-advertise-peer-urls":["https://199.204.45.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T01:16:17.23387Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T01:16:17.240905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"info","ts":"2026-04-08T01:16:17.241059Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","added-peer-id":"9ef3b4f68930dc2","added-peer-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-04-08T01:16:17.305374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T01:16:17.305463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T01:16:17.305563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgPreVoteResp from 9ef3b4f68930dc2 at term 1"} {"level":"info","ts":"2026-04-08T01:16:17.305649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became candidate at term 2"} {"level":"info","ts":"2026-04-08T01:16:17.305757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgVoteResp from 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-04-08T01:16:17.305931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became leader at term 2"} {"level":"info","ts":"2026-04-08T01:16:17.305955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9ef3b4f68930dc2 elected leader 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-04-08T01:16:17.308169Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9ef3b4f68930dc2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.141:2379]}","request-path":"/0/members/9ef3b4f68930dc2/attributes","cluster-id":"b19a5957e6e65747","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T01:16:17.308371Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T01:16:17.308504Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T01:16:17.30851Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T01:16:17.308848Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T01:16:17.308918Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T01:16:17.309439Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T01:16:17.309551Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T01:16:17.309587Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T01:16:17.310149Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T01:16:17.312805Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.141:2379"} {"level":"info","ts":"2026-04-08T01:16:20.141876Z","caller":"traceutil/trace.go:171","msg":"trace[755671835] transaction","detail":"{read_only:false; response_revision:83; number_of_response:1; }","duration":"168.902505ms","start":"2026-04-08T01:16:19.972946Z","end":"2026-04-08T01:16:20.141849Z","steps":["trace[755671835] 'process raft request' (duration: 87.89067ms)","trace[755671835] 'compare' (duration: 80.872634ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:16:22.003471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.791254ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:16:22.003738Z","caller":"traceutil/trace.go:171","msg":"trace[208822267] transaction","detail":"{read_only:false; response_revision:148; number_of_response:1; }","duration":"157.026404ms","start":"2026-04-08T01:16:21.846677Z","end":"2026-04-08T01:16:22.003703Z","steps":["trace[208822267] 'process raft request' (duration: 51.419051ms)","trace[208822267] 'compare' (duration: 104.605652ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:22.003843Z","caller":"traceutil/trace.go:171","msg":"trace[984842371] transaction","detail":"{read_only:false; response_revision:149; number_of_response:1; }","duration":"155.822822ms","start":"2026-04-08T01:16:21.847974Z","end":"2026-04-08T01:16:22.003797Z","steps":["trace[984842371] 'process raft request' (duration: 155.62011ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:22.179042Z","caller":"traceutil/trace.go:171","msg":"trace[917081657] transaction","detail":"{read_only:false; response_revision:155; number_of_response:1; }","duration":"114.245102ms","start":"2026-04-08T01:16:22.06477Z","end":"2026-04-08T01:16:22.179015Z","steps":["trace[917081657] 'process raft request' (duration: 114.174501ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:22.179074Z","caller":"traceutil/trace.go:171","msg":"trace[382647580] transaction","detail":"{read_only:false; response_revision:154; number_of_response:1; }","duration":"114.728006ms","start":"2026-04-08T01:16:22.064319Z","end":"2026-04-08T01:16:22.179047Z","steps":["trace[382647580] 'process raft request' (duration: 39.883779ms)","trace[382647580] 'compare' (duration: 74.582754ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:23.287026Z","caller":"traceutil/trace.go:171","msg":"trace[1633114027] transaction","detail":"{read_only:false; response_revision:232; number_of_response:1; }","duration":"100.561322ms","start":"2026-04-08T01:16:23.186433Z","end":"2026-04-08T01:16:23.286995Z","steps":["trace[1633114027] 'process raft request' (duration: 37.3737ms)","trace[1633114027] 'compare' (duration: 63.076051ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:23.457722Z","caller":"traceutil/trace.go:171","msg":"trace[834257927] transaction","detail":"{read_only:false; response_revision:233; number_of_response:1; }","duration":"163.664493ms","start":"2026-04-08T01:16:23.29402Z","end":"2026-04-08T01:16:23.457684Z","steps":["trace[834257927] 'process raft request' (duration: 147.313827ms)","trace[834257927] 'compare' (duration: 16.142874ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:16:23.818362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.936257ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:16:23.818492Z","caller":"traceutil/trace.go:171","msg":"trace[1789460784] transaction","detail":"{read_only:false; response_revision:239; number_of_response:1; }","duration":"191.708178ms","start":"2026-04-08T01:16:23.626761Z","end":"2026-04-08T01:16:23.818469Z","steps":["trace[1789460784] 'process raft request' (duration: 81.563689ms)","trace[1789460784] 'compare' (duration: 109.765696ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:23.824511Z","caller":"traceutil/trace.go:171","msg":"trace[706534468] transaction","detail":"{read_only:false; response_revision:240; number_of_response:1; }","duration":"130.652608ms","start":"2026-04-08T01:16:23.693819Z","end":"2026-04-08T01:16:23.824472Z","steps":["trace[706534468] 'process raft request' (duration: 130.401546ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:24.013406Z","caller":"traceutil/trace.go:171","msg":"trace[1849741800] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"115.636124ms","start":"2026-04-08T01:16:23.897716Z","end":"2026-04-08T01:16:24.013353Z","steps":["trace[1849741800] 'process raft request' (duration: 22.69273ms)","trace[1849741800] 'compare' (duration: 92.735402ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:24.193589Z","caller":"traceutil/trace.go:171","msg":"trace[933195734] transaction","detail":"{read_only:false; response_revision:245; number_of_response:1; }","duration":"103.684825ms","start":"2026-04-08T01:16:24.089874Z","end":"2026-04-08T01:16:24.193559Z","steps":["trace[933195734] 'process raft request' (duration: 45.65087ms)","trace[933195734] 'compare' (duration: 57.895944ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:24.197333Z","caller":"traceutil/trace.go:171","msg":"trace[1609980512] transaction","detail":"{read_only:false; response_revision:246; number_of_response:1; }","duration":"104.558494ms","start":"2026-04-08T01:16:24.092749Z","end":"2026-04-08T01:16:24.197307Z","steps":["trace[1609980512] 'process raft request' (duration: 104.392942ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:24.515481Z","caller":"traceutil/trace.go:171","msg":"trace[581635469] transaction","detail":"{read_only:false; response_revision:254; number_of_response:1; }","duration":"169.295226ms","start":"2026-04-08T01:16:24.346152Z","end":"2026-04-08T01:16:24.515447Z","steps":["trace[581635469] 'process raft request' (duration: 141.90764ms)","trace[581635469] 'compare' (duration: 27.260385ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:16:26.079657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.921343ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:16:26.079893Z","caller":"traceutil/trace.go:171","msg":"trace[1998139890] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"131.036324ms","start":"2026-04-08T01:16:25.9488Z","end":"2026-04-08T01:16:26.079836Z","steps":["trace[1998139890] 'process raft request' (duration: 23.872009ms)","trace[1998139890] 'compare' (duration: 106.789002ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:26.309702Z","caller":"traceutil/trace.go:171","msg":"trace[965503788] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"201.189665ms","start":"2026-04-08T01:16:26.108487Z","end":"2026-04-08T01:16:26.309677Z","steps":["trace[965503788] 'process raft request' (duration: 201.141165ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:26.309821Z","caller":"traceutil/trace.go:171","msg":"trace[850417436] linearizableReadLoop","detail":"{readStateIndex:289; appliedIndex:287; }","duration":"211.171903ms","start":"2026-04-08T01:16:26.098611Z","end":"2026-04-08T01:16:26.309783Z","steps":["trace[850417436] 'read index received' (duration: 6.13814ms)","trace[850417436] 'applied index is now lower than readState.Index' (duration: 205.026513ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:26.309715Z","caller":"traceutil/trace.go:171","msg":"trace[337650458] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"213.742589ms","start":"2026-04-08T01:16:26.095948Z","end":"2026-04-08T01:16:26.309691Z","steps":["trace[337650458] 'process raft request' (duration: 129.402983ms)","trace[337650458] 'compare' (duration: 84.138784ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:16:26.309998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.347975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"} {"level":"warn","ts":"2026-04-08T01:16:26.310058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.376915ms","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-08T01:16:26.310127Z","caller":"traceutil/trace.go:171","msg":"trace[845833972] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:284; }","duration":"107.467935ms","start":"2026-04-08T01:16:26.20264Z","end":"2026-04-08T01:16:26.310108Z","steps":["trace[845833972] 'agreement among raft nodes before linearized reading' (duration: 107.313564ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:26.310064Z","caller":"traceutil/trace.go:171","msg":"trace[314017950] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:284; }","duration":"211.468477ms","start":"2026-04-08T01:16:26.098577Z","end":"2026-04-08T01:16:26.310046Z","steps":["trace[314017950] 'agreement among raft nodes before linearized reading' (duration: 211.308265ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:26.554298Z","caller":"traceutil/trace.go:171","msg":"trace[2109995120] linearizableReadLoop","detail":"{readStateIndex:292; appliedIndex:291; }","duration":"238.974669ms","start":"2026-04-08T01:16:26.315297Z","end":"2026-04-08T01:16:26.554272Z","steps":["trace[2109995120] 'read index received' (duration: 69.58539ms)","trace[2109995120] 'applied index is now lower than readState.Index' (duration: 169.388069ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:26.554422Z","caller":"traceutil/trace.go:171","msg":"trace[79404615] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"226.325033ms","start":"2026-04-08T01:16:26.328078Z","end":"2026-04-08T01:16:26.554403Z","steps":["trace[79404615] 'process raft request' (duration: 226.143241ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:26.554557Z","caller":"traceutil/trace.go:171","msg":"trace[1483995198] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"239.523154ms","start":"2026-04-08T01:16:26.315005Z","end":"2026-04-08T01:16:26.554528Z","steps":["trace[1483995198] 'process raft request' (duration: 205.232185ms)","trace[1483995198] 'compare' (duration: 33.851545ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:16:26.554589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.267842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-08T01:16:26.554755Z","caller":"traceutil/trace.go:171","msg":"trace[1032075187] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:287; }","duration":"239.465984ms","start":"2026-04-08T01:16:26.315271Z","end":"2026-04-08T01:16:26.554737Z","steps":["trace[1032075187] 'agreement among raft nodes before linearized reading' (duration: 239.185601ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:26.573124Z","caller":"traceutil/trace.go:171","msg":"trace[1517186523] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"183.208787ms","start":"2026-04-08T01:16:26.389893Z","end":"2026-04-08T01:16:26.573101Z","steps":["trace[1517186523] 'process raft request' (duration: 183.096856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:26.715751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.339503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-08T01:16:26.715774Z","caller":"traceutil/trace.go:171","msg":"trace[730359131] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"110.595326ms","start":"2026-04-08T01:16:26.605151Z","end":"2026-04-08T01:16:26.715746Z","steps":["trace[730359131] 'process raft request' (duration: 83.338986ms)","trace[730359131] 'compare' (duration: 27.091758ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:26.715824Z","caller":"traceutil/trace.go:171","msg":"trace[606850019] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/disruption-controller; range_end:; response_count:1; response_revision:291; }","duration":"116.445804ms","start":"2026-04-08T01:16:26.599361Z","end":"2026-04-08T01:16:26.715807Z","steps":["trace[606850019] 'agreement among raft nodes before linearized reading' (duration: 116.321592ms)"],"step_count":1} 2026/04/08 01:16:26 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-08T01:16:27.02714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.840562ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:16:27.036621Z","caller":"traceutil/trace.go:171","msg":"trace[555958999] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"306.677817ms","start":"2026-04-08T01:16:26.729921Z","end":"2026-04-08T01:16:27.036599Z","steps":["trace[555958999] 'process raft request' (duration: 306.559996ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:27.03674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:26.729896Z","time spent":"306.788628ms","remote":"127.0.0.1:58714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T01:16:27.276057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.009256ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:16:27.276284Z","caller":"traceutil/trace.go:171","msg":"trace[458577336] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"147.122517ms","start":"2026-04-08T01:16:27.129145Z","end":"2026-04-08T01:16:27.276267Z","steps":["trace[458577336] 'process raft request' (duration: 147.081936ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:27.276254Z","caller":"traceutil/trace.go:171","msg":"trace[318557045] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"165.974882ms","start":"2026-04-08T01:16:27.110239Z","end":"2026-04-08T01:16:27.276214Z","steps":["trace[318557045] 'process raft request' (duration: 19.732744ms)","trace[318557045] 'compare' (duration: 145.869365ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:27.276376Z","caller":"traceutil/trace.go:171","msg":"trace[605967963] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"147.634902ms","start":"2026-04-08T01:16:27.128678Z","end":"2026-04-08T01:16:27.276312Z","steps":["trace[605967963] 'process raft request' (duration: 147.498811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:27.276525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.569098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:16:27.276563Z","caller":"traceutil/trace.go:171","msg":"trace[1121248053] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:301; }","duration":"166.625169ms","start":"2026-04-08T01:16:27.109928Z","end":"2026-04-08T01:16:27.276553Z","steps":["trace[1121248053] 'agreement among raft nodes before linearized reading' (duration: 166.533728ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:27.276511Z","caller":"traceutil/trace.go:171","msg":"trace[1329238979] linearizableReadLoop","detail":"{readStateIndex:305; appliedIndex:304; }","duration":"150.822184ms","start":"2026-04-08T01:16:27.125632Z","end":"2026-04-08T01:16:27.276454Z","steps":["trace[1329238979] 'read index received' (duration: 4.347883ms)","trace[1329238979] 'applied index is now lower than readState.Index' (duration: 146.470771ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:16:27.276641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.73946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-04-08T01:16:27.2767Z","caller":"traceutil/trace.go:171","msg":"trace[1520595278] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:301; }","duration":"168.838881ms","start":"2026-04-08T01:16:27.107843Z","end":"2026-04-08T01:16:27.276682Z","steps":["trace[1520595278] 'agreement among raft nodes before linearized reading' (duration: 168.70779ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:27.324992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.29567ms","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-08T01:16:27.325068Z","caller":"traceutil/trace.go:171","msg":"trace[733489764] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:303; }","duration":"139.425722ms","start":"2026-04-08T01:16:27.185626Z","end":"2026-04-08T01:16:27.325052Z","steps":["trace[733489764] 'agreement among raft nodes before linearized reading' (duration: 139.279241ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:27.568809Z","caller":"traceutil/trace.go:171","msg":"trace[1981265472] linearizableReadLoop","detail":"{readStateIndex:321; appliedIndex:319; }","duration":"213.609922ms","start":"2026-04-08T01:16:27.355176Z","end":"2026-04-08T01:16:27.568786Z","steps":["trace[1981265472] 'read index received' (duration: 200.019348ms)","trace[1981265472] 'applied index is now lower than readState.Index' (duration: 13.589564ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:27.568915Z","caller":"traceutil/trace.go:171","msg":"trace[9398102] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"231.017472ms","start":"2026-04-08T01:16:27.337858Z","end":"2026-04-08T01:16:27.568876Z","steps":["trace[9398102] 'process raft request' (duration: 230.866291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:27.568959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.766043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-04-08T01:16:27.569011Z","caller":"traceutil/trace.go:171","msg":"trace[1974443626] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:309; }","duration":"213.855764ms","start":"2026-04-08T01:16:27.355137Z","end":"2026-04-08T01:16:27.568993Z","steps":["trace[1974443626] 'agreement among raft nodes before linearized reading' (duration: 213.759513ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:27.569074Z","caller":"traceutil/trace.go:171","msg":"trace[1760726194] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"234.065362ms","start":"2026-04-08T01:16:27.334971Z","end":"2026-04-08T01:16:27.569037Z","steps":["trace[1760726194] 'process raft request' (duration: 220.207416ms)","trace[1760726194] 'compare' (duration: 13.392221ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:16:27.624218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.650933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:16:27.624275Z","caller":"traceutil/trace.go:171","msg":"trace[567738694] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:310; }","duration":"141.756484ms","start":"2026-04-08T01:16:27.482506Z","end":"2026-04-08T01:16:27.624262Z","steps":["trace[567738694] 'agreement among raft nodes before linearized reading' (duration: 141.645703ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:27.624666Z","caller":"traceutil/trace.go:171","msg":"trace[635098775] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"268.657463ms","start":"2026-04-08T01:16:27.355483Z","end":"2026-04-08T01:16:27.624141Z","steps":["trace[635098775] 'process raft request' (duration: 268.502141ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:27.798737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.151555ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:16:27.798925Z","caller":"traceutil/trace.go:171","msg":"trace[1821206517] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"134.352901ms","start":"2026-04-08T01:16:27.664555Z","end":"2026-04-08T01:16:27.798908Z","steps":["trace[1821206517] 'process raft request' (duration: 134.299401ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:27.798936Z","caller":"traceutil/trace.go:171","msg":"trace[1166758060] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"160.817302ms","start":"2026-04-08T01:16:27.638074Z","end":"2026-04-08T01:16:27.798892Z","steps":["trace[1166758060] 'process raft request' (duration: 55.426295ms)","trace[1166758060] 'compare' (duration: 104.986603ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:27.799455Z","caller":"traceutil/trace.go:171","msg":"trace[1570019041] linearizableReadLoop","detail":"{readStateIndex:327; appliedIndex:326; }","duration":"139.579983ms","start":"2026-04-08T01:16:27.659852Z","end":"2026-04-08T01:16:27.799432Z","steps":["trace[1570019041] 'read index received' (duration: 33.662302ms)","trace[1570019041] 'applied index is now lower than readState.Index' (duration: 105.915411ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:16:27.799707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.152225ms","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-08T01:16:27.79975Z","caller":"traceutil/trace.go:171","msg":"trace[1276654379] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:316; }","duration":"162.225075ms","start":"2026-04-08T01:16:27.637513Z","end":"2026-04-08T01:16:27.799738Z","steps":["trace[1276654379] 'agreement among raft nodes before linearized reading' (duration: 162.035853ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:27.799733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.594864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-08T01:16:27.799885Z","caller":"traceutil/trace.go:171","msg":"trace[1345809582] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:316; }","duration":"137.791475ms","start":"2026-04-08T01:16:27.662055Z","end":"2026-04-08T01:16:27.799846Z","steps":["trace[1345809582] 'agreement among raft nodes before linearized reading' (duration: 137.530013ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:28.000526Z","caller":"traceutil/trace.go:171","msg":"trace[2116019364] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"102.410527ms","start":"2026-04-08T01:16:27.898091Z","end":"2026-04-08T01:16:28.000501Z","steps":["trace[2116019364] 'process raft request' (duration: 14.581163ms)","trace[2116019364] 'compare' (duration: 87.624712ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:16:28.000549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.037304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-08T01:16:28.0008Z","caller":"traceutil/trace.go:171","msg":"trace[525882752] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:320; }","duration":"100.343237ms","start":"2026-04-08T01:16:27.900437Z","end":"2026-04-08T01:16:28.000781Z","steps":["trace[525882752] 'agreement among raft nodes before linearized reading' (duration: 100.003673ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:28.122586Z","caller":"traceutil/trace.go:171","msg":"trace[1626316947] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"118.478287ms","start":"2026-04-08T01:16:28.004076Z","end":"2026-04-08T01:16:28.122555Z","steps":["trace[1626316947] 'process raft request' (duration: 108.116635ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:28.341815Z","caller":"traceutil/trace.go:171","msg":"trace[1428036050] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"114.133324ms","start":"2026-04-08T01:16:28.227657Z","end":"2026-04-08T01:16:28.341791Z","steps":["trace[1428036050] 'process raft request' (duration: 113.824561ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:28.683301Z","caller":"traceutil/trace.go:171","msg":"trace[926381118] linearizableReadLoop","detail":"{readStateIndex:348; appliedIndex:347; }","duration":"133.310511ms","start":"2026-04-08T01:16:28.549962Z","end":"2026-04-08T01:16:28.683272Z","steps":["trace[926381118] 'read index received' (duration: 124.713228ms)","trace[926381118] 'applied index is now lower than readState.Index' (duration: 8.595773ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:16:28.683512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.524053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-04-08T01:16:28.683561Z","caller":"traceutil/trace.go:171","msg":"trace[1494965223] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:335; }","duration":"133.603244ms","start":"2026-04-08T01:16:28.549939Z","end":"2026-04-08T01:16:28.683542Z","steps":["trace[1494965223] 'agreement among raft nodes before linearized reading' (duration: 133.480823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:28.683575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.681877ms","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-08T01:16:28.683635Z","caller":"traceutil/trace.go:171","msg":"trace[1529132730] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:335; }","duration":"125.779018ms","start":"2026-04-08T01:16:28.557843Z","end":"2026-04-08T01:16:28.683622Z","steps":["trace[1529132730] 'agreement among raft nodes before linearized reading' (duration: 125.654076ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:28.683414Z","caller":"traceutil/trace.go:171","msg":"trace[2062378604] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"140.058577ms","start":"2026-04-08T01:16:28.543315Z","end":"2026-04-08T01:16:28.683373Z","steps":["trace[2062378604] 'process raft request' (duration: 131.379473ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:29.033175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.525284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-04-08T01:16:29.033233Z","caller":"traceutil/trace.go:171","msg":"trace[1014798863] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:337; }","duration":"248.593535ms","start":"2026-04-08T01:16:28.784625Z","end":"2026-04-08T01:16:29.033218Z","steps":["trace[1014798863] 'range keys from in-memory index tree' (duration: 248.388272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:29.033226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.989009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7110"} {"level":"info","ts":"2026-04-08T01:16:29.033298Z","caller":"traceutil/trace.go:171","msg":"trace[1584174165] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:337; }","duration":"248.1192ms","start":"2026-04-08T01:16:28.785161Z","end":"2026-04-08T01:16:29.03328Z","steps":["trace[1584174165] 'range keys from in-memory index tree' (duration: 247.899618ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:29.033597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.326555ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:16:29.033842Z","caller":"traceutil/trace.go:171","msg":"trace[1097078630] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"247.448774ms","start":"2026-04-08T01:16:28.786381Z","end":"2026-04-08T01:16:29.03383Z","steps":["trace[1097078630] 'process raft request' (duration: 48.813716ms)","trace[1097078630] 'compare' (duration: 198.204183ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:29.03394Z","caller":"traceutil/trace.go:171","msg":"trace[207353486] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"246.266802ms","start":"2026-04-08T01:16:28.787586Z","end":"2026-04-08T01:16:29.033853Z","steps":["trace[207353486] 'process raft request' (duration: 246.168251ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:29.458363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.920451ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:16:29.458477Z","caller":"traceutil/trace.go:171","msg":"trace[1115804076] linearizableReadLoop","detail":"{readStateIndex:359; appliedIndex:358; }","duration":"223.439405ms","start":"2026-04-08T01:16:29.235018Z","end":"2026-04-08T01:16:29.458457Z","steps":["trace[1115804076] 'read index received' (duration: 34.331592ms)","trace[1115804076] 'applied index is now lower than readState.Index' (duration: 189.106633ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:29.459022Z","caller":"traceutil/trace.go:171","msg":"trace[896221009] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"247.134525ms","start":"2026-04-08T01:16:29.211862Z","end":"2026-04-08T01:16:29.458997Z","steps":["trace[896221009] 'process raft request' (duration: 57.478967ms)","trace[896221009] 'compare' (duration: 188.80038ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:16:29.459045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.468992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-08T01:16:29.459096Z","caller":"traceutil/trace.go:171","msg":"trace[785956738] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:346; }","duration":"264.520893ms","start":"2026-04-08T01:16:29.194556Z","end":"2026-04-08T01:16:29.459077Z","steps":["trace[785956738] 'agreement among raft nodes before linearized reading' (duration: 264.442162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:29.459489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.131885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-04-08T01:16:29.459543Z","caller":"traceutil/trace.go:171","msg":"trace[861270617] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:346; }","duration":"214.231655ms","start":"2026-04-08T01:16:29.245296Z","end":"2026-04-08T01:16:29.459528Z","steps":["trace[861270617] 'agreement among raft nodes before linearized reading' (duration: 214.138564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:29.459638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.844047ms","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-08T01:16:29.459669Z","caller":"traceutil/trace.go:171","msg":"trace[227941868] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:346; }","duration":"101.905368ms","start":"2026-04-08T01:16:29.357755Z","end":"2026-04-08T01:16:29.459661Z","steps":["trace[227941868] 'agreement among raft nodes before linearized reading' (duration: 101.794837ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:29.459755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.61839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-08T01:16:29.459827Z","caller":"traceutil/trace.go:171","msg":"trace[670109116] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:346; }","duration":"114.686341ms","start":"2026-04-08T01:16:29.345124Z","end":"2026-04-08T01:16:29.45981Z","steps":["trace[670109116] 'agreement among raft nodes before linearized reading' (duration: 114.351168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:29.459845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.890708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-08T01:16:29.459878Z","caller":"traceutil/trace.go:171","msg":"trace[1382335275] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:346; }","duration":"164.944189ms","start":"2026-04-08T01:16:29.29492Z","end":"2026-04-08T01:16:29.459864Z","steps":["trace[1382335275] 'agreement among raft nodes before linearized reading' (duration: 164.693206ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:29.769454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.8653ms","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-08T01:16:29.769609Z","caller":"traceutil/trace.go:171","msg":"trace[1506577076] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:348; }","duration":"125.108132ms","start":"2026-04-08T01:16:29.644471Z","end":"2026-04-08T01:16:29.769579Z","steps":["trace[1506577076] 'range keys from in-memory index tree' (duration: 124.721019ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:29.769853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.284458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-08T01:16:29.769955Z","caller":"traceutil/trace.go:171","msg":"trace[130658600] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:348; }","duration":"174.565501ms","start":"2026-04-08T01:16:29.595357Z","end":"2026-04-08T01:16:29.769922Z","steps":["trace[130658600] 'range keys from in-memory index tree' (duration: 174.145727ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:29.924544Z","caller":"traceutil/trace.go:171","msg":"trace[1975071793] linearizableReadLoop","detail":"{readStateIndex:362; appliedIndex:361; }","duration":"131.285461ms","start":"2026-04-08T01:16:29.793237Z","end":"2026-04-08T01:16:29.924523Z","steps":["trace[1975071793] 'read index received' (duration: 131.066969ms)","trace[1975071793] 'applied index is now lower than readState.Index' (duration: 217.272µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:29.924668Z","caller":"traceutil/trace.go:171","msg":"trace[1898819816] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"146.384149ms","start":"2026-04-08T01:16:29.778273Z","end":"2026-04-08T01:16:29.924658Z","steps":["trace[1898819816] 'process raft request' (duration: 146.054356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:29.924899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.536725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-08T01:16:29.924994Z","caller":"traceutil/trace.go:171","msg":"trace[15054134] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:349; }","duration":"129.665596ms","start":"2026-04-08T01:16:29.795307Z","end":"2026-04-08T01:16:29.924973Z","steps":["trace[15054134] 'agreement among raft nodes before linearized reading' (duration: 129.426414ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:29.925277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.04554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-rhr0s5\" ","response":"range_response_count:1 size:540"} {"level":"info","ts":"2026-04-08T01:16:29.925396Z","caller":"traceutil/trace.go:171","msg":"trace[1916291830] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-rhr0s5; range_end:; response_count:1; response_revision:349; }","duration":"132.216881ms","start":"2026-04-08T01:16:29.793163Z","end":"2026-04-08T01:16:29.92538Z","steps":["trace[1916291830] 'agreement among raft nodes before linearized reading' (duration: 132.053229ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:30.124217Z","caller":"traceutil/trace.go:171","msg":"trace[1562441117] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"115.633102ms","start":"2026-04-08T01:16:30.008564Z","end":"2026-04-08T01:16:30.124197Z","steps":["trace[1562441117] 'process raft request' (duration: 115.587562ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:30.124237Z","caller":"traceutil/trace.go:171","msg":"trace[692709034] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"121.048674ms","start":"2026-04-08T01:16:30.003154Z","end":"2026-04-08T01:16:30.124203Z","steps":["trace[692709034] 'process raft request' (duration: 120.914313ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:30.124404Z","caller":"traceutil/trace.go:171","msg":"trace[1950860718] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"119.56738ms","start":"2026-04-08T01:16:30.004689Z","end":"2026-04-08T01:16:30.124257Z","steps":["trace[1950860718] 'process raft request' (duration: 119.416178ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:30.124673Z","caller":"traceutil/trace.go:171","msg":"trace[907783515] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"121.66282ms","start":"2026-04-08T01:16:30.002993Z","end":"2026-04-08T01:16:30.124656Z","steps":["trace[907783515] 'process raft request' (duration: 94.68932ms)","trace[907783515] 'compare' (duration: 26.249913ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:30.126402Z","caller":"traceutil/trace.go:171","msg":"trace[465302364] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"113.862985ms","start":"2026-04-08T01:16:30.012524Z","end":"2026-04-08T01:16:30.126387Z","steps":["trace[465302364] 'process raft request' (duration: 113.511072ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:30.126664Z","caller":"traceutil/trace.go:171","msg":"trace[768286407] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"114.001647ms","start":"2026-04-08T01:16:30.012642Z","end":"2026-04-08T01:16:30.126644Z","steps":["trace[768286407] 'process raft request' (duration: 113.496512ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:30.126935Z","caller":"traceutil/trace.go:171","msg":"trace[319266445] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"110.28997ms","start":"2026-04-08T01:16:30.016635Z","end":"2026-04-08T01:16:30.126925Z","steps":["trace[319266445] 'process raft request' (duration: 109.715685ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:30.126957Z","caller":"traceutil/trace.go:171","msg":"trace[1071054840] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"102.416135ms","start":"2026-04-08T01:16:30.024528Z","end":"2026-04-08T01:16:30.126944Z","steps":["trace[1071054840] 'process raft request' (duration: 102.317954ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:30.40824Z","caller":"traceutil/trace.go:171","msg":"trace[1670724074] linearizableReadLoop","detail":"{readStateIndex:382; appliedIndex:377; }","duration":"263.751206ms","start":"2026-04-08T01:16:30.144464Z","end":"2026-04-08T01:16:30.408215Z","steps":["trace[1670724074] 'read index received' (duration: 32.318161ms)","trace[1670724074] 'applied index is now lower than readState.Index' (duration: 231.431895ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:30.408665Z","caller":"traceutil/trace.go:171","msg":"trace[930282366] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"271.082946ms","start":"2026-04-08T01:16:30.137561Z","end":"2026-04-08T01:16:30.408644Z","steps":["trace[930282366] 'process raft request' (duration: 192.835414ms)","trace[930282366] 'compare' (duration: 77.481965ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:30.409037Z","caller":"traceutil/trace.go:171","msg":"trace[236448443] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"268.120628ms","start":"2026-04-08T01:16:30.140904Z","end":"2026-04-08T01:16:30.409025Z","steps":["trace[236448443] 'process raft request' (duration: 267.26823ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:30.40935Z","caller":"traceutil/trace.go:171","msg":"trace[1835477388] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"270.306079ms","start":"2026-04-08T01:16:30.139032Z","end":"2026-04-08T01:16:30.409338Z","steps":["trace[1835477388] 'process raft request' (duration: 269.030567ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:30.409675Z","caller":"traceutil/trace.go:171","msg":"trace[349291887] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"269.814184ms","start":"2026-04-08T01:16:30.13985Z","end":"2026-04-08T01:16:30.409664Z","steps":["trace[349291887] 'process raft request' (duration: 268.272889ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:30.410361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.876407ms","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-08T01:16:30.410458Z","caller":"traceutil/trace.go:171","msg":"trace[773499068] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:369; }","duration":"265.995878ms","start":"2026-04-08T01:16:30.14445Z","end":"2026-04-08T01:16:30.410445Z","steps":["trace[773499068] 'agreement among raft nodes before linearized reading' (duration: 265.836646ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:30.410644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.30295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-08T01:16:30.410842Z","caller":"traceutil/trace.go:171","msg":"trace[1190923815] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:369; }","duration":"215.449801ms","start":"2026-04-08T01:16:30.195282Z","end":"2026-04-08T01:16:30.410732Z","steps":["trace[1190923815] 'agreement among raft nodes before linearized reading' (duration: 215.118398ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:30.410934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.44394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-08T01:16:30.411012Z","caller":"traceutil/trace.go:171","msg":"trace[2097140526] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:369; }","duration":"165.550301ms","start":"2026-04-08T01:16:30.245451Z","end":"2026-04-08T01:16:30.411001Z","steps":["trace[2097140526] 'agreement among raft nodes before linearized reading' (duration: 165.370809ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:30.676477Z","caller":"traceutil/trace.go:171","msg":"trace[1124414775] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"178.682739ms","start":"2026-04-08T01:16:30.497758Z","end":"2026-04-08T01:16:30.676441Z","steps":["trace[1124414775] 'process raft request' (duration: 178.577758ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:30.676738Z","caller":"traceutil/trace.go:171","msg":"trace[957693518] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"180.87382ms","start":"2026-04-08T01:16:30.495843Z","end":"2026-04-08T01:16:30.676717Z","steps":["trace[957693518] 'process raft request' (duration: 136.340891ms)","trace[957693518] 'compare' (duration: 43.818552ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:30.676909Z","caller":"traceutil/trace.go:171","msg":"trace[918374268] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"179.385355ms","start":"2026-04-08T01:16:30.497483Z","end":"2026-04-08T01:16:30.676869Z","steps":["trace[918374268] 'process raft request' (duration: 178.81782ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:30.676909Z","caller":"traceutil/trace.go:171","msg":"trace[1606934296] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"180.641347ms","start":"2026-04-08T01:16:30.496235Z","end":"2026-04-08T01:16:30.676876Z","steps":["trace[1606934296] 'process raft request' (duration: 180.005411ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:30.6848Z","caller":"traceutil/trace.go:171","msg":"trace[910361948] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"184.295862ms","start":"2026-04-08T01:16:30.500481Z","end":"2026-04-08T01:16:30.684777Z","steps":["trace[910361948] 'process raft request' (duration: 184.04028ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:30.684838Z","caller":"traceutil/trace.go:171","msg":"trace[1266403999] linearizableReadLoop","detail":"{readStateIndex:395; appliedIndex:389; }","duration":"165.3546ms","start":"2026-04-08T01:16:30.519468Z","end":"2026-04-08T01:16:30.684822Z","steps":["trace[1266403999] 'read index received' (duration: 112.714504ms)","trace[1266403999] 'applied index is now lower than readState.Index' (duration: 52.638906ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:30.684875Z","caller":"traceutil/trace.go:171","msg":"trace[2022542225] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"182.562616ms","start":"2026-04-08T01:16:30.50228Z","end":"2026-04-08T01:16:30.684843Z","steps":["trace[2022542225] 'process raft request' (duration: 182.386144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:30.685447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.967656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:16:30.685503Z","caller":"traceutil/trace.go:171","msg":"trace[666944904] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:382; }","duration":"166.068417ms","start":"2026-04-08T01:16:30.519422Z","end":"2026-04-08T01:16:30.68549Z","steps":["trace[666944904] 'agreement among raft nodes before linearized reading' (duration: 165.454781ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:30.856629Z","caller":"traceutil/trace.go:171","msg":"trace[897222265] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"120.800392ms","start":"2026-04-08T01:16:30.735795Z","end":"2026-04-08T01:16:30.856595Z","steps":["trace[897222265] 'process raft request' (duration: 108.13052ms)","trace[897222265] 'compare' (duration: 12.404339ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:32.932323Z","caller":"traceutil/trace.go:171","msg":"trace[170694053] linearizableReadLoop","detail":"{readStateIndex:418; appliedIndex:417; }","duration":"448.764196ms","start":"2026-04-08T01:16:32.483534Z","end":"2026-04-08T01:16:32.932299Z","steps":["trace[170694053] 'read index received' (duration: 448.523733ms)","trace[170694053] 'applied index is now lower than readState.Index' (duration: 239.403µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:16:32.932516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.804985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:16:32.932558Z","caller":"traceutil/trace.go:171","msg":"trace[1433615803] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:404; }","duration":"412.860355ms","start":"2026-04-08T01:16:32.519685Z","end":"2026-04-08T01:16:32.932545Z","steps":["trace[1433615803] 'agreement among raft nodes before linearized reading' (duration: 412.783024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:32.932597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:32.519631Z","time spent":"412.958267ms","remote":"127.0.0.1:58504","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-08T01:16:32.932544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.978088ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:16:32.932687Z","caller":"traceutil/trace.go:171","msg":"trace[2071131207] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:404; }","duration":"449.137099ms","start":"2026-04-08T01:16:32.483525Z","end":"2026-04-08T01:16:32.932662Z","steps":["trace[2071131207] 'agreement among raft nodes before linearized reading' (duration: 448.936867ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:32.932528Z","caller":"traceutil/trace.go:171","msg":"trace[10237472] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"766.197826ms","start":"2026-04-08T01:16:32.166175Z","end":"2026-04-08T01:16:32.932373Z","steps":["trace[10237472] 'process raft request' (duration: 765.991575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:32.93361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:32.166141Z","time spent":"767.355258ms","remote":"127.0.0.1:58684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4467,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:16:33.07544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.82272ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:16:33.075595Z","caller":"traceutil/trace.go:171","msg":"trace[758443247] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"133.901086ms","start":"2026-04-08T01:16:32.941661Z","end":"2026-04-08T01:16:33.075562Z","steps":["trace[758443247] 'process raft request' (duration: 28.861484ms)","trace[758443247] 'compare' (duration: 104.662319ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:33.077486Z","caller":"traceutil/trace.go:171","msg":"trace[753962151] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"132.103509ms","start":"2026-04-08T01:16:32.945364Z","end":"2026-04-08T01:16:33.077467Z","steps":["trace[753962151] 'process raft request' (duration: 132.017658ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:33.392265Z","caller":"traceutil/trace.go:171","msg":"trace[1660244440] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"224.834338ms","start":"2026-04-08T01:16:33.167388Z","end":"2026-04-08T01:16:33.392222Z","steps":["trace[1660244440] 'process raft request' (duration: 143.708834ms)","trace[1660244440] 'compare' (duration: 80.936472ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:38.348799Z","caller":"traceutil/trace.go:171","msg":"trace[1915886502] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"274.849109ms","start":"2026-04-08T01:16:38.073923Z","end":"2026-04-08T01:16:38.348772Z","steps":["trace[1915886502] 'process raft request' (duration: 274.721138ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:40.308876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.331058005s","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-08T01:16:40.308956Z","caller":"traceutil/trace.go:171","msg":"trace[732297176] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:424; }","duration":"1.331172505s","start":"2026-04-08T01:16:38.977764Z","end":"2026-04-08T01:16:40.308936Z","steps":["trace[732297176] 'range keys from in-memory index tree' (duration: 1.330972303s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:40.308996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:38.977747Z","time spent":"1.331239896s","remote":"127.0.0.1:58768","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-08T01:16:40.309254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.094111793s","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-08T01:16:40.309332Z","caller":"traceutil/trace.go:171","msg":"trace[1164070953] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:424; }","duration":"1.094228064s","start":"2026-04-08T01:16:39.215085Z","end":"2026-04-08T01:16:40.309313Z","steps":["trace[1164070953] 'range keys from in-memory index tree' (duration: 1.093967602s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:40.309373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:39.215063Z","time spent":"1.094300384s","remote":"127.0.0.1:58768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-08T01:16:40.390866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.276827ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-08T01:16:40.391097Z","caller":"traceutil/trace.go:171","msg":"trace[2130457812] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"805.948584ms","start":"2026-04-08T01:16:39.585126Z","end":"2026-04-08T01:16:40.391075Z","steps":["trace[2130457812] 'process raft request' (duration: 805.837043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:40.391235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:39.585086Z","time spent":"806.070925ms","remote":"127.0.0.1:58768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:16:40.39134Z","caller":"traceutil/trace.go:171","msg":"trace[243489846] linearizableReadLoop","detail":"{readStateIndex:440; appliedIndex:439; }","duration":"873.771019ms","start":"2026-04-08T01:16:39.517534Z","end":"2026-04-08T01:16:40.391305Z","steps":["trace[243489846] 'read index received' (duration: 478.083988ms)","trace[243489846] 'applied index is now lower than readState.Index' (duration: 395.683751ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:16:40.391641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"874.082372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:16:40.391718Z","caller":"traceutil/trace.go:171","msg":"trace[118484005] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:427; }","duration":"874.198933ms","start":"2026-04-08T01:16:39.517502Z","end":"2026-04-08T01:16:40.391701Z","steps":["trace[118484005] 'agreement among raft nodes before linearized reading' (duration: 874.062132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:40.391766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:39.517487Z","time spent":"874.270144ms","remote":"127.0.0.1:58504","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-08T01:16:40.391911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"773.59461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-08T01:16:40.391964Z","caller":"traceutil/trace.go:171","msg":"trace[2004787649] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:427; }","duration":"773.701992ms","start":"2026-04-08T01:16:39.61825Z","end":"2026-04-08T01:16:40.391952Z","steps":["trace[2004787649] 'agreement among raft nodes before linearized reading' (duration: 773.418809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:40.392137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:39.618227Z","time spent":"773.897143ms","remote":"127.0.0.1:58768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-08T01:16:40.515816Z","caller":"traceutil/trace.go:171","msg":"trace[1044596059] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"119.933312ms","start":"2026-04-08T01:16:40.395854Z","end":"2026-04-08T01:16:40.515787Z","steps":["trace[1044596059] 'process raft request' (duration: 78.577609ms)","trace[1044596059] 'compare' (duration: 41.157281ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:16:40.516634Z","caller":"traceutil/trace.go:171","msg":"trace[227349443] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"120.007483ms","start":"2026-04-08T01:16:40.39658Z","end":"2026-04-08T01:16:40.516587Z","steps":["trace[227349443] 'process raft request' (duration: 119.154945ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:42.531103Z","caller":"traceutil/trace.go:171","msg":"trace[1011751379] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"130.781717ms","start":"2026-04-08T01:16:42.4003Z","end":"2026-04-08T01:16:42.531082Z","steps":["trace[1011751379] 'process raft request' (duration: 130.647946ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:42.537106Z","caller":"traceutil/trace.go:171","msg":"trace[1765327489] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"135.634ms","start":"2026-04-08T01:16:42.401454Z","end":"2026-04-08T01:16:42.537088Z","steps":["trace[1765327489] 'process raft request' (duration: 135.282637ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:45.882319Z","caller":"traceutil/trace.go:171","msg":"trace[1656265344] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"339.474164ms","start":"2026-04-08T01:16:45.542816Z","end":"2026-04-08T01:16:45.88229Z","steps":["trace[1656265344] 'process raft request' (duration: 339.309792ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:45.882598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:45.542798Z","time spent":"339.601535ms","remote":"127.0.0.1:35094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:16:46.121653Z","caller":"traceutil/trace.go:171","msg":"trace[920104486] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"231.443589ms","start":"2026-04-08T01:16:45.890184Z","end":"2026-04-08T01:16:46.121628Z","steps":["trace[920104486] 'process raft request' (duration: 225.75324ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:16:58.761314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.317979ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:16:58.7614Z","caller":"traceutil/trace.go:171","msg":"trace[1278446779] linearizableReadLoop","detail":"{readStateIndex:550; appliedIndex:549; }","duration":"125.123585ms","start":"2026-04-08T01:16:58.636263Z","end":"2026-04-08T01:16:58.761386Z","steps":["trace[1278446779] 'read index received' (duration: 15.604904ms)","trace[1278446779] 'applied index is now lower than readState.Index' (duration: 109.517811ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:16:58.76154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.594685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-08T01:16:58.761564Z","caller":"traceutil/trace.go:171","msg":"trace[637696419] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:531; }","duration":"121.643187ms","start":"2026-04-08T01:16:58.639914Z","end":"2026-04-08T01:16:58.761557Z","steps":["trace[637696419] 'agreement among raft nodes before linearized reading' (duration: 121.543662ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:16:58.761608Z","caller":"traceutil/trace.go:171","msg":"trace[2026337359] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"151.303497ms","start":"2026-04-08T01:16:58.610284Z","end":"2026-04-08T01:16:58.761588Z","steps":["trace[2026337359] 'process raft request' (duration: 41.645648ms)","trace[2026337359] 'compare' (duration: 109.206914ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:16:58.761585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.294304ms","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-08T01:16:58.761705Z","caller":"traceutil/trace.go:171","msg":"trace[86845424] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:531; }","duration":"125.408301ms","start":"2026-04-08T01:16:58.636259Z","end":"2026-04-08T01:16:58.761667Z","steps":["trace[86845424] 'agreement among raft nodes before linearized reading' (duration: 125.202519ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:17:00.293346Z","caller":"traceutil/trace.go:171","msg":"trace[1805003828] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"615.784013ms","start":"2026-04-08T01:16:59.677534Z","end":"2026-04-08T01:17:00.293318Z","steps":["trace[1805003828] 'process raft request' (duration: 605.510065ms)","trace[1805003828] 'compare' (duration: 10.082267ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:17:00.293522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:59.677514Z","time spent":"615.933442ms","remote":"127.0.0.1:58540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80688,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:17:00.305068Z","caller":"traceutil/trace.go:171","msg":"trace[781166892] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:609; }","duration":"480.89877ms","start":"2026-04-08T01:16:59.82413Z","end":"2026-04-08T01:17:00.305029Z","steps":["trace[781166892] 'read index received' (duration: 458.997019ms)","trace[781166892] 'applied index is now lower than readState.Index' (duration: 21.901131ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:17:00.305162Z","caller":"traceutil/trace.go:171","msg":"trace[745803138] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"609.887996ms","start":"2026-04-08T01:16:59.695266Z","end":"2026-04-08T01:17:00.305154Z","steps":["trace[745803138] 'process raft request' (duration: 609.452942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:17:00.305236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:59.695243Z","time spent":"609.937678ms","remote":"127.0.0.1:58540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":73770,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T01:17:00.305348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.197186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:17:00.30538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.180065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:17:00.30541Z","caller":"traceutil/trace.go:171","msg":"trace[642945187] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:591; }","duration":"481.299262ms","start":"2026-04-08T01:16:59.824094Z","end":"2026-04-08T01:17:00.305393Z","steps":["trace[642945187] 'agreement among raft nodes before linearized reading' (duration: 481.137363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:17:00.30545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:59.824075Z","time spent":"481.364146ms","remote":"127.0.0.1:37528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-08T01:17:00.305458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.70393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:17:00.305485Z","caller":"traceutil/trace.go:171","msg":"trace[1400009053] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:591; }","duration":"366.747443ms","start":"2026-04-08T01:16:59.938728Z","end":"2026-04-08T01:17:00.305476Z","steps":["trace[1400009053] 'agreement among raft nodes before linearized reading' (duration: 366.70483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:17:00.305511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:59.938721Z","time spent":"366.782655ms","remote":"127.0.0.1:37554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"info","ts":"2026-04-08T01:17:00.305416Z","caller":"traceutil/trace.go:171","msg":"trace[3601210] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:591; }","duration":"481.234408ms","start":"2026-04-08T01:16:59.82417Z","end":"2026-04-08T01:17:00.305404Z","steps":["trace[3601210] 'agreement among raft nodes before linearized reading' (duration: 481.174104ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:17:00.305573Z","caller":"traceutil/trace.go:171","msg":"trace[1178662258] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"580.543464ms","start":"2026-04-08T01:16:59.725004Z","end":"2026-04-08T01:17:00.305547Z","steps":["trace[1178662258] 'process raft request' (duration: 579.918889ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:17:00.305614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:59.824164Z","time spent":"481.43741ms","remote":"127.0.0.1:37528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-08T01:17:00.305662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.147545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:17:00.305683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:59.724986Z","time spent":"580.640759ms","remote":"127.0.0.1:58540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:17:00.305693Z","caller":"traceutil/trace.go:171","msg":"trace[1610148681] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:591; }","duration":"367.198938ms","start":"2026-04-08T01:16:59.938485Z","end":"2026-04-08T01:17:00.305684Z","steps":["trace[1610148681] 'agreement among raft nodes before linearized reading' (duration: 367.148095ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:17:00.305723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:59.938476Z","time spent":"367.23768ms","remote":"127.0.0.1:37568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-08T01:17:00.30578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.280848ms","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-08T01:17:00.305803Z","caller":"traceutil/trace.go:171","msg":"trace[11351146] 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:591; }","duration":"447.335891ms","start":"2026-04-08T01:16:59.858458Z","end":"2026-04-08T01:17:00.305794Z","steps":["trace[11351146] 'agreement among raft nodes before linearized reading' (duration: 447.296619ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:17:00.305829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:59.858437Z","time spent":"447.387154ms","remote":"127.0.0.1:37542","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-08T01:17:00.305861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.522561ms","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":"warn","ts":"2026-04-08T01:17:00.305885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.114972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:17:00.305893Z","caller":"traceutil/trace.go:171","msg":"trace[484739274] 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:591; }","duration":"447.563094ms","start":"2026-04-08T01:16:59.85832Z","end":"2026-04-08T01:17:00.305884Z","steps":["trace[484739274] 'agreement among raft nodes before linearized reading' (duration: 447.512341ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:17:00.305914Z","caller":"traceutil/trace.go:171","msg":"trace[1930556544] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:591; }","duration":"466.157504ms","start":"2026-04-08T01:16:59.839748Z","end":"2026-04-08T01:17:00.305905Z","steps":["trace[1930556544] 'agreement among raft nodes before linearized reading' (duration: 466.109482ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:17:00.305923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:59.858315Z","time spent":"447.599166ms","remote":"127.0.0.1:37542","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":"warn","ts":"2026-04-08T01:17:00.305941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:59.839741Z","time spent":"466.191006ms","remote":"127.0.0.1:37540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-08T01:17:00.305996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.835693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:17:00.30602Z","caller":"traceutil/trace.go:171","msg":"trace[296975489] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:591; }","duration":"367.882646ms","start":"2026-04-08T01:16:59.938128Z","end":"2026-04-08T01:17:00.306011Z","steps":["trace[296975489] 'agreement among raft nodes before linearized reading' (duration: 367.851704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:17:00.306037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:59.938118Z","time spent":"367.914898ms","remote":"127.0.0.1:37568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-08T01:17:00.306124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.888612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:17:00.306141Z","caller":"traceutil/trace.go:171","msg":"trace[1143557524] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:591; }","duration":"400.926895ms","start":"2026-04-08T01:16:59.905209Z","end":"2026-04-08T01:17:00.306136Z","steps":["trace[1143557524] 'agreement among raft nodes before linearized reading' (duration: 400.901094ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:17:00.306157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:59.905197Z","time spent":"400.955926ms","remote":"127.0.0.1:37554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-08T01:17:00.306167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.55226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:17:00.306202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.035511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:17:00.306202Z","caller":"traceutil/trace.go:171","msg":"trace[1948540323] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:591; }","duration":"465.600582ms","start":"2026-04-08T01:16:59.840591Z","end":"2026-04-08T01:17:00.306192Z","steps":["trace[1948540323] 'agreement among raft nodes before linearized reading' (duration: 465.545189ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:17:00.306219Z","caller":"traceutil/trace.go:171","msg":"trace[321878143] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:591; }","duration":"401.076833ms","start":"2026-04-08T01:16:59.905137Z","end":"2026-04-08T01:17:00.306214Z","steps":["trace[321878143] 'agreement among raft nodes before linearized reading' (duration: 401.052272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:17:00.306249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:59.90512Z","time spent":"401.113314ms","remote":"127.0.0.1:37554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-08T01:17:00.306296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.31472ms","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-08T01:17:00.306311Z","caller":"traceutil/trace.go:171","msg":"trace[281476272] 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:591; }","duration":"447.32965ms","start":"2026-04-08T01:16:59.858976Z","end":"2026-04-08T01:17:00.306306Z","steps":["trace[281476272] 'agreement among raft nodes before linearized reading' (duration: 447.308129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:17:00.306326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:59.858962Z","time spent":"447.360002ms","remote":"127.0.0.1:37542","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-08T01:17:00.3066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.735725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:17:00.306619Z","caller":"traceutil/trace.go:171","msg":"trace[1028671499] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:591; }","duration":"466.790409ms","start":"2026-04-08T01:16:59.839823Z","end":"2026-04-08T01:17:00.306614Z","steps":["trace[1028671499] 'agreement among raft nodes before linearized reading' (duration: 466.758337ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:17:00.306638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:59.839803Z","time spent":"466.829152ms","remote":"127.0.0.1:37540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-08T01:17:00.30623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:16:59.840585Z","time spent":"465.636775ms","remote":"127.0.0.1:37528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-04-08T01:17:01.778752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.235879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:17:01.778817Z","caller":"traceutil/trace.go:171","msg":"trace[672823682] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"259.331685ms","start":"2026-04-08T01:17:01.519467Z","end":"2026-04-08T01:17:01.778799Z","steps":["trace[672823682] 'range keys from in-memory index tree' (duration: 259.187437ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:17:01.779041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.412522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:15688"} {"level":"info","ts":"2026-04-08T01:17:01.779137Z","caller":"traceutil/trace.go:171","msg":"trace[778910995] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:615; }","duration":"433.569381ms","start":"2026-04-08T01:17:01.345545Z","end":"2026-04-08T01:17:01.779114Z","steps":["trace[778910995] 'range keys from in-memory index tree' (duration: 433.18832ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:17:01.779192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:17:01.345524Z","time spent":"433.656926ms","remote":"127.0.0.1:58540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":15711,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io\" "} {"level":"info","ts":"2026-04-08T01:17:06.408139Z","caller":"traceutil/trace.go:171","msg":"trace[1243506426] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:663; }","duration":"147.545186ms","start":"2026-04-08T01:17:06.260563Z","end":"2026-04-08T01:17:06.408109Z","steps":["trace[1243506426] 'read index received' (duration: 146.762216ms)","trace[1243506426] 'applied index is now lower than readState.Index' (duration: 781.79µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:17:06.408204Z","caller":"traceutil/trace.go:171","msg":"trace[1184371455] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"266.765284ms","start":"2026-04-08T01:17:06.141402Z","end":"2026-04-08T01:17:06.408168Z","steps":["trace[1184371455] 'process raft request' (duration: 266.197685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:17:06.408341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.763878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-g78hd\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-08T01:17:06.40842Z","caller":"traceutil/trace.go:171","msg":"trace[1788663946] range","detail":"{range_begin:/registry/pods/kube-system/cilium-g78hd; range_end:; response_count:1; response_revision:642; }","duration":"147.892634ms","start":"2026-04-08T01:17:06.260515Z","end":"2026-04-08T01:17:06.408408Z","steps":["trace[1788663946] 'agreement among raft nodes before linearized reading' (duration: 147.706444ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:17:06.675671Z","caller":"traceutil/trace.go:171","msg":"trace[841440420] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"247.118581ms","start":"2026-04-08T01:17:06.428527Z","end":"2026-04-08T01:17:06.675646Z","steps":["trace[841440420] 'process raft request' (duration: 246.962053ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:17:06.747485Z","caller":"traceutil/trace.go:171","msg":"trace[943864864] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:664; }","duration":"227.485162ms","start":"2026-04-08T01:17:06.519974Z","end":"2026-04-08T01:17:06.747459Z","steps":["trace[943864864] 'read index received' (duration: 155.473634ms)","trace[943864864] 'applied index is now lower than readState.Index' (duration: 72.008878ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:17:06.747598Z","caller":"traceutil/trace.go:171","msg":"trace[329617278] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"285.198212ms","start":"2026-04-08T01:17:06.462352Z","end":"2026-04-08T01:17:06.74755Z","steps":["trace[329617278] 'process raft request' (duration: 284.991552ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:17:06.747691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.702382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:17:06.747829Z","caller":"traceutil/trace.go:171","msg":"trace[1927276678] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:644; }","duration":"227.870691ms","start":"2026-04-08T01:17:06.519931Z","end":"2026-04-08T01:17:06.747802Z","steps":["trace[1927276678] 'agreement among raft nodes before linearized reading' (duration: 227.65106ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:17:08.583183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"793.834144ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:17:08.583291Z","caller":"traceutil/trace.go:171","msg":"trace[560953805] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"1.773196184s","start":"2026-04-08T01:17:06.810075Z","end":"2026-04-08T01:17:08.583271Z","steps":["trace[560953805] 'process raft request' (duration: 979.188031ms)","trace[560953805] 'compare' (duration: 793.670026ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:17:08.583347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:17:06.810055Z","time spent":"1.773266748s","remote":"127.0.0.1:58768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:17:08.628748Z","caller":"traceutil/trace.go:171","msg":"trace[108619171] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"1.817989437s","start":"2026-04-08T01:17:06.810725Z","end":"2026-04-08T01:17:08.628714Z","steps":["trace[108619171] 'process raft request' (duration: 1.815942434s)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:17:08.629261Z","caller":"traceutil/trace.go:171","msg":"trace[1284260192] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"1.81728623s","start":"2026-04-08T01:17:06.811946Z","end":"2026-04-08T01:17:08.629232Z","steps":["trace[1284260192] 'process raft request' (duration: 1.814870778s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:17:08.629745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:17:06.811908Z","time spent":"1.817802246s","remote":"127.0.0.1:58768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:17:08.630264Z","caller":"traceutil/trace.go:171","msg":"trace[352675570] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"1.43555287s","start":"2026-04-08T01:17:07.1947Z","end":"2026-04-08T01:17:08.630252Z","steps":["trace[352675570] 'process raft request' (duration: 1.432927148s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:17:08.630321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:17:07.194683Z","time spent":"1.435602462s","remote":"127.0.0.1:58584","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-08T01:17:08.633493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:17:06.810708Z","time spent":"1.818120494s","remote":"127.0.0.1:58768","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-08T01:17:08.636958Z","caller":"traceutil/trace.go:171","msg":"trace[819171399] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"475.287506ms","start":"2026-04-08T01:17:08.16165Z","end":"2026-04-08T01:17:08.636938Z","steps":["trace[819171399] 'process raft request' (duration: 475.140638ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:17:08.636972Z","caller":"traceutil/trace.go:171","msg":"trace[2093912834] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:668; }","duration":"116.259508ms","start":"2026-04-08T01:17:08.520654Z","end":"2026-04-08T01:17:08.636913Z","steps":["trace[2093912834] 'read index received' (duration: 106.088437ms)","trace[2093912834] 'applied index is now lower than readState.Index' (duration: 10.170401ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:17:08.63704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:17:08.161626Z","time spent":"475.37296ms","remote":"127.0.0.1:58768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:17:08.637072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.410045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:17:08.637105Z","caller":"traceutil/trace.go:171","msg":"trace[498591911] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:650; }","duration":"116.458467ms","start":"2026-04-08T01:17:08.520637Z","end":"2026-04-08T01:17:08.637096Z","steps":["trace[498591911] 'agreement among raft nodes before linearized reading' (duration: 116.393124ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:17:10.604248Z","caller":"traceutil/trace.go:171","msg":"trace[1449407438] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"180.116972ms","start":"2026-04-08T01:17:10.424069Z","end":"2026-04-08T01:17:10.604186Z","steps":["trace[1449407438] 'process raft request' (duration: 179.87632ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:17:21.089921Z","caller":"traceutil/trace.go:171","msg":"trace[1908791840] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"216.154861ms","start":"2026-04-08T01:17:20.873723Z","end":"2026-04-08T01:17:21.089877Z","steps":["trace[1908791840] 'process raft request' (duration: 216.010145ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:17:24.275621Z","caller":"traceutil/trace.go:171","msg":"trace[1835185017] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"105.943793ms","start":"2026-04-08T01:17:24.169641Z","end":"2026-04-08T01:17:24.275584Z","steps":["trace[1835185017] 'process raft request' (duration: 105.427752ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:17:49.792488Z","caller":"traceutil/trace.go:171","msg":"trace[449009138] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"124.178195ms","start":"2026-04-08T01:17:49.668292Z","end":"2026-04-08T01:17:49.79247Z","steps":["trace[449009138] 'process raft request' (duration: 124.039171ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:19:17.330707Z","caller":"traceutil/trace.go:171","msg":"trace[1798018641] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"267.491954ms","start":"2026-04-08T01:19:17.063193Z","end":"2026-04-08T01:19:17.330685Z","steps":["trace[1798018641] 'process raft request' (duration: 267.374012ms)"],"step_count":1}