{"level":"warn","ts":"2026-04-28T07:26:14.242405Z","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-28T07:26:14.242533Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.202:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.202:2380","--initial-cluster=instance=https://199.19.213.202:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.202:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.202: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-28T07:26:14.242818Z","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-28T07:26:14.242838Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.202:2380"]} {"level":"info","ts":"2026-04-28T07:26:14.242899Z","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-28T07:26:14.243775Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.202:2379"]} {"level":"info","ts":"2026-04-28T07:26:14.243904Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.202:2380"],"listen-peer-urls":["https://199.19.213.202:2380"],"advertise-client-urls":["https://199.19.213.202:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.202:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.202: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-28T07:26:14.247548Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.318753ms"} {"level":"info","ts":"2026-04-28T07:26:14.252341Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c9b4049ccf4190cf","cluster-id":"2bc66bd50b26302c"} {"level":"info","ts":"2026-04-28T07:26:14.252472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf switched to configuration voters=()"} {"level":"info","ts":"2026-04-28T07:26:14.252521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf became follower at term 0"} {"level":"info","ts":"2026-04-28T07:26:14.252539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c9b4049ccf4190cf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-28T07:26:14.252578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf became follower at term 1"} {"level":"info","ts":"2026-04-28T07:26:14.252643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf switched to configuration voters=(14534246968970023119)"} {"level":"warn","ts":"2026-04-28T07:26:14.255887Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-28T07:26:14.257126Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-28T07:26:14.258153Z","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-28T07:26:14.260059Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c9b4049ccf4190cf","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-28T07:26:14.260245Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c9b4049ccf4190cf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-28T07:26:14.264804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf switched to configuration voters=(14534246968970023119)"} {"level":"info","ts":"2026-04-28T07:26:14.264726Z","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-28T07:26:14.265053Z","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-28T07:26:14.265065Z","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-28T07:26:14.264965Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bc66bd50b26302c","local-member-id":"c9b4049ccf4190cf","added-peer-id":"c9b4049ccf4190cf","added-peer-peer-urls":["https://199.19.213.202:2380"]} {"level":"info","ts":"2026-04-28T07:26:14.267809Z","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-28T07:26:14.268018Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c9b4049ccf4190cf","initial-advertise-peer-urls":["https://199.19.213.202:2380"],"listen-peer-urls":["https://199.19.213.202:2380"],"advertise-client-urls":["https://199.19.213.202:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.202:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-28T07:26:14.268052Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-28T07:26:14.268159Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.202:2380"} {"level":"info","ts":"2026-04-28T07:26:14.268173Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.202:2380"} {"level":"info","ts":"2026-04-28T07:26:15.253788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf is starting a new election at term 1"} {"level":"info","ts":"2026-04-28T07:26:15.253919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf became pre-candidate at term 1"} {"level":"info","ts":"2026-04-28T07:26:15.253989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf received MsgPreVoteResp from c9b4049ccf4190cf at term 1"} {"level":"info","ts":"2026-04-28T07:26:15.25403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf became candidate at term 2"} {"level":"info","ts":"2026-04-28T07:26:15.254049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf received MsgVoteResp from c9b4049ccf4190cf at term 2"} {"level":"info","ts":"2026-04-28T07:26:15.254079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf became leader at term 2"} {"level":"info","ts":"2026-04-28T07:26:15.254099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c9b4049ccf4190cf elected leader c9b4049ccf4190cf at term 2"} {"level":"info","ts":"2026-04-28T07:26:15.255952Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c9b4049ccf4190cf","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.202:2379]}","request-path":"/0/members/c9b4049ccf4190cf/attributes","cluster-id":"2bc66bd50b26302c","publish-timeout":"7s"} {"level":"info","ts":"2026-04-28T07:26:15.256092Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T07:26:15.25622Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T07:26:15.256031Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T07:26:15.257735Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bc66bd50b26302c","local-member-id":"c9b4049ccf4190cf","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T07:26:15.257888Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T07:26:15.257962Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T07:26:15.261114Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-28T07:26:15.263193Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.202:2379"} {"level":"info","ts":"2026-04-28T07:26:15.263244Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-28T07:26:15.263428Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-28T07:26:19.972172Z","caller":"traceutil/trace.go:171","msg":"trace[1280252766] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"151.524724ms","start":"2026-04-28T07:26:19.820616Z","end":"2026-04-28T07:26:19.972141Z","steps":["trace[1280252766] 'process raft request' (duration: 105.207326ms)","trace[1280252766] 'compare' (duration: 46.11596ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:26:20.861259Z","caller":"traceutil/trace.go:171","msg":"trace[1591863163] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"166.137846ms","start":"2026-04-28T07:26:20.695079Z","end":"2026-04-28T07:26:20.861217Z","steps":["trace[1591863163] 'process raft request' (duration: 86.81824ms)","trace[1591863163] 'compare' (duration: 78.93633ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:26:20.890061Z","caller":"traceutil/trace.go:171","msg":"trace[914058032] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"194.63741ms","start":"2026-04-28T07:26:20.695385Z","end":"2026-04-28T07:26:20.890022Z","steps":["trace[914058032] 'process raft request' (duration: 194.40926ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:20.890507Z","caller":"traceutil/trace.go:171","msg":"trace[427620758] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"182.331987ms","start":"2026-04-28T07:26:20.708144Z","end":"2026-04-28T07:26:20.890476Z","steps":["trace[427620758] 'process raft request' (duration: 181.770322ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:20.890554Z","caller":"traceutil/trace.go:171","msg":"trace[676401377] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"182.319036ms","start":"2026-04-28T07:26:20.708213Z","end":"2026-04-28T07:26:20.890532Z","steps":["trace[676401377] 'process raft request' (duration: 182.145449ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:20.890608Z","caller":"traceutil/trace.go:171","msg":"trace[167375749] transaction","detail":"{read_only:false; number_of_response:0; response_revision:283; }","duration":"141.290059ms","start":"2026-04-28T07:26:20.749284Z","end":"2026-04-28T07:26:20.890574Z","steps":["trace[167375749] 'process raft request' (duration: 141.128862ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:20.890755Z","caller":"traceutil/trace.go:171","msg":"trace[579079837] transaction","detail":"{read_only:false; number_of_response:0; response_revision:283; }","duration":"121.248271ms","start":"2026-04-28T07:26:20.769492Z","end":"2026-04-28T07:26:20.89074Z","steps":["trace[579079837] 'process raft request' (duration: 120.965349ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:20.891017Z","caller":"traceutil/trace.go:171","msg":"trace[195789285] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"119.36792ms","start":"2026-04-28T07:26:20.771639Z","end":"2026-04-28T07:26:20.891007Z","steps":["trace[195789285] 'process raft request' (duration: 119.236974ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:20.891138Z","caller":"traceutil/trace.go:171","msg":"trace[749441868] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"119.176561ms","start":"2026-04-28T07:26:20.771953Z","end":"2026-04-28T07:26:20.891129Z","steps":["trace[749441868] 'process raft request' (duration: 119.054086ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:20.891122Z","caller":"traceutil/trace.go:171","msg":"trace[1363054665] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"119.325228ms","start":"2026-04-28T07:26:20.771768Z","end":"2026-04-28T07:26:20.891093Z","steps":["trace[1363054665] 'process raft request' (duration: 119.184072ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:20.891148Z","caller":"traceutil/trace.go:171","msg":"trace[1463280829] linearizableReadLoop","detail":"{readStateIndex:290; appliedIndex:285; }","duration":"139.564854ms","start":"2026-04-28T07:26:20.751558Z","end":"2026-04-28T07:26:20.891123Z","steps":["trace[1463280829] 'read index received' (duration: 30.350134ms)","trace[1463280829] 'applied index is now lower than readState.Index' (duration: 109.21335ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:26:20.891231Z","caller":"traceutil/trace.go:171","msg":"trace[749374963] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"118.888649ms","start":"2026-04-28T07:26:20.772328Z","end":"2026-04-28T07:26:20.891217Z","steps":["trace[749374963] 'process raft request' (duration: 118.738502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:20.891347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.750172ms","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-28T07:26:20.891431Z","caller":"traceutil/trace.go:171","msg":"trace[1687900194] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:287; }","duration":"139.898788ms","start":"2026-04-28T07:26:20.75152Z","end":"2026-04-28T07:26:20.891418Z","steps":["trace[1687900194] 'agreement among raft nodes before linearized reading' (duration: 139.716311ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:20.927576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.944218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-28T07:26:20.92761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.111944ms","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-28T07:26:20.927664Z","caller":"traceutil/trace.go:171","msg":"trace[72975444] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:288; }","duration":"154.197818ms","start":"2026-04-28T07:26:20.773451Z","end":"2026-04-28T07:26:20.927649Z","steps":["trace[72975444] 'agreement among raft nodes before linearized reading' (duration: 154.081143ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:20.927653Z","caller":"traceutil/trace.go:171","msg":"trace[1698655800] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:288; }","duration":"154.041061ms","start":"2026-04-28T07:26:20.773594Z","end":"2026-04-28T07:26:20.927635Z","steps":["trace[1698655800] 'agreement among raft nodes before linearized reading' (duration: 153.903235ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:21.036836Z","caller":"traceutil/trace.go:171","msg":"trace[638837212] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"105.338624ms","start":"2026-04-28T07:26:20.931441Z","end":"2026-04-28T07:26:21.036779Z","steps":["trace[638837212] 'process raft request' (duration: 55.351677ms)","trace[638837212] 'compare' (duration: 49.488985ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:26:21.037128Z","caller":"traceutil/trace.go:171","msg":"trace[583428664] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"104.172505ms","start":"2026-04-28T07:26:20.932751Z","end":"2026-04-28T07:26:21.036923Z","steps":["trace[583428664] 'process raft request' (duration: 103.928135ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:21.036932Z","caller":"traceutil/trace.go:171","msg":"trace[1319576394] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"104.123532ms","start":"2026-04-28T07:26:20.932768Z","end":"2026-04-28T07:26:21.036892Z","steps":["trace[1319576394] 'process raft request' (duration: 104.015097ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:21.834763Z","caller":"traceutil/trace.go:171","msg":"trace[602963064] linearizableReadLoop","detail":"{readStateIndex:321; appliedIndex:320; }","duration":"150.840292ms","start":"2026-04-28T07:26:21.683892Z","end":"2026-04-28T07:26:21.834732Z","steps":["trace[602963064] 'read index received' (duration: 150.619433ms)","trace[602963064] 'applied index is now lower than readState.Index' (duration: 219.619µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:26:21.834988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.066591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3980"} {"level":"info","ts":"2026-04-28T07:26:21.835048Z","caller":"traceutil/trace.go:171","msg":"trace[1864550964] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:313; }","duration":"151.183917ms","start":"2026-04-28T07:26:21.683846Z","end":"2026-04-28T07:26:21.83503Z","steps":["trace[1864550964] 'agreement among raft nodes before linearized reading' (duration: 151.007699ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:21.835076Z","caller":"traceutil/trace.go:171","msg":"trace[184516636] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"203.178523ms","start":"2026-04-28T07:26:21.631864Z","end":"2026-04-28T07:26:21.835042Z","steps":["trace[184516636] 'process raft request' (duration: 202.703213ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:21.844471Z","caller":"traceutil/trace.go:171","msg":"trace[1184842527] transaction","detail":"{read_only:false; number_of_response:0; response_revision:313; }","duration":"159.003421ms","start":"2026-04-28T07:26:21.685453Z","end":"2026-04-28T07:26:21.844456Z","steps":["trace[1184842527] 'process raft request' (duration: 158.619594ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:21.844635Z","caller":"traceutil/trace.go:171","msg":"trace[225170636] transaction","detail":"{read_only:false; number_of_response:0; response_revision:313; }","duration":"158.402495ms","start":"2026-04-28T07:26:21.686223Z","end":"2026-04-28T07:26:21.844625Z","steps":["trace[225170636] 'process raft request' (duration: 157.906973ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:21.844775Z","caller":"traceutil/trace.go:171","msg":"trace[2117226677] transaction","detail":"{read_only:false; number_of_response:0; response_revision:313; }","duration":"157.388623ms","start":"2026-04-28T07:26:21.687376Z","end":"2026-04-28T07:26:21.844765Z","steps":["trace[2117226677] 'process raft request' (duration: 156.785237ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:21.844992Z","caller":"traceutil/trace.go:171","msg":"trace[927479424] transaction","detail":"{read_only:false; number_of_response:0; response_revision:313; }","duration":"157.529499ms","start":"2026-04-28T07:26:21.687448Z","end":"2026-04-28T07:26:21.844978Z","steps":["trace[927479424] 'process raft request' (duration: 156.741785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:24.497103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.472999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T07:26:24.497324Z","caller":"traceutil/trace.go:171","msg":"trace[1566857286] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/statefulset-controller; range_end:; response_count:0; response_revision:337; }","duration":"115.780771ms","start":"2026-04-28T07:26:24.381511Z","end":"2026-04-28T07:26:24.497292Z","steps":["trace[1566857286] 'range keys from in-memory index tree' (duration: 115.353603ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:24.957395Z","caller":"traceutil/trace.go:171","msg":"trace[1720336206] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"263.782747ms","start":"2026-04-28T07:26:24.693551Z","end":"2026-04-28T07:26:24.957334Z","steps":["trace[1720336206] 'process raft request' (duration: 263.637941ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:24.971043Z","caller":"traceutil/trace.go:171","msg":"trace[1151359087] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"277.206294ms","start":"2026-04-28T07:26:24.693816Z","end":"2026-04-28T07:26:24.971022Z","steps":["trace[1151359087] 'process raft request' (duration: 277.071728ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:24.97116Z","caller":"traceutil/trace.go:171","msg":"trace[2003306368] linearizableReadLoop","detail":"{readStateIndex:354; appliedIndex:351; }","duration":"239.738571ms","start":"2026-04-28T07:26:24.731409Z","end":"2026-04-28T07:26:24.971148Z","steps":["trace[2003306368] 'read index received' (duration: 225.828544ms)","trace[2003306368] 'applied index is now lower than readState.Index' (duration: 13.909127ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:26:24.971287Z","caller":"traceutil/trace.go:171","msg":"trace[1799063774] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"277.214915ms","start":"2026-04-28T07:26:24.694035Z","end":"2026-04-28T07:26:24.97125Z","steps":["trace[1799063774] 'process raft request' (duration: 276.940044ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:24.971486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.979181ms","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-28T07:26:24.971526Z","caller":"traceutil/trace.go:171","msg":"trace[228349256] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:342; }","duration":"240.149477ms","start":"2026-04-28T07:26:24.731367Z","end":"2026-04-28T07:26:24.971517Z","steps":["trace[228349256] 'agreement among raft nodes before linearized reading' (duration: 239.96299ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:24.971502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.308629ms","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-28T07:26:24.971593Z","caller":"traceutil/trace.go:171","msg":"trace[1332210104] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:342; }","duration":"189.462575ms","start":"2026-04-28T07:26:24.782106Z","end":"2026-04-28T07:26:24.971568Z","steps":["trace[1332210104] 'agreement among raft nodes before linearized reading' (duration: 189.292638ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:24.972176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.682163ms","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-28T07:26:24.972221Z","caller":"traceutil/trace.go:171","msg":"trace[1196937518] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:342; }","duration":"140.779297ms","start":"2026-04-28T07:26:24.831429Z","end":"2026-04-28T07:26:24.972208Z","steps":["trace[1196937518] 'agreement among raft nodes before linearized reading' (duration: 140.646462ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:25.267853Z","caller":"traceutil/trace.go:171","msg":"trace[1122613933] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"127.548982ms","start":"2026-04-28T07:26:25.14021Z","end":"2026-04-28T07:26:25.267759Z","steps":["trace[1122613933] 'process raft request' (duration: 63.130099ms)","trace[1122613933] 'compare' (duration: 64.006827ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:26:25.639051Z","caller":"traceutil/trace.go:171","msg":"trace[1459236057] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"276.782514ms","start":"2026-04-28T07:26:25.362213Z","end":"2026-04-28T07:26:25.638996Z","steps":["trace[1459236057] 'process raft request' (duration: 226.106665ms)","trace[1459236057] 'compare' (duration: 50.336175ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:26:25.639316Z","caller":"traceutil/trace.go:171","msg":"trace[1140055130] linearizableReadLoop","detail":"{readStateIndex:369; appliedIndex:365; }","duration":"256.999932ms","start":"2026-04-28T07:26:25.382263Z","end":"2026-04-28T07:26:25.639263Z","steps":["trace[1140055130] 'read index received' (duration: 29.149676ms)","trace[1140055130] 'applied index is now lower than readState.Index' (duration: 227.848956ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:26:25.639429Z","caller":"traceutil/trace.go:171","msg":"trace[1294291795] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"272.699425ms","start":"2026-04-28T07:26:25.3667Z","end":"2026-04-28T07:26:25.6394Z","steps":["trace[1294291795] 'process raft request' (duration: 272.406454ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:25.639212Z","caller":"traceutil/trace.go:171","msg":"trace[1979446315] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"274.930247ms","start":"2026-04-28T07:26:25.364216Z","end":"2026-04-28T07:26:25.639146Z","steps":["trace[1979446315] 'process raft request' (duration: 274.688728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:25.64031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.758982ms","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-28T07:26:25.639801Z","caller":"traceutil/trace.go:171","msg":"trace[685507437] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"197.402648ms","start":"2026-04-28T07:26:25.442341Z","end":"2026-04-28T07:26:25.639744Z","steps":["trace[685507437] 'process raft request' (duration: 196.862326ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:25.640416Z","caller":"traceutil/trace.go:171","msg":"trace[844123787] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:360; }","duration":"207.907429ms","start":"2026-04-28T07:26:25.43248Z","end":"2026-04-28T07:26:25.640388Z","steps":["trace[844123787] 'agreement among raft nodes before linearized reading' (duration: 207.689009ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:25.639925Z","caller":"traceutil/trace.go:171","msg":"trace[101721091] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"197.382117ms","start":"2026-04-28T07:26:25.442515Z","end":"2026-04-28T07:26:25.639897Z","steps":["trace[101721091] 'process raft request' (duration: 197.005531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:25.640712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.438101ms","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-28T07:26:25.64077Z","caller":"traceutil/trace.go:171","msg":"trace[1105329691] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:360; }","duration":"258.523414ms","start":"2026-04-28T07:26:25.382229Z","end":"2026-04-28T07:26:25.640753Z","steps":["trace[1105329691] 'agreement among raft nodes before linearized reading' (duration: 257.183659ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:25.640951Z","caller":"traceutil/trace.go:171","msg":"trace[1703706557] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"196.474919ms","start":"2026-04-28T07:26:25.444461Z","end":"2026-04-28T07:26:25.640936Z","steps":["trace[1703706557] 'process raft request' (duration: 195.320133ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:25.641538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.625776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-04-28T07:26:25.641655Z","caller":"traceutil/trace.go:171","msg":"trace[1797927200] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:360; }","duration":"158.792403ms","start":"2026-04-28T07:26:25.482839Z","end":"2026-04-28T07:26:25.641631Z","steps":["trace[1797927200] 'agreement among raft nodes before linearized reading' (duration: 158.553023ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:25.642918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.922058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-04-28T07:26:25.643056Z","caller":"traceutil/trace.go:171","msg":"trace[1399615566] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:360; }","duration":"110.45597ms","start":"2026-04-28T07:26:25.532554Z","end":"2026-04-28T07:26:25.64301Z","steps":["trace[1399615566] 'agreement among raft nodes before linearized reading' (duration: 108.828554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:26.154299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.379687ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-28T07:26:26.154598Z","caller":"traceutil/trace.go:171","msg":"trace[818315499] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"422.465612ms","start":"2026-04-28T07:26:25.732103Z","end":"2026-04-28T07:26:26.154569Z","steps":["trace[818315499] 'process raft request' (duration: 138.305123ms)","trace[818315499] 'compare' (duration: 282.611726ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:26:26.154752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:25.73208Z","time spent":"422.595337ms","remote":"127.0.0.1:39888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":172,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T07:26:26.154801Z","caller":"traceutil/trace.go:171","msg":"trace[317828363] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"416.773237ms","start":"2026-04-28T07:26:25.738009Z","end":"2026-04-28T07:26:26.154782Z","steps":["trace[317828363] 'process raft request' (duration: 416.696114ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:26.154832Z","caller":"traceutil/trace.go:171","msg":"trace[180585644] linearizableReadLoop","detail":"{readStateIndex:382; appliedIndex:381; }","duration":"422.472862ms","start":"2026-04-28T07:26:25.7323Z","end":"2026-04-28T07:26:26.154773Z","steps":["trace[180585644] 'read index received' (duration: 137.992881ms)","trace[180585644] 'applied index is now lower than readState.Index' (duration: 284.391747ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:26:26.155075Z","caller":"traceutil/trace.go:171","msg":"trace[830818433] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"422.001142ms","start":"2026-04-28T07:26:25.73302Z","end":"2026-04-28T07:26:26.155021Z","steps":["trace[830818433] 'process raft request' (duration: 421.496002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:26.155204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.896149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2901"} {"level":"warn","ts":"2026-04-28T07:26:26.155237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:25.732988Z","time spent":"422.1802ms","remote":"127.0.0.1:39740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":654,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T07:26:26.155273Z","caller":"traceutil/trace.go:171","msg":"trace[404424624] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:373; }","duration":"422.998793ms","start":"2026-04-28T07:26:25.732261Z","end":"2026-04-28T07:26:26.15526Z","steps":["trace[404424624] 'agreement among raft nodes before linearized reading' (duration: 422.765194ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:26.155341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:25.73225Z","time spent":"423.078506ms","remote":"127.0.0.1:40148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":2924,"request content":"key:\"/registry/daemonsets/kube-system/kube-proxy\" "} {"level":"warn","ts":"2026-04-28T07:26:26.155517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.585126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-04-28T07:26:26.155603Z","caller":"traceutil/trace.go:171","msg":"trace[1271571579] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:373; }","duration":"353.743602ms","start":"2026-04-28T07:26:25.801842Z","end":"2026-04-28T07:26:26.155585Z","steps":["trace[1271571579] 'agreement among raft nodes before linearized reading' (duration: 353.514292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:26.155653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:25.801811Z","time spent":"353.831226ms","remote":"127.0.0.1:39888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":208,"request content":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" "} {"level":"warn","ts":"2026-04-28T07:26:26.154944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:25.738003Z","time spent":"416.899524ms","remote":"127.0.0.1:39864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T07:26:26.154913Z","caller":"traceutil/trace.go:171","msg":"trace[739314245] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"421.117977ms","start":"2026-04-28T07:26:25.733737Z","end":"2026-04-28T07:26:26.154855Z","steps":["trace[739314245] 'process raft request' (duration: 420.898177ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:26.15655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:25.733717Z","time spent":"422.787744ms","remote":"127.0.0.1:39784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1739,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T07:26:26.591502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.629016ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-28T07:26:26.591923Z","caller":"traceutil/trace.go:171","msg":"trace[1621120593] linearizableReadLoop","detail":"{readStateIndex:389; appliedIndex:385; }","duration":"429.73863ms","start":"2026-04-28T07:26:26.162166Z","end":"2026-04-28T07:26:26.591904Z","steps":["trace[1621120593] 'read index received' (duration: 168.650395ms)","trace[1621120593] 'applied index is now lower than readState.Index' (duration: 261.087225ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:26:26.592012Z","caller":"traceutil/trace.go:171","msg":"trace[1059772363] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"433.503442ms","start":"2026-04-28T07:26:26.158486Z","end":"2026-04-28T07:26:26.59199Z","steps":["trace[1059772363] 'process raft request' (duration: 172.308863ms)","trace[1059772363] 'compare' (duration: 260.47685ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:26:26.592092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:26.158449Z","time spent":"433.609366ms","remote":"127.0.0.1:39888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":164,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T07:26:26.592162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.98755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2901"} {"level":"info","ts":"2026-04-28T07:26:26.592016Z","caller":"traceutil/trace.go:171","msg":"trace[2066982876] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"426.531499ms","start":"2026-04-28T07:26:26.165473Z","end":"2026-04-28T07:26:26.592005Z","steps":["trace[2066982876] 'process raft request' (duration: 426.346402ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:26.592031Z","caller":"traceutil/trace.go:171","msg":"trace[2097666862] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"425.417295ms","start":"2026-04-28T07:26:26.166604Z","end":"2026-04-28T07:26:26.592021Z","steps":["trace[2097666862] 'process raft request' (duration: 425.250388ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:26.592314Z","caller":"traceutil/trace.go:171","msg":"trace[1286861146] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"429.98073ms","start":"2026-04-28T07:26:26.162325Z","end":"2026-04-28T07:26:26.592305Z","steps":["trace[1286861146] 'process raft request' (duration: 429.407827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:26.592473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:26.162317Z","time spent":"430.111486ms","remote":"127.0.0.1:39864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T07:26:26.592549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:26.165464Z","time spent":"427.041361ms","remote":"127.0.0.1:39740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":754,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T07:26:26.592581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:26.166593Z","time spent":"425.712786ms","remote":"127.0.0.1:39864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4001,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T07:26:26.59255Z","caller":"traceutil/trace.go:171","msg":"trace[722183188] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"431.091205ms","start":"2026-04-28T07:26:26.161411Z","end":"2026-04-28T07:26:26.592502Z","steps":["trace[722183188] 'process raft request' (duration: 430.289331ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:26.592448Z","caller":"traceutil/trace.go:171","msg":"trace[1756302065] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"431.774163ms","start":"2026-04-28T07:26:26.160661Z","end":"2026-04-28T07:26:26.592435Z","steps":["trace[1756302065] 'process raft request' (duration: 431.000051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:26.592749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:26.161397Z","time spent":"431.257722ms","remote":"127.0.0.1:39740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T07:26:26.592236Z","caller":"traceutil/trace.go:171","msg":"trace[1722858842] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:380; }","duration":"430.099784ms","start":"2026-04-28T07:26:26.162124Z","end":"2026-04-28T07:26:26.592224Z","steps":["trace[1722858842] 'agreement among raft nodes before linearized reading' (duration: 429.925397ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:26.592826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:26.162111Z","time spent":"430.703279ms","remote":"127.0.0.1:40148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":2924,"request content":"key:\"/registry/daemonsets/kube-system/kube-proxy\" "} {"level":"info","ts":"2026-04-28T07:26:26.593024Z","caller":"traceutil/trace.go:171","msg":"trace[407937951] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"432.540122ms","start":"2026-04-28T07:26:26.160468Z","end":"2026-04-28T07:26:26.593008Z","steps":["trace[407937951] 'process raft request' (duration: 431.136455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:26.593166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:26.160455Z","time spent":"432.616356ms","remote":"127.0.0.1:39784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1731,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T07:26:26.593343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:26.160637Z","time spent":"432.055394ms","remote":"127.0.0.1:39740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T07:26:27.218313Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10434732391124627276,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T07:26:27.514356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.670359ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-28T07:26:27.514552Z","caller":"traceutil/trace.go:171","msg":"trace[566553769] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"917.400466ms","start":"2026-04-28T07:26:26.597064Z","end":"2026-04-28T07:26:27.514464Z","steps":["trace[566553769] 'process raft request' (duration: 756.488906ms)","trace[566553769] 'compare' (duration: 160.284005ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:26:27.514678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:26.597039Z","time spent":"917.600024ms","remote":"127.0.0.1:39888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":164,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T07:26:27.52654Z","caller":"traceutil/trace.go:171","msg":"trace[1926948433] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"929.166807ms","start":"2026-04-28T07:26:26.59735Z","end":"2026-04-28T07:26:27.526517Z","steps":["trace[1926948433] 'process raft request' (duration: 928.979099ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:27.526698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:26.597343Z","time spent":"929.270071ms","remote":"127.0.0.1:39938","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-28T07:26:27.52679Z","caller":"traceutil/trace.go:171","msg":"trace[1999731487] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"929.148426ms","start":"2026-04-28T07:26:26.597621Z","end":"2026-04-28T07:26:27.526769Z","steps":["trace[1999731487] 'process raft request' (duration: 928.852575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:27.526864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:26.597607Z","time spent":"929.225429ms","remote":"127.0.0.1:39740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T07:26:27.526863Z","caller":"traceutil/trace.go:171","msg":"trace[1135075414] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"929.041002ms","start":"2026-04-28T07:26:26.597804Z","end":"2026-04-28T07:26:27.526845Z","steps":["trace[1135075414] 'process raft request' (duration: 928.836165ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:27.526923Z","caller":"traceutil/trace.go:171","msg":"trace[971969282] linearizableReadLoop","detail":"{readStateIndex:400; appliedIndex:392; }","duration":"809.487431ms","start":"2026-04-28T07:26:26.717418Z","end":"2026-04-28T07:26:27.526906Z","steps":["trace[971969282] 'read index received' (duration: 636.203015ms)","trace[971969282] 'applied index is now lower than readState.Index' (duration: 173.283166ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:26:27.527009Z","caller":"traceutil/trace.go:171","msg":"trace[1665576292] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"927.02242ms","start":"2026-04-28T07:26:26.599977Z","end":"2026-04-28T07:26:27.526999Z","steps":["trace[1665576292] 'process raft request' (duration: 926.847864ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:27.526975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:26.597795Z","time spent":"929.143236ms","remote":"127.0.0.1:39784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1731,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T07:26:27.527072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:26.599967Z","time spent":"927.064062ms","remote":"127.0.0.1:39864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4001,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T07:26:27.527128Z","caller":"traceutil/trace.go:171","msg":"trace[2019789236] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"927.449438ms","start":"2026-04-28T07:26:26.599665Z","end":"2026-04-28T07:26:27.527114Z","steps":["trace[2019789236] 'process raft request' (duration: 927.119684ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:27.527172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:26.599658Z","time spent":"927.491039ms","remote":"127.0.0.1:39740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T07:26:27.527261Z","caller":"traceutil/trace.go:171","msg":"trace[1691254327] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"928.647356ms","start":"2026-04-28T07:26:26.598607Z","end":"2026-04-28T07:26:27.527254Z","steps":["trace[1691254327] 'process raft request' (duration: 928.121155ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:27.527275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"809.860706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-proxy-lmq4f.18aa7494fada155a\" ","response":"range_response_count:1 size:769"} {"level":"warn","ts":"2026-04-28T07:26:27.527319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:26.598595Z","time spent":"928.679818ms","remote":"127.0.0.1:40150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3759,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T07:26:27.527333Z","caller":"traceutil/trace.go:171","msg":"trace[1582409578] range","detail":"{range_begin:/registry/events/kube-system/kube-proxy-lmq4f.18aa7494fada155a; range_end:; response_count:1; response_revision:388; }","duration":"809.943019ms","start":"2026-04-28T07:26:26.717362Z","end":"2026-04-28T07:26:27.527305Z","steps":["trace[1582409578] 'agreement among raft nodes before linearized reading' (duration: 809.858776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:27.527366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:26.717339Z","time spent":"810.020192ms","remote":"127.0.0.1:39740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":792,"request content":"key:\"/registry/events/kube-system/kube-proxy-lmq4f.18aa7494fada155a\" "} {"level":"warn","ts":"2026-04-28T07:26:27.527439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.698228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-28T07:26:27.52747Z","caller":"traceutil/trace.go:171","msg":"trace[145924228] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:388; }","duration":"408.74772ms","start":"2026-04-28T07:26:27.118712Z","end":"2026-04-28T07:26:27.527459Z","steps":["trace[145924228] 'agreement among raft nodes before linearized reading' (duration: 408.692628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:27.527498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:27.118702Z","time spent":"408.789631ms","remote":"127.0.0.1:39938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-28T07:26:27.527555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.950139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-28T07:26:27.527579Z","caller":"traceutil/trace.go:171","msg":"trace[1116684951] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"412.620095ms","start":"2026-04-28T07:26:27.114949Z","end":"2026-04-28T07:26:27.527569Z","steps":["trace[1116684951] 'process raft request' (duration: 411.921287ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:27.527596Z","caller":"traceutil/trace.go:171","msg":"trace[303474214] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:388; }","duration":"414.011621ms","start":"2026-04-28T07:26:27.113575Z","end":"2026-04-28T07:26:27.527587Z","steps":["trace[303474214] 'agreement among raft nodes before linearized reading' (duration: 413.936008ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:27.527625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:27.113564Z","time spent":"414.051492ms","remote":"127.0.0.1:39938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-28T07:26:27.527637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:27.114924Z","time spent":"412.678898ms","remote":"127.0.0.1:39938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T07:26:27.527323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.791772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-28T07:26:27.52773Z","caller":"traceutil/trace.go:171","msg":"trace[771193665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:388; }","duration":"414.24186ms","start":"2026-04-28T07:26:27.113476Z","end":"2026-04-28T07:26:27.527718Z","steps":["trace[771193665] 'agreement among raft nodes before linearized reading' (duration: 413.781802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:27.527773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:27.113451Z","time spent":"414.311564ms","remote":"127.0.0.1:39938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-28T07:26:28.811749Z","caller":"traceutil/trace.go:171","msg":"trace[2044679653] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"103.369266ms","start":"2026-04-28T07:26:28.708362Z","end":"2026-04-28T07:26:28.811732Z","steps":["trace[2044679653] 'process raft request' (duration: 103.255092ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:29.824024Z","caller":"traceutil/trace.go:171","msg":"trace[297494091] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"226.424461ms","start":"2026-04-28T07:26:29.597547Z","end":"2026-04-28T07:26:29.823972Z","steps":["trace[297494091] 'process raft request' (duration: 151.926922ms)","trace[297494091] 'compare' (duration: 74.291291ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:26:29.824245Z","caller":"traceutil/trace.go:171","msg":"trace[1274383724] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"226.520956ms","start":"2026-04-28T07:26:29.597681Z","end":"2026-04-28T07:26:29.824202Z","steps":["trace[1274383724] 'process raft request' (duration: 226.239664ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:29.824462Z","caller":"traceutil/trace.go:171","msg":"trace[377829461] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"226.650781ms","start":"2026-04-28T07:26:29.597793Z","end":"2026-04-28T07:26:29.824444Z","steps":["trace[377829461] 'process raft request' (duration: 226.345529ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:31.425497Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10434732391124627317,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T07:26:31.926435Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10434732391124627317,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T07:26:32.427116Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10434732391124627317,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T07:26:32.523353Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.842871009s","expected-duration":"1s"} {"level":"info","ts":"2026-04-28T07:26:32.523656Z","caller":"traceutil/trace.go:171","msg":"trace[540473962] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"1.843316785s","start":"2026-04-28T07:26:30.68032Z","end":"2026-04-28T07:26:32.523636Z","steps":["trace[540473962] 'process raft request' (duration: 1.84319454s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:32.52383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:30.680291Z","time spent":"1.843476323s","remote":"127.0.0.1:39864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4649,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T07:26:32.925813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000506079s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-28T07:26:32.92597Z","caller":"traceutil/trace.go:171","msg":"trace[475597050] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000712606s","start":"2026-04-28T07:26:30.925238Z","end":"2026-04-28T07:26:32.925951Z","steps":["trace[475597050] 'agreement among raft nodes before linearized reading' (duration: 2.000502989s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:32.926027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:30.925182Z","time spent":"2.000830281s","remote":"127.0.0.1:39656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/28 07:26:32 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-28T07:26:33.764541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.010152899s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T07:26:33.764795Z","caller":"traceutil/trace.go:171","msg":"trace[1244279988] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"835.219644ms","start":"2026-04-28T07:26:32.929542Z","end":"2026-04-28T07:26:33.764762Z","steps":["trace[1244279988] 'process raft request' (duration: 835.1282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:33.76487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:32.929517Z","time spent":"835.321787ms","remote":"127.0.0.1:39740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":757,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T07:26:33.765533Z","caller":"traceutil/trace.go:171","msg":"trace[2113403430] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"2.696768188s","start":"2026-04-28T07:26:31.068746Z","end":"2026-04-28T07:26:33.765514Z","steps":["trace[2113403430] 'process raft request' (duration: 1.68556127s)","trace[2113403430] 'compare' (duration: 1.009472913s)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:26:33.765614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:31.068718Z","time spent":"2.696851071s","remote":"127.0.0.1:39938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T07:26:33.765837Z","caller":"traceutil/trace.go:171","msg":"trace[652622269] linearizableReadLoop","detail":"{readStateIndex:421; appliedIndex:419; }","duration":"2.840540686s","start":"2026-04-28T07:26:30.925244Z","end":"2026-04-28T07:26:33.765785Z","steps":["trace[652622269] 'read index received' (duration: 1.598260574s)","trace[652622269] 'applied index is now lower than readState.Index' (duration: 1.242278582s)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:26:33.766092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.616987195s","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-28T07:26:33.766185Z","caller":"traceutil/trace.go:171","msg":"trace[960829321] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:408; }","duration":"2.617067538s","start":"2026-04-28T07:26:31.149091Z","end":"2026-04-28T07:26:33.766159Z","steps":["trace[960829321] 'agreement among raft nodes before linearized reading' (duration: 2.616970905s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:33.766603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.239847589s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"info","ts":"2026-04-28T07:26:33.76669Z","caller":"traceutil/trace.go:171","msg":"trace[1905713901] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:408; }","duration":"1.240032485s","start":"2026-04-28T07:26:32.52662Z","end":"2026-04-28T07:26:33.766653Z","steps":["trace[1905713901] 'agreement among raft nodes before linearized reading' (duration: 1.239832408s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:33.766745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:32.526601Z","time spent":"1.240129239s","remote":"127.0.0.1:39864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6988,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"warn","ts":"2026-04-28T07:26:33.766985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.93008011s","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-28T07:26:33.76704Z","caller":"traceutil/trace.go:171","msg":"trace[277100589] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:408; }","duration":"1.930144463s","start":"2026-04-28T07:26:31.836872Z","end":"2026-04-28T07:26:33.767017Z","steps":["trace[277100589] 'agreement among raft nodes before linearized reading' (duration: 1.93005508s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:33.76707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:31.836861Z","time spent":"1.930201466s","remote":"127.0.0.1:39938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-28T07:26:33.767261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.936916395s","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-28T07:26:33.767309Z","caller":"traceutil/trace.go:171","msg":"trace[1751197806] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:408; }","duration":"1.936994277s","start":"2026-04-28T07:26:31.830294Z","end":"2026-04-28T07:26:33.767288Z","steps":["trace[1751197806] 'agreement among raft nodes before linearized reading' (duration: 1.936922225s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:33.767339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:31.830271Z","time spent":"1.93705946s","remote":"127.0.0.1:39938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-28T07:26:33.767521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.937186774s","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-28T07:26:33.767573Z","caller":"traceutil/trace.go:171","msg":"trace[23721727] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:408; }","duration":"1.937259257s","start":"2026-04-28T07:26:31.830288Z","end":"2026-04-28T07:26:33.767547Z","steps":["trace[23721727] 'agreement among raft nodes before linearized reading' (duration: 1.937196874s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:33.767606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:31.830267Z","time spent":"1.937331619s","remote":"127.0.0.1:39938","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-28T07:26:33.767793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.171340009s","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-28T07:26:33.767843Z","caller":"traceutil/trace.go:171","msg":"trace[1586670881] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:408; }","duration":"2.171425732s","start":"2026-04-28T07:26:31.596396Z","end":"2026-04-28T07:26:33.767822Z","steps":["trace[1586670881] 'agreement among raft nodes before linearized reading' (duration: 2.171358018s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:33.767873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:31.596318Z","time spent":"2.171546456s","remote":"127.0.0.1:39938","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-28T07:26:34.546756Z","caller":"traceutil/trace.go:171","msg":"trace[1401795] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"773.005878ms","start":"2026-04-28T07:26:33.773725Z","end":"2026-04-28T07:26:34.546731Z","steps":["trace[1401795] 'process raft request' (duration: 771.97517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:34.546915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:33.773702Z","time spent":"773.127433ms","remote":"127.0.0.1:39938","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-28T07:26:34.549826Z","caller":"traceutil/trace.go:171","msg":"trace[962678823] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"775.547763ms","start":"2026-04-28T07:26:33.774251Z","end":"2026-04-28T07:26:34.549799Z","steps":["trace[962678823] 'process raft request' (duration: 775.326864ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:34.54993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:33.774219Z","time spent":"775.662777ms","remote":"127.0.0.1:39938","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-28T07:26:34.550134Z","caller":"traceutil/trace.go:171","msg":"trace[1247698780] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"773.89272ms","start":"2026-04-28T07:26:33.776227Z","end":"2026-04-28T07:26:34.55012Z","steps":["trace[1247698780] 'process raft request' (duration: 773.670742ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:34.550232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:33.77621Z","time spent":"773.958363ms","remote":"127.0.0.1:39938","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-28T07:26:34.550368Z","caller":"traceutil/trace.go:171","msg":"trace[1871124571] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"773.841258ms","start":"2026-04-28T07:26:33.776482Z","end":"2026-04-28T07:26:34.550323Z","steps":["trace[1871124571] 'process raft request' (duration: 773.595399ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:34.550595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:33.776471Z","time spent":"773.998544ms","remote":"127.0.0.1:39938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T07:26:34.55005Z","caller":"traceutil/trace.go:171","msg":"trace[625272069] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"774.1297ms","start":"2026-04-28T07:26:33.775877Z","end":"2026-04-28T07:26:34.550007Z","steps":["trace[625272069] 'process raft request' (duration: 773.861299ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:34.550906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:33.775856Z","time spent":"774.998002ms","remote":"127.0.0.1:39864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6740,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T07:26:54.319381Z","caller":"traceutil/trace.go:171","msg":"trace[1074290196] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"299.028908ms","start":"2026-04-28T07:26:54.019922Z","end":"2026-04-28T07:26:54.318951Z","steps":["trace[1074290196] 'process raft request' (duration: 298.72835ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:54.326457Z","caller":"traceutil/trace.go:171","msg":"trace[650387103] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"301.420163ms","start":"2026-04-28T07:26:54.025007Z","end":"2026-04-28T07:26:54.326427Z","steps":["trace[650387103] 'process raft request' (duration: 300.332079ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:54.326663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:54.024979Z","time spent":"301.553317ms","remote":"127.0.0.1:39704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T07:26:54.326826Z","caller":"traceutil/trace.go:171","msg":"trace[886106477] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"301.809544ms","start":"2026-04-28T07:26:54.025005Z","end":"2026-04-28T07:26:54.326815Z","steps":["trace[886106477] 'process raft request' (duration: 300.476343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:26:54.326892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:26:54.024974Z","time spent":"301.875966ms","remote":"127.0.0.1:39704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T07:26:54.327011Z","caller":"traceutil/trace.go:171","msg":"trace[826608542] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"296.408178ms","start":"2026-04-28T07:26:54.030594Z","end":"2026-04-28T07:26:54.327002Z","steps":["trace[826608542] 'process raft request' (duration: 294.928273ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:54.32782Z","caller":"traceutil/trace.go:171","msg":"trace[1465367004] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"287.391861ms","start":"2026-04-28T07:26:54.040404Z","end":"2026-04-28T07:26:54.327796Z","steps":["trace[1465367004] 'process raft request' (duration: 285.295596ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:54.327894Z","caller":"traceutil/trace.go:171","msg":"trace[1252921798] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"282.326834ms","start":"2026-04-28T07:26:54.045557Z","end":"2026-04-28T07:26:54.327884Z","steps":["trace[1252921798] 'process raft request' (duration: 280.187299ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:54.327971Z","caller":"traceutil/trace.go:171","msg":"trace[1547483991] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"293.55372ms","start":"2026-04-28T07:26:54.034409Z","end":"2026-04-28T07:26:54.327963Z","steps":["trace[1547483991] 'process raft request' (duration: 291.205998ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:54.327953Z","caller":"traceutil/trace.go:171","msg":"trace[1946631456] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"125.053678ms","start":"2026-04-28T07:26:54.202805Z","end":"2026-04-28T07:26:54.327859Z","steps":["trace[1946631456] 'process raft request' (duration: 123.107877ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:54.328085Z","caller":"traceutil/trace.go:171","msg":"trace[1056683991] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"293.493528ms","start":"2026-04-28T07:26:54.03458Z","end":"2026-04-28T07:26:54.328073Z","steps":["trace[1056683991] 'process raft request' (duration: 291.072004ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:54.327825Z","caller":"traceutil/trace.go:171","msg":"trace[471360923] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"233.341198ms","start":"2026-04-28T07:26:54.094442Z","end":"2026-04-28T07:26:54.327783Z","steps":["trace[471360923] 'process raft request' (duration: 231.398798ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:54.328225Z","caller":"traceutil/trace.go:171","msg":"trace[706248872] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"273.578515ms","start":"2026-04-28T07:26:54.054636Z","end":"2026-04-28T07:26:54.328215Z","steps":["trace[706248872] 'process raft request' (duration: 271.153471ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:26:54.327834Z","caller":"traceutil/trace.go:171","msg":"trace[1902163437] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"293.433166ms","start":"2026-04-28T07:26:54.034371Z","end":"2026-04-28T07:26:54.327804Z","steps":["trace[1902163437] 'process raft request' (duration: 291.192447ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:27:00.447318Z","caller":"traceutil/trace.go:171","msg":"trace[1822058725] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"126.061426ms","start":"2026-04-28T07:27:00.32123Z","end":"2026-04-28T07:27:00.447292Z","steps":["trace[1822058725] 'process raft request' (duration: 57.991861ms)","trace[1822058725] 'compare' (duration: 67.681124ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:27:01.350484Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10434732391124627769,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-28T07:27:01.81561Z","caller":"traceutil/trace.go:171","msg":"trace[1266116955] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"977.304459ms","start":"2026-04-28T07:27:00.838264Z","end":"2026-04-28T07:27:01.815569Z","steps":["trace[1266116955] 'process raft request' (duration: 976.878177ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:01.815748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:00.838242Z","time spent":"977.441633ms","remote":"127.0.0.1:39938","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-28T07:27:02.057288Z","caller":"traceutil/trace.go:171","msg":"trace[1105813127] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"1.208521778s","start":"2026-04-28T07:27:00.848719Z","end":"2026-04-28T07:27:02.057241Z","steps":["trace[1105813127] 'process raft request' (duration: 1.208268741s)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:27:02.057432Z","caller":"traceutil/trace.go:171","msg":"trace[492568643] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"1.219020705s","start":"2026-04-28T07:27:00.838381Z","end":"2026-04-28T07:27:02.057402Z","steps":["trace[492568643] 'process raft request' (duration: 1.218303445s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:02.057608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:00.83836Z","time spent":"1.219144039s","remote":"127.0.0.1:39938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T07:27:02.057831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:00.848699Z","time spent":"1.208669423s","remote":"127.0.0.1:39864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T07:27:02.058274Z","caller":"traceutil/trace.go:171","msg":"trace[1892685970] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:656; }","duration":"1.209158407s","start":"2026-04-28T07:27:00.849056Z","end":"2026-04-28T07:27:02.058215Z","steps":["trace[1892685970] 'read index received' (duration: 966.144544ms)","trace[1892685970] 'applied index is now lower than readState.Index' (duration: 243.012743ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:27:02.058564Z","caller":"traceutil/trace.go:171","msg":"trace[458796460] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"1.130923854s","start":"2026-04-28T07:27:00.927619Z","end":"2026-04-28T07:27:02.058543Z","steps":["trace[458796460] 'process raft request' (duration: 1.129639368s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:02.058822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:00.927591Z","time spent":"1.131036187s","remote":"127.0.0.1:39772","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-28T07:27:02.058938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.19830185s","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-28T07:27:02.059017Z","caller":"traceutil/trace.go:171","msg":"trace[943868413] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:636; }","duration":"1.198414733s","start":"2026-04-28T07:27:00.860583Z","end":"2026-04-28T07:27:02.058998Z","steps":["trace[943868413] 'agreement among raft nodes before linearized reading' (duration: 1.198222568s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:02.059075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:00.860571Z","time spent":"1.198494786s","remote":"127.0.0.1:39938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-28T07:27:02.059329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.210267258s","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-28T07:27:02.059381Z","caller":"traceutil/trace.go:171","msg":"trace[103328117] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:636; }","duration":"1.21033969s","start":"2026-04-28T07:27:00.849028Z","end":"2026-04-28T07:27:02.059367Z","steps":["trace[103328117] 'agreement among raft nodes before linearized reading' (duration: 1.210211886s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:02.059439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:00.849018Z","time spent":"1.210411022s","remote":"127.0.0.1:39938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-28T07:27:02.059367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.816893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T07:27:02.05968Z","caller":"traceutil/trace.go:171","msg":"trace[123012556] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"743.154584ms","start":"2026-04-28T07:27:01.316505Z","end":"2026-04-28T07:27:02.059659Z","steps":["trace[123012556] 'agreement among raft nodes before linearized reading' (duration: 742.813244ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:02.059946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:01.316477Z","time spent":"743.344369ms","remote":"127.0.0.1:39656","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-28T07:27:02.829616Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10434732391124627776,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T07:27:03.105667Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.038169305s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-28T07:27:03.9621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"856.085071ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T07:27:03.962231Z","caller":"traceutil/trace.go:171","msg":"trace[1394608384] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"1.894787669s","start":"2026-04-28T07:27:02.067416Z","end":"2026-04-28T07:27:03.962204Z","steps":["trace[1394608384] 'process raft request' (duration: 1.038491624s)","trace[1394608384] 'compare' (duration: 855.592296ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:27:03.962295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:02.067395Z","time spent":"1.894869592s","remote":"127.0.0.1:39938","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-28T07:27:03.96292Z","caller":"traceutil/trace.go:171","msg":"trace[503145179] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"1.894000436s","start":"2026-04-28T07:27:02.068903Z","end":"2026-04-28T07:27:03.962904Z","steps":["trace[503145179] 'process raft request' (duration: 1.893899774s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:03.963058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:02.068886Z","time spent":"1.894086539s","remote":"127.0.0.1:39938","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-28T07:27:03.963076Z","caller":"traceutil/trace.go:171","msg":"trace[1756597405] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:660; }","duration":"1.634492298s","start":"2026-04-28T07:27:02.328559Z","end":"2026-04-28T07:27:03.963051Z","steps":["trace[1756597405] 'read index received' (duration: 777.387609ms)","trace[1756597405] 'applied index is now lower than readState.Index' (duration: 857.103819ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:27:03.963132Z","caller":"traceutil/trace.go:171","msg":"trace[340169823] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"1.844213481s","start":"2026-04-28T07:27:02.118887Z","end":"2026-04-28T07:27:03.9631Z","steps":["trace[340169823] 'process raft request' (duration: 1.843977873s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:03.963231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.634665213s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T07:27:03.963252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:02.118864Z","time spent":"1.844331234s","remote":"127.0.0.1:39926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T07:27:03.963294Z","caller":"traceutil/trace.go:171","msg":"trace[1910158092] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:639; }","duration":"1.634779976s","start":"2026-04-28T07:27:02.328494Z","end":"2026-04-28T07:27:03.963274Z","steps":["trace[1910158092] 'agreement among raft nodes before linearized reading' (duration: 1.634648113s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:03.963341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:02.328465Z","time spent":"1.634864029s","remote":"127.0.0.1:39656","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-28T07:27:03.976314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.908682ms","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-28T07:27:03.976368Z","caller":"traceutil/trace.go:171","msg":"trace[994056269] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:640; }","duration":"155.002595ms","start":"2026-04-28T07:27:03.821351Z","end":"2026-04-28T07:27:03.976354Z","steps":["trace[994056269] 'agreement among raft nodes before linearized reading' (duration: 154.8667ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:27:17.199993Z","caller":"traceutil/trace.go:171","msg":"trace[1494937041] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"219.335401ms","start":"2026-04-28T07:27:16.980632Z","end":"2026-04-28T07:27:17.199967Z","steps":["trace[1494937041] 'process raft request' (duration: 219.017622ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:27:17.200186Z","caller":"traceutil/trace.go:171","msg":"trace[1917016148] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"216.889698ms","start":"2026-04-28T07:27:16.983263Z","end":"2026-04-28T07:27:17.200152Z","steps":["trace[1917016148] 'process raft request' (duration: 216.641412ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:27:20.008258Z","caller":"traceutil/trace.go:171","msg":"trace[808233775] linearizableReadLoop","detail":"{readStateIndex:820; appliedIndex:819; }","duration":"332.656894ms","start":"2026-04-28T07:27:19.675564Z","end":"2026-04-28T07:27:20.008221Z","steps":["trace[808233775] 'read index received' (duration: 332.265795ms)","trace[808233775] 'applied index is now lower than readState.Index' (duration: 389.409µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:27:20.008393Z","caller":"traceutil/trace.go:171","msg":"trace[1840678078] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"356.824547ms","start":"2026-04-28T07:27:19.651502Z","end":"2026-04-28T07:27:20.008327Z","steps":["trace[1840678078] 'process raft request' (duration: 356.488129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:20.00852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.90684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T07:27:20.008569Z","caller":"traceutil/trace.go:171","msg":"trace[167195601] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:791; }","duration":"333.045955ms","start":"2026-04-28T07:27:19.675512Z","end":"2026-04-28T07:27:20.008558Z","steps":["trace[167195601] 'agreement among raft nodes before linearized reading' (duration: 332.90845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:20.008593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:19.651481Z","time spent":"357.001672ms","remote":"127.0.0.1:39938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T07:27:20.008627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:19.675485Z","time spent":"333.129336ms","remote":"127.0.0.1:40050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-28T07:27:22.90121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.829535ms","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-28T07:27:22.901278Z","caller":"traceutil/trace.go:171","msg":"trace[226798433] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:805; }","duration":"566.904536ms","start":"2026-04-28T07:27:22.334358Z","end":"2026-04-28T07:27:22.901263Z","steps":["trace[226798433] 'range keys from in-memory index tree' (duration: 566.698222ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:22.901309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:22.334316Z","time spent":"566.985309ms","remote":"127.0.0.1:39938","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-28T07:27:22.90121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.238162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-28T07:27:22.90138Z","caller":"traceutil/trace.go:171","msg":"trace[1040093911] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:805; }","duration":"645.438017ms","start":"2026-04-28T07:27:22.255926Z","end":"2026-04-28T07:27:22.901364Z","steps":["trace[1040093911] 'range keys from in-memory index tree' (duration: 645.075618ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:22.901423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:22.255913Z","time spent":"645.499079ms","remote":"127.0.0.1:39938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-28T07:27:22.901435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.57337ms","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-28T07:27:22.901545Z","caller":"traceutil/trace.go:171","msg":"trace[1372656932] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:805; }","duration":"665.722023ms","start":"2026-04-28T07:27:22.235808Z","end":"2026-04-28T07:27:22.90153Z","steps":["trace[1372656932] 'range keys from in-memory index tree' (duration: 665.367275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:22.901598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:22.235793Z","time spent":"665.797025ms","remote":"127.0.0.1:39938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-28T07:27:22.901576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.267406ms","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-28T07:27:22.901892Z","caller":"traceutil/trace.go:171","msg":"trace[1082386320] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:805; }","duration":"567.659295ms","start":"2026-04-28T07:27:22.334213Z","end":"2026-04-28T07:27:22.901872Z","steps":["trace[1082386320] 'range keys from in-memory index tree' (duration: 567.071961ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:22.902017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:22.334193Z","time spent":"567.762928ms","remote":"127.0.0.1:39938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-28T07:27:23.0479Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10434732391124628121,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-28T07:27:23.208783Z","caller":"traceutil/trace.go:171","msg":"trace[1420450835] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"699.960823ms","start":"2026-04-28T07:27:22.5088Z","end":"2026-04-28T07:27:23.20876Z","steps":["trace[1420450835] 'process raft request' (duration: 699.788198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:23.208953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:22.50878Z","time spent":"700.093456ms","remote":"127.0.0.1:39858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4905,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T07:27:23.250253Z","caller":"traceutil/trace.go:171","msg":"trace[2069549054] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"344.901867ms","start":"2026-04-28T07:27:22.905323Z","end":"2026-04-28T07:27:23.250225Z","steps":["trace[2069549054] 'process raft request' (duration: 344.837335ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:27:23.250307Z","caller":"traceutil/trace.go:171","msg":"trace[1103919203] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"345.01773ms","start":"2026-04-28T07:27:22.905255Z","end":"2026-04-28T07:27:23.250273Z","steps":["trace[1103919203] 'process raft request' (duration: 344.787565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:23.250615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:22.905239Z","time spent":"345.274966ms","remote":"127.0.0.1:39938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T07:27:23.250639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:22.905307Z","time spent":"345.093932ms","remote":"127.0.0.1:39938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T07:27:23.25082Z","caller":"traceutil/trace.go:171","msg":"trace[1334074340] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"345.453861ms","start":"2026-04-28T07:27:22.905322Z","end":"2026-04-28T07:27:23.250776Z","steps":["trace[1334074340] 'process raft request' (duration: 344.872766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:23.251044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:22.905297Z","time spent":"345.625695ms","remote":"127.0.0.1:39938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T07:27:23.251537Z","caller":"traceutil/trace.go:171","msg":"trace[1981047314] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"345.127503ms","start":"2026-04-28T07:27:22.906391Z","end":"2026-04-28T07:27:23.251518Z","steps":["trace[1981047314] 'process raft request' (duration: 344.951228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:23.251633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:22.90638Z","time spent":"345.208904ms","remote":"127.0.0.1:39938","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-28T07:27:23.251682Z","caller":"traceutil/trace.go:171","msg":"trace[34299021] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"301.775322ms","start":"2026-04-28T07:27:22.949894Z","end":"2026-04-28T07:27:23.251669Z","steps":["trace[34299021] 'process raft request' (duration: 301.581428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:23.25178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:22.949876Z","time spent":"301.852264ms","remote":"127.0.0.1:39926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T07:27:23.251546Z","caller":"traceutil/trace.go:171","msg":"trace[2084977782] linearizableReadLoop","detail":"{readStateIndex:841; appliedIndex:835; }","duration":"703.981464ms","start":"2026-04-28T07:27:22.547539Z","end":"2026-04-28T07:27:23.251521Z","steps":["trace[2084977782] 'read index received' (duration: 661.060101ms)","trace[2084977782] 'applied index is now lower than readState.Index' (duration: 42.920243ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:27:23.251636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.087267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-28T07:27:23.25195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.635602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T07:27:23.251999Z","caller":"traceutil/trace.go:171","msg":"trace[918899156] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:811; }","duration":"644.708844ms","start":"2026-04-28T07:27:22.607276Z","end":"2026-04-28T07:27:23.251985Z","steps":["trace[918899156] 'agreement among raft nodes before linearized reading' (duration: 644.640353ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:23.252043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:22.607261Z","time spent":"644.772795ms","remote":"127.0.0.1:39656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-28T07:27:23.252511Z","caller":"traceutil/trace.go:171","msg":"trace[1599457025] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:811; }","duration":"704.412943ms","start":"2026-04-28T07:27:22.547494Z","end":"2026-04-28T07:27:23.251907Z","steps":["trace[1599457025] 'agreement among raft nodes before linearized reading' (duration: 704.087196ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:23.252585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:27:22.547479Z","time spent":"705.08505ms","remote":"127.0.0.1:39848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":2,"response size":30,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"info","ts":"2026-04-28T07:27:34.406586Z","caller":"traceutil/trace.go:171","msg":"trace[1918751244] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"116.98872ms","start":"2026-04-28T07:27:34.289549Z","end":"2026-04-28T07:27:34.406537Z","steps":["trace[1918751244] 'process raft request' (duration: 116.446369ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:27:34.406676Z","caller":"traceutil/trace.go:171","msg":"trace[1470557805] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"110.226099ms","start":"2026-04-28T07:27:34.296402Z","end":"2026-04-28T07:27:34.406628Z","steps":["trace[1470557805] 'process raft request' (duration: 109.954212ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:27:37.460888Z","caller":"traceutil/trace.go:171","msg":"trace[285182693] linearizableReadLoop","detail":"{readStateIndex:1003; appliedIndex:1002; }","duration":"142.188645ms","start":"2026-04-28T07:27:37.318676Z","end":"2026-04-28T07:27:37.460865Z","steps":["trace[285182693] 'read index received' (duration: 141.978531ms)","trace[285182693] 'applied index is now lower than readState.Index' (duration: 209.184µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:27:37.461006Z","caller":"traceutil/trace.go:171","msg":"trace[344294470] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"227.214409ms","start":"2026-04-28T07:27:37.23378Z","end":"2026-04-28T07:27:37.460994Z","steps":["trace[344294470] 'process raft request' (duration: 226.930703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:37.461247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.552763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T07:27:37.461305Z","caller":"traceutil/trace.go:171","msg":"trace[624025468] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:970; }","duration":"142.660405ms","start":"2026-04-28T07:27:37.318632Z","end":"2026-04-28T07:27:37.461293Z","steps":["trace[624025468] 'agreement among raft nodes before linearized reading' (duration: 142.554062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:37.461535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.524546ms","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-28T07:27:37.461571Z","caller":"traceutil/trace.go:171","msg":"trace[1828552760] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:970; }","duration":"139.581936ms","start":"2026-04-28T07:27:37.32198Z","end":"2026-04-28T07:27:37.461562Z","steps":["trace[1828552760] 'agreement among raft nodes before linearized reading' (duration: 139.467734ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:37.462041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.964076ms","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-28T07:27:37.462082Z","caller":"traceutil/trace.go:171","msg":"trace[1706677040] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:970; }","duration":"140.013497ms","start":"2026-04-28T07:27:37.322059Z","end":"2026-04-28T07:27:37.462073Z","steps":["trace[1706677040] 'agreement among raft nodes before linearized reading' (duration: 139.925905ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:37.46225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.19036ms","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-28T07:27:37.462284Z","caller":"traceutil/trace.go:171","msg":"trace[368976893] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:970; }","duration":"140.231961ms","start":"2026-04-28T07:27:37.322044Z","end":"2026-04-28T07:27:37.462276Z","steps":["trace[368976893] 'agreement among raft nodes before linearized reading' (duration: 140.151289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:37.462679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.60742ms","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-28T07:27:37.462759Z","caller":"traceutil/trace.go:171","msg":"trace[479316722] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:970; }","duration":"140.713692ms","start":"2026-04-28T07:27:37.322027Z","end":"2026-04-28T07:27:37.462741Z","steps":["trace[479316722] 'agreement among raft nodes before linearized reading' (duration: 140.463405ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:27:37.688147Z","caller":"traceutil/trace.go:171","msg":"trace[507533799] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"220.930311ms","start":"2026-04-28T07:27:37.467196Z","end":"2026-04-28T07:27:37.688126Z","steps":["trace[507533799] 'process raft request' (duration: 220.813869ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:27:37.695784Z","caller":"traceutil/trace.go:171","msg":"trace[1704625185] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"227.969066ms","start":"2026-04-28T07:27:37.467781Z","end":"2026-04-28T07:27:37.69575Z","steps":["trace[1704625185] 'process raft request' (duration: 227.819742ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:27:37.695952Z","caller":"traceutil/trace.go:171","msg":"trace[237477822] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"227.26234ms","start":"2026-04-28T07:27:37.46868Z","end":"2026-04-28T07:27:37.695942Z","steps":["trace[237477822] 'process raft request' (duration: 227.042376ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:27:37.696239Z","caller":"traceutil/trace.go:171","msg":"trace[1805126565] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"223.012036ms","start":"2026-04-28T07:27:37.473202Z","end":"2026-04-28T07:27:37.696214Z","steps":["trace[1805126565] 'process raft request' (duration: 222.675809ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:27:37.696322Z","caller":"traceutil/trace.go:171","msg":"trace[1736324857] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"221.85696ms","start":"2026-04-28T07:27:37.47444Z","end":"2026-04-28T07:27:37.696297Z","steps":["trace[1736324857] 'process raft request' (duration: 221.712507ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:28:06.038117Z","caller":"traceutil/trace.go:171","msg":"trace[428338231] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"120.264912ms","start":"2026-04-28T07:28:05.917824Z","end":"2026-04-28T07:28:06.038089Z","steps":["trace[428338231] 'process raft request' (duration: 119.424106ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:28:06.038568Z","caller":"traceutil/trace.go:171","msg":"trace[547900201] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"120.65862ms","start":"2026-04-28T07:28:05.917892Z","end":"2026-04-28T07:28:06.03855Z","steps":["trace[547900201] 'process raft request' (duration: 120.516337ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:28:06.038655Z","caller":"traceutil/trace.go:171","msg":"trace[1622739200] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"120.440925ms","start":"2026-04-28T07:28:05.918184Z","end":"2026-04-28T07:28:06.038625Z","steps":["trace[1622739200] 'process raft request' (duration: 120.316013ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:29:09.889573Z","caller":"traceutil/trace.go:171","msg":"trace[2011801547] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"295.698182ms","start":"2026-04-28T07:29:09.593848Z","end":"2026-04-28T07:29:09.889546Z","steps":["trace[2011801547] 'process raft request' (duration: 295.484529ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:29:09.889535Z","caller":"traceutil/trace.go:171","msg":"trace[914056428] linearizableReadLoop","detail":"{readStateIndex:1376; appliedIndex:1375; }","duration":"204.139403ms","start":"2026-04-28T07:29:09.685363Z","end":"2026-04-28T07:29:09.889502Z","steps":["trace[914056428] 'read index received' (duration: 203.873919ms)","trace[914056428] 'applied index is now lower than readState.Index' (duration: 264.244µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:29:09.889821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.444499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"} {"level":"info","ts":"2026-04-28T07:29:09.889948Z","caller":"traceutil/trace.go:171","msg":"trace[50735292] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1322; }","duration":"204.58164ms","start":"2026-04-28T07:29:09.685289Z","end":"2026-04-28T07:29:09.88987Z","steps":["trace[50735292] 'agreement among raft nodes before linearized reading' (duration: 204.339387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:29:21.453124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.178235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-28T07:29:21.45315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.394224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T07:29:21.45321Z","caller":"traceutil/trace.go:171","msg":"trace[1526250036] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1370; }","duration":"207.317197ms","start":"2026-04-28T07:29:21.245876Z","end":"2026-04-28T07:29:21.453193Z","steps":["trace[1526250036] 'count revisions from in-memory index tree' (duration: 207.075603ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:29:21.453233Z","caller":"traceutil/trace.go:171","msg":"trace[1330851984] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1370; }","duration":"133.506916ms","start":"2026-04-28T07:29:21.319699Z","end":"2026-04-28T07:29:21.453206Z","steps":["trace[1330851984] 'range keys from in-memory index tree' (duration: 133.300263ms)"],"step_count":1}