{"level":"warn","ts":"2026-04-13T15:59:16.242547Z","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-13T15:59:16.242627Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.33:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.33:2380","--initial-cluster=instance=https://199.204.45.33:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.33:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.33: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-13T15:59:16.242695Z","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-13T15:59:16.242708Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.33:2380"]} {"level":"info","ts":"2026-04-13T15:59:16.242729Z","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-13T15:59:16.243359Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"]} {"level":"info","ts":"2026-04-13T15:59:16.243436Z","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":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.33:2380"],"listen-peer-urls":["https://199.204.45.33:2380"],"advertise-client-urls":["https://199.204.45.33:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.33: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-13T15:59:16.249373Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.777034ms"} {"level":"info","ts":"2026-04-13T15:59:16.258183Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f1e5729930cf7e1f","cluster-id":"14aeb8c3ec66b749"} {"level":"info","ts":"2026-04-13T15:59:16.258305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=()"} {"level":"info","ts":"2026-04-13T15:59:16.258346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became follower at term 0"} {"level":"info","ts":"2026-04-13T15:59:16.258369Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f1e5729930cf7e1f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-13T15:59:16.258396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became follower at term 1"} {"level":"info","ts":"2026-04-13T15:59:16.258454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=(17430463935081840159)"} {"level":"warn","ts":"2026-04-13T15:59:16.264253Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-13T15:59:16.265548Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-13T15:59:16.266727Z","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-13T15:59:16.270321Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f1e5729930cf7e1f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-13T15:59:16.270586Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f1e5729930cf7e1f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-13T15:59:16.270732Z","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-13T15:59:16.270798Z","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-13T15:59:16.270824Z","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-13T15:59:16.271705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=(17430463935081840159)"} {"level":"info","ts":"2026-04-13T15:59:16.273176Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"14aeb8c3ec66b749","local-member-id":"f1e5729930cf7e1f","added-peer-id":"f1e5729930cf7e1f","added-peer-peer-urls":["https://199.204.45.33:2380"]} {"level":"info","ts":"2026-04-13T15:59:16.275479Z","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-13T15:59:16.275553Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.33:2380"} {"level":"info","ts":"2026-04-13T15:59:16.275585Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.33:2380"} {"level":"info","ts":"2026-04-13T15:59:16.27571Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f1e5729930cf7e1f","initial-advertise-peer-urls":["https://199.204.45.33:2380"],"listen-peer-urls":["https://199.204.45.33:2380"],"advertise-client-urls":["https://199.204.45.33:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-13T15:59:16.275749Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-13T15:59:16.459397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f is starting a new election at term 1"} {"level":"info","ts":"2026-04-13T15:59:16.45946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became pre-candidate at term 1"} {"level":"info","ts":"2026-04-13T15:59:16.459495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f received MsgPreVoteResp from f1e5729930cf7e1f at term 1"} {"level":"info","ts":"2026-04-13T15:59:16.459514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became candidate at term 2"} {"level":"info","ts":"2026-04-13T15:59:16.459525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f received MsgVoteResp from f1e5729930cf7e1f at term 2"} {"level":"info","ts":"2026-04-13T15:59:16.459541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became leader at term 2"} {"level":"info","ts":"2026-04-13T15:59:16.459569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f1e5729930cf7e1f elected leader f1e5729930cf7e1f at term 2"} {"level":"info","ts":"2026-04-13T15:59:16.46082Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f1e5729930cf7e1f","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.33:2379]}","request-path":"/0/members/f1e5729930cf7e1f/attributes","cluster-id":"14aeb8c3ec66b749","publish-timeout":"7s"} {"level":"info","ts":"2026-04-13T15:59:16.461011Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T15:59:16.461062Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T15:59:16.461268Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T15:59:16.462371Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"14aeb8c3ec66b749","local-member-id":"f1e5729930cf7e1f","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T15:59:16.464156Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-13T15:59:16.464322Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-13T15:59:16.46432Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T15:59:16.464348Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-13T15:59:16.464423Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T15:59:16.465838Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.33:2379"} {"level":"info","ts":"2026-04-13T15:59:37.107144Z","caller":"traceutil/trace.go:171","msg":"trace[1483068421] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"249.063428ms","start":"2026-04-13T15:59:36.858032Z","end":"2026-04-13T15:59:37.107095Z","steps":["trace[1483068421] 'process raft request' (duration: 248.927673ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:59:37.610603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.821656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:59:37.610715Z","caller":"traceutil/trace.go:171","msg":"trace[303421321] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:451; }","duration":"231.988202ms","start":"2026-04-13T15:59:37.378711Z","end":"2026-04-13T15:59:37.610699Z","steps":["trace[303421321] 'range keys from in-memory index tree' (duration: 231.688142ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:59:45.328921Z","caller":"traceutil/trace.go:171","msg":"trace[1892215992] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"209.992618ms","start":"2026-04-13T15:59:45.118901Z","end":"2026-04-13T15:59:45.328893Z","steps":["trace[1892215992] 'process raft request' (duration: 209.799402ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:59:45.355161Z","caller":"traceutil/trace.go:171","msg":"trace[1427822788] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"228.955234ms","start":"2026-04-13T15:59:45.126174Z","end":"2026-04-13T15:59:45.355129Z","steps":["trace[1427822788] 'process raft request' (duration: 228.691556ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:59:45.35523Z","caller":"traceutil/trace.go:171","msg":"trace[703512830] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"218.470939ms","start":"2026-04-13T15:59:45.136739Z","end":"2026-04-13T15:59:45.35521Z","steps":["trace[703512830] 'process raft request' (duration: 218.353705ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:59:45.355288Z","caller":"traceutil/trace.go:171","msg":"trace[961224183] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"218.472339ms","start":"2026-04-13T15:59:45.136809Z","end":"2026-04-13T15:59:45.355281Z","steps":["trace[961224183] 'process raft request' (duration: 218.322394ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:59:45.355182Z","caller":"traceutil/trace.go:171","msg":"trace[1803242987] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"218.413718ms","start":"2026-04-13T15:59:45.136733Z","end":"2026-04-13T15:59:45.355146Z","steps":["trace[1803242987] 'process raft request' (duration: 218.316734ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:59:45.355377Z","caller":"traceutil/trace.go:171","msg":"trace[2130491946] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"217.815608ms","start":"2026-04-13T15:59:45.137542Z","end":"2026-04-13T15:59:45.355357Z","steps":["trace[2130491946] 'process raft request' (duration: 217.666473ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:59:45.355462Z","caller":"traceutil/trace.go:171","msg":"trace[964418456] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"217.55627ms","start":"2026-04-13T15:59:45.137893Z","end":"2026-04-13T15:59:45.355449Z","steps":["trace[964418456] 'process raft request' (duration: 217.367564ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:59:45.355564Z","caller":"traceutil/trace.go:171","msg":"trace[1302686939] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"212.910062ms","start":"2026-04-13T15:59:45.142647Z","end":"2026-04-13T15:59:45.355557Z","steps":["trace[1302686939] 'process raft request' (duration: 212.675874ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:59:45.355674Z","caller":"traceutil/trace.go:171","msg":"trace[1634169924] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"227.527918ms","start":"2026-04-13T15:59:45.128136Z","end":"2026-04-13T15:59:45.355664Z","steps":["trace[1634169924] 'process raft request' (duration: 226.868487ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:59:45.355702Z","caller":"traceutil/trace.go:171","msg":"trace[1281847684] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"201.24502ms","start":"2026-04-13T15:59:45.154433Z","end":"2026-04-13T15:59:45.355678Z","steps":["trace[1281847684] 'process raft request' (duration: 201.094225ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:59:45.355764Z","caller":"traceutil/trace.go:171","msg":"trace[207689871] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"185.654402ms","start":"2026-04-13T15:59:45.170101Z","end":"2026-04-13T15:59:45.355755Z","steps":["trace[207689871] 'process raft request' (duration: 185.531258ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:59:45.355819Z","caller":"traceutil/trace.go:171","msg":"trace[1722319198] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:521; }","duration":"206.474656ms","start":"2026-04-13T15:59:45.14932Z","end":"2026-04-13T15:59:45.355795Z","steps":["trace[1722319198] 'read index received' (duration: 179.474575ms)","trace[1722319198] 'applied index is now lower than readState.Index' (duration: 26.999301ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:59:45.356006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.670212ms","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-13T15:59:45.35605Z","caller":"traceutil/trace.go:171","msg":"trace[885004932] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:515; }","duration":"206.754745ms","start":"2026-04-13T15:59:45.149283Z","end":"2026-04-13T15:59:45.356038Z","steps":["trace[885004932] 'agreement among raft nodes before linearized reading' (duration: 206.615781ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:59:51.857577Z","caller":"traceutil/trace.go:171","msg":"trace[1001128812] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"250.647713ms","start":"2026-04-13T15:59:51.606904Z","end":"2026-04-13T15:59:51.857552Z","steps":["trace[1001128812] 'process raft request' (duration: 250.466548ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:59:52.657539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.468181ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T15:59:52.657742Z","caller":"traceutil/trace.go:171","msg":"trace[9010329] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"479.677719ms","start":"2026-04-13T15:59:52.178049Z","end":"2026-04-13T15:59:52.657726Z","steps":["trace[9010329] 'process raft request' (duration: 479.611367ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:59:52.657717Z","caller":"traceutil/trace.go:171","msg":"trace[626165257] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"893.808506ms","start":"2026-04-13T15:59:51.763865Z","end":"2026-04-13T15:59:52.657673Z","steps":["trace[626165257] 'process raft request' (duration: 146.686365ms)","trace[626165257] 'compare' (duration: 746.109271ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:59:52.657797Z","caller":"traceutil/trace.go:171","msg":"trace[1496558628] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:633; }","duration":"564.851888ms","start":"2026-04-13T15:59:52.092916Z","end":"2026-04-13T15:59:52.657767Z","steps":["trace[1496558628] 'read index received' (duration: 32.261µs)","trace[1496558628] 'applied index is now lower than readState.Index' (duration: 564.817107ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:59:52.657817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:59:52.178026Z","time spent":"479.758401ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:59:52.657893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:59:51.763842Z","time spent":"893.95283ms","remote":"127.0.0.1:60386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:59:52.658117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.191819ms","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-13T15:59:52.658167Z","caller":"traceutil/trace.go:171","msg":"trace[981339365] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:615; }","duration":"565.255851ms","start":"2026-04-13T15:59:52.092898Z","end":"2026-04-13T15:59:52.658154Z","steps":["trace[981339365] 'agreement among raft nodes before linearized reading' (duration: 565.021494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:59:52.658202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:59:52.092831Z","time spent":"565.362294ms","remote":"127.0.0.1:60574","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-13T15:59:52.670823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.954931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-13T15:59:52.67088Z","caller":"traceutil/trace.go:171","msg":"trace[2145003211] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:616; }","duration":"494.053834ms","start":"2026-04-13T15:59:52.176812Z","end":"2026-04-13T15:59:52.670866Z","steps":["trace[2145003211] 'agreement among raft nodes before linearized reading' (duration: 493.880369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:59:52.670935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:59:52.176793Z","time spent":"494.113216ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-13T15:59:52.670872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.710279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:59:52.671005Z","caller":"traceutil/trace.go:171","msg":"trace[503741310] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"468.898571ms","start":"2026-04-13T15:59:52.202088Z","end":"2026-04-13T15:59:52.670986Z","steps":["trace[503741310] 'process raft request' (duration: 468.514989ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:59:52.671034Z","caller":"traceutil/trace.go:171","msg":"trace[1135256112] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"291.942306ms","start":"2026-04-13T15:59:52.379078Z","end":"2026-04-13T15:59:52.67102Z","steps":["trace[1135256112] 'agreement among raft nodes before linearized reading' (duration: 291.622986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:59:52.671156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:59:52.202067Z","time spent":"468.984612ms","remote":"127.0.0.1:60478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4542,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:59:52.671355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.158332ms","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-13T15:59:52.671524Z","caller":"traceutil/trace.go:171","msg":"trace[422648435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:616; }","duration":"316.366568ms","start":"2026-04-13T15:59:52.355143Z","end":"2026-04-13T15:59:52.67151Z","steps":["trace[422648435] 'agreement among raft nodes before linearized reading' (duration: 316.07819ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:59:52.671602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:59:52.355124Z","time spent":"316.466371ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T15:59:58.056464Z","caller":"traceutil/trace.go:171","msg":"trace[1545415855] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"119.272504ms","start":"2026-04-13T15:59:57.937164Z","end":"2026-04-13T15:59:58.056436Z","steps":["trace[1545415855] 'process raft request' (duration: 119.100459ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:00:14.385688Z","caller":"traceutil/trace.go:171","msg":"trace[1341123262] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"161.420624ms","start":"2026-04-13T16:00:14.224229Z","end":"2026-04-13T16:00:14.385649Z","steps":["trace[1341123262] 'process raft request' (duration: 161.152548ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:00:17.428516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.440339ms","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-13T16:00:17.428597Z","caller":"traceutil/trace.go:171","msg":"trace[2064301486] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:802; }","duration":"651.570492ms","start":"2026-04-13T16:00:16.777009Z","end":"2026-04-13T16:00:17.42858Z","steps":["trace[2064301486] 'range keys from in-memory index tree' (duration: 651.258204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:00:17.428637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:00:16.776988Z","time spent":"651.640734ms","remote":"127.0.0.1:60574","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-13T16:00:17.428729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.130194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fzc67\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-04-13T16:00:17.42881Z","caller":"traceutil/trace.go:171","msg":"trace[416128137] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fzc67; range_end:; response_count:1; response_revision:802; }","duration":"721.249007ms","start":"2026-04-13T16:00:16.707544Z","end":"2026-04-13T16:00:17.428793Z","steps":["trace[416128137] 'range keys from in-memory index tree' (duration: 720.96678ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:00:17.428783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.21568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-13T16:00:17.428852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:00:16.707527Z","time spent":"721.313789ms","remote":"127.0.0.1:60486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fzc67\" "} {"level":"info","ts":"2026-04-13T16:00:17.428874Z","caller":"traceutil/trace.go:171","msg":"trace[857624362] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:802; }","duration":"653.372184ms","start":"2026-04-13T16:00:16.775478Z","end":"2026-04-13T16:00:17.42885Z","steps":["trace[857624362] 'range keys from in-memory index tree' (duration: 653.029766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:00:17.428925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:00:16.775454Z","time spent":"653.460636ms","remote":"127.0.0.1:60574","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-13T16:00:17.429353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.306269ms","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-13T16:00:17.429632Z","caller":"traceutil/trace.go:171","msg":"trace[1353695148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:802; }","duration":"649.631087ms","start":"2026-04-13T16:00:16.779981Z","end":"2026-04-13T16:00:17.429612Z","steps":["trace[1353695148] 'range keys from in-memory index tree' (duration: 648.302936ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:00:17.429712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:00:16.779966Z","time spent":"649.728339ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T16:01:09.138049Z","caller":"traceutil/trace.go:171","msg":"trace[499090881] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"481.609002ms","start":"2026-04-13T16:01:08.656413Z","end":"2026-04-13T16:01:09.138022Z","steps":["trace[499090881] 'process raft request' (duration: 481.407258ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:01:09.138226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:01:08.656396Z","time spent":"481.761596ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T16:01:09.403018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.895751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T16:01:09.403111Z","caller":"traceutil/trace.go:171","msg":"trace[1308730303] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1076; }","duration":"119.005303ms","start":"2026-04-13T16:01:09.284083Z","end":"2026-04-13T16:01:09.403088Z","steps":["trace[1308730303] 'count revisions from in-memory index tree' (duration: 118.82661ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:01:31.934201Z","caller":"traceutil/trace.go:171","msg":"trace[50438289] linearizableReadLoop","detail":"{readStateIndex:1194; appliedIndex:1193; }","duration":"139.750703ms","start":"2026-04-13T16:01:31.794411Z","end":"2026-04-13T16:01:31.934162Z","steps":["trace[50438289] 'read index received' (duration: 139.389549ms)","trace[50438289] 'applied index is now lower than readState.Index' (duration: 359.514µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T16:01:31.934293Z","caller":"traceutil/trace.go:171","msg":"trace[18034444] transaction","detail":"{read_only:false; response_revision:1151; number_of_response:1; }","duration":"141.43511ms","start":"2026-04-13T16:01:31.792831Z","end":"2026-04-13T16:01:31.934266Z","steps":["trace[18034444] 'process raft request' (duration: 141.096197ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:01:31.934589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.876341ms","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-13T16:01:31.934641Z","caller":"traceutil/trace.go:171","msg":"trace[1500627966] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1151; }","duration":"120.984621ms","start":"2026-04-13T16:01:31.813643Z","end":"2026-04-13T16:01:31.934628Z","steps":["trace[1500627966] 'agreement among raft nodes before linearized reading' (duration: 120.750129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:01:31.934691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.189147ms","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-13T16:01:31.934798Z","caller":"traceutil/trace.go:171","msg":"trace[321526615] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1151; }","duration":"140.41475ms","start":"2026-04-13T16:01:31.79436Z","end":"2026-04-13T16:01:31.934774Z","steps":["trace[321526615] 'agreement among raft nodes before linearized reading' (duration: 140.062676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:01:32.912631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.690067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T16:01:32.91273Z","caller":"traceutil/trace.go:171","msg":"trace[980467353] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1155; }","duration":"533.800848ms","start":"2026-04-13T16:01:32.378905Z","end":"2026-04-13T16:01:32.912706Z","steps":["trace[980467353] 'range keys from in-memory index tree' (duration: 533.560136ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:01:32.912787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:01:32.378849Z","time spent":"533.914099ms","remote":"127.0.0.1:60320","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-13T16:01:34.065746Z","caller":"traceutil/trace.go:171","msg":"trace[414722797] transaction","detail":"{read_only:false; response_revision:1157; number_of_response:1; }","duration":"122.91683ms","start":"2026-04-13T16:01:33.942804Z","end":"2026-04-13T16:01:34.06572Z","steps":["trace[414722797] 'process raft request' (duration: 122.649768ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:01:34.231574Z","caller":"traceutil/trace.go:171","msg":"trace[389203805] transaction","detail":"{read_only:false; response_revision:1158; number_of_response:1; }","duration":"235.174727ms","start":"2026-04-13T16:01:33.996352Z","end":"2026-04-13T16:01:34.231526Z","steps":["trace[389203805] 'process raft request' (duration: 163.20318ms)","trace[389203805] 'compare' (duration: 71.640544ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T16:01:34.231549Z","caller":"traceutil/trace.go:171","msg":"trace[1122144957] linearizableReadLoop","detail":"{readStateIndex:1201; appliedIndex:1200; }","duration":"165.869596ms","start":"2026-04-13T16:01:34.065641Z","end":"2026-04-13T16:01:34.231511Z","steps":["trace[1122144957] 'read index received' (duration: 94.00544ms)","trace[1122144957] 'applied index is now lower than readState.Index' (duration: 71.862456ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T16:01:34.231759Z","caller":"traceutil/trace.go:171","msg":"trace[484536536] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"161.495414ms","start":"2026-04-13T16:01:34.070241Z","end":"2026-04-13T16:01:34.231736Z","steps":["trace[484536536] 'process raft request' (duration: 161.219481ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:01:34.23196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.587267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-13T16:01:34.232075Z","caller":"traceutil/trace.go:171","msg":"trace[792701841] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1159; }","duration":"250.718118ms","start":"2026-04-13T16:01:33.981333Z","end":"2026-04-13T16:01:34.232051Z","steps":["trace[792701841] 'agreement among raft nodes before linearized reading' (duration: 250.298694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:01:34.231953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.446835ms","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-13T16:01:34.232203Z","caller":"traceutil/trace.go:171","msg":"trace[767531028] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1159; }","duration":"250.759248ms","start":"2026-04-13T16:01:33.981423Z","end":"2026-04-13T16:01:34.232182Z","steps":["trace[767531028] 'agreement among raft nodes before linearized reading' (duration: 250.149182ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:01:35.245363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.467875ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-13T16:01:35.289777Z","caller":"traceutil/trace.go:171","msg":"trace[1045878048] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"202.655062ms","start":"2026-04-13T16:01:35.087098Z","end":"2026-04-13T16:01:35.289753Z","steps":["trace[1045878048] 'process raft request' (duration: 202.513511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:01:35.518864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.178727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T16:01:35.518975Z","caller":"traceutil/trace.go:171","msg":"trace[1538784955] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1162; }","duration":"140.346029ms","start":"2026-04-13T16:01:35.378609Z","end":"2026-04-13T16:01:35.518955Z","steps":["trace[1538784955] 'range keys from in-memory index tree' (duration: 140.077506ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:01:35.519215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.224399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-13T16:01:35.519253Z","caller":"traceutil/trace.go:171","msg":"trace[1289275260] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1162; }","duration":"136.300849ms","start":"2026-04-13T16:01:35.382943Z","end":"2026-04-13T16:01:35.519244Z","steps":["trace[1289275260] 'range keys from in-memory index tree' (duration: 136.046337ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:05:53.013795Z","caller":"traceutil/trace.go:171","msg":"trace[1261981528] transaction","detail":"{read_only:false; response_revision:2009; number_of_response:1; }","duration":"242.382391ms","start":"2026-04-13T16:05:52.771381Z","end":"2026-04-13T16:05:53.013764Z","steps":["trace[1261981528] 'process raft request' (duration: 242.231508ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:06:13.336696Z","caller":"traceutil/trace.go:171","msg":"trace[327549453] transaction","detail":"{read_only:false; response_revision:2075; number_of_response:1; }","duration":"222.69485ms","start":"2026-04-13T16:06:13.113977Z","end":"2026-04-13T16:06:13.336672Z","steps":["trace[327549453] 'process raft request' (duration: 222.582907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:06:13.70759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.00161ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T16:06:13.707677Z","caller":"traceutil/trace.go:171","msg":"trace[1820163005] linearizableReadLoop","detail":"{readStateIndex:2175; appliedIndex:2174; }","duration":"307.400573ms","start":"2026-04-13T16:06:13.400265Z","end":"2026-04-13T16:06:13.707666Z","steps":["trace[1820163005] 'read index received' (duration: 144.212889ms)","trace[1820163005] 'applied index is now lower than readState.Index' (duration: 163.186714ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T16:06:13.707739Z","caller":"traceutil/trace.go:171","msg":"trace[1651337927] transaction","detail":"{read_only:false; response_revision:2076; number_of_response:1; }","duration":"469.041103ms","start":"2026-04-13T16:06:13.238656Z","end":"2026-04-13T16:06:13.707697Z","steps":["trace[1651337927] 'process raft request' (duration: 305.875979ms)","trace[1651337927] 'compare' (duration: 162.910338ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T16:06:13.707808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.742705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-13T16:06:13.707826Z","caller":"traceutil/trace.go:171","msg":"trace[1537321558] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2076; }","duration":"254.773166ms","start":"2026-04-13T16:06:13.453047Z","end":"2026-04-13T16:06:13.70782Z","steps":["trace[1537321558] 'agreement among raft nodes before linearized reading' (duration: 254.678753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:06:13.70793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.635998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-13T16:06:13.707975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:06:13.238633Z","time spent":"469.192636ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T16:06:13.708029Z","caller":"traceutil/trace.go:171","msg":"trace[625197215] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2076; }","duration":"307.773642ms","start":"2026-04-13T16:06:13.40023Z","end":"2026-04-13T16:06:13.708003Z","steps":["trace[625197215] 'agreement among raft nodes before linearized reading' (duration: 307.493845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:06:13.708028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.689668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-13T16:06:13.708052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.649235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-13T16:06:13.708084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:06:13.400213Z","time spent":"307.858063ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-13T16:06:13.708116Z","caller":"traceutil/trace.go:171","msg":"trace[30873339] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2076; }","duration":"119.763038ms","start":"2026-04-13T16:06:13.58834Z","end":"2026-04-13T16:06:13.708103Z","steps":["trace[30873339] 'agreement among raft nodes before linearized reading' (duration: 119.566633ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:06:13.708106Z","caller":"traceutil/trace.go:171","msg":"trace[780495981] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2076; }","duration":"116.78931ms","start":"2026-04-13T16:06:13.591296Z","end":"2026-04-13T16:06:13.708085Z","steps":["trace[780495981] 'agreement among raft nodes before linearized reading' (duration: 116.511873ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:06:22.921586Z","caller":"traceutil/trace.go:171","msg":"trace[2076818736] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"102.50367ms","start":"2026-04-13T16:06:22.819032Z","end":"2026-04-13T16:06:22.921535Z","steps":["trace[2076818736] 'process raft request' (duration: 102.241214ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:06:23.506062Z","caller":"traceutil/trace.go:171","msg":"trace[1856862832] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"123.279103ms","start":"2026-04-13T16:06:23.382762Z","end":"2026-04-13T16:06:23.506041Z","steps":["trace[1856862832] 'process raft request' (duration: 123.15504ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:06:31.72531Z","caller":"traceutil/trace.go:171","msg":"trace[830657107] transaction","detail":"{read_only:false; response_revision:2594; number_of_response:1; }","duration":"298.6778ms","start":"2026-04-13T16:06:31.426609Z","end":"2026-04-13T16:06:31.725287Z","steps":["trace[830657107] 'process raft request' (duration: 298.543547ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:06:31.725582Z","caller":"traceutil/trace.go:171","msg":"trace[9499256] linearizableReadLoop","detail":"{readStateIndex:2702; appliedIndex:2702; }","duration":"166.125157ms","start":"2026-04-13T16:06:31.559426Z","end":"2026-04-13T16:06:31.725551Z","steps":["trace[9499256] 'read index received' (duration: 166.117527ms)","trace[9499256] 'applied index is now lower than readState.Index' (duration: 6.15µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T16:06:31.725825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.382573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-13T16:06:31.725866Z","caller":"traceutil/trace.go:171","msg":"trace[860513959] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2594; }","duration":"166.473855ms","start":"2026-04-13T16:06:31.559381Z","end":"2026-04-13T16:06:31.725855Z","steps":["trace[860513959] 'agreement among raft nodes before linearized reading' (duration: 166.298951ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:06:32.576395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.283293ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T16:06:32.576472Z","caller":"traceutil/trace.go:171","msg":"trace[214522809] transaction","detail":"{read_only:false; response_revision:2595; number_of_response:1; }","duration":"846.234358ms","start":"2026-04-13T16:06:31.730226Z","end":"2026-04-13T16:06:32.576461Z","steps":["trace[214522809] 'process raft request' (duration: 415.829193ms)","trace[214522809] 'compare' (duration: 429.986716ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T16:06:32.576504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:06:31.730203Z","time spent":"846.287659ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T16:06:32.577498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.902105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-13T16:06:32.577565Z","caller":"traceutil/trace.go:171","msg":"trace[357127901] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2596; }","duration":"777.993347ms","start":"2026-04-13T16:06:31.799553Z","end":"2026-04-13T16:06:32.577546Z","steps":["trace[357127901] 'agreement among raft nodes before linearized reading' (duration: 777.817403ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:06:32.577533Z","caller":"traceutil/trace.go:171","msg":"trace[804058966] transaction","detail":"{read_only:false; response_revision:2596; number_of_response:1; }","duration":"807.455286ms","start":"2026-04-13T16:06:31.769834Z","end":"2026-04-13T16:06:32.577289Z","steps":["trace[804058966] 'process raft request' (duration: 807.310183ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:06:32.577609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:06:31.799544Z","time spent":"778.056398ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-13T16:06:32.577334Z","caller":"traceutil/trace.go:171","msg":"trace[1000094567] linearizableReadLoop","detail":"{readStateIndex:2704; appliedIndex:2702; }","duration":"777.67833ms","start":"2026-04-13T16:06:31.799577Z","end":"2026-04-13T16:06:32.577256Z","steps":["trace[1000094567] 'read index received' (duration: 346.458366ms)","trace[1000094567] 'applied index is now lower than readState.Index' (duration: 431.218923ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T16:06:32.577791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:06:31.769786Z","time spent":"807.835075ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T16:06:32.578081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.213955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-13T16:06:32.578068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.281141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T16:06:32.578115Z","caller":"traceutil/trace.go:171","msg":"trace[1660262453] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2596; }","duration":"750.265467ms","start":"2026-04-13T16:06:31.82784Z","end":"2026-04-13T16:06:32.578106Z","steps":["trace[1660262453] 'agreement among raft nodes before linearized reading' (duration: 750.171725ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:06:32.578129Z","caller":"traceutil/trace.go:171","msg":"trace[1337625240] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2596; }","duration":"199.401724ms","start":"2026-04-13T16:06:32.378713Z","end":"2026-04-13T16:06:32.578115Z","steps":["trace[1337625240] 'agreement among raft nodes before linearized reading' (duration: 199.278021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:06:32.578148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:06:31.827832Z","time spent":"750.310148ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T16:06:32.578161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.732547ms","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-13T16:06:32.578215Z","caller":"traceutil/trace.go:171","msg":"trace[378980301] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2596; }","duration":"750.800969ms","start":"2026-04-13T16:06:31.827401Z","end":"2026-04-13T16:06:32.578201Z","steps":["trace[378980301] 'agreement among raft nodes before linearized reading' (duration: 750.641605ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:06:32.578251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:06:31.827395Z","time spent":"750.84866ms","remote":"127.0.0.1:60574","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-13T16:06:32.578415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"751.672319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-13T16:06:32.578453Z","caller":"traceutil/trace.go:171","msg":"trace[1028241974] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2596; }","duration":"751.71152ms","start":"2026-04-13T16:06:31.826733Z","end":"2026-04-13T16:06:32.578444Z","steps":["trace[1028241974] 'agreement among raft nodes before linearized reading' (duration: 751.250589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:06:32.578481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:06:31.82668Z","time spent":"751.795421ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T16:06:37.054603Z","caller":"traceutil/trace.go:171","msg":"trace[397040528] linearizableReadLoop","detail":"{readStateIndex:2743; appliedIndex:2742; }","duration":"437.470266ms","start":"2026-04-13T16:06:36.617111Z","end":"2026-04-13T16:06:37.054582Z","steps":["trace[397040528] 'read index received' (duration: 437.282492ms)","trace[397040528] 'applied index is now lower than readState.Index' (duration: 186.904µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T16:06:37.054718Z","caller":"traceutil/trace.go:171","msg":"trace[970286429] transaction","detail":"{read_only:false; response_revision:2634; number_of_response:1; }","duration":"437.811114ms","start":"2026-04-13T16:06:36.616878Z","end":"2026-04-13T16:06:37.054689Z","steps":["trace[970286429] 'process raft request' (duration: 437.566419ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:06:37.054866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.502855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-13T16:06:37.05491Z","caller":"traceutil/trace.go:171","msg":"trace[1575224890] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2634; }","duration":"436.587086ms","start":"2026-04-13T16:06:36.618311Z","end":"2026-04-13T16:06:37.054898Z","steps":["trace[1575224890] 'agreement among raft nodes before linearized reading' (duration: 436.407312ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:06:37.054901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.761344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-13T16:06:37.05498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:06:36.618294Z","time spent":"436.675819ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-13T16:06:37.055005Z","caller":"traceutil/trace.go:171","msg":"trace[778884317] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2634; }","duration":"437.888016ms","start":"2026-04-13T16:06:36.617099Z","end":"2026-04-13T16:06:37.054987Z","steps":["trace[778884317] 'agreement among raft nodes before linearized reading' (duration: 437.60738ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:06:37.055051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:06:36.617094Z","time spent":"437.947617ms","remote":"127.0.0.1:60574","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-13T16:06:37.055051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.170574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-13T16:06:37.055117Z","caller":"traceutil/trace.go:171","msg":"trace[1442303138] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2634; }","duration":"435.268737ms","start":"2026-04-13T16:06:36.619831Z","end":"2026-04-13T16:06:37.0551Z","steps":["trace[1442303138] 'agreement among raft nodes before linearized reading' (duration: 434.9871ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:06:37.05508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.486052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-create-prmk8\" ","response":"range_response_count:1 size:4196"} {"level":"warn","ts":"2026-04-13T16:06:37.055175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:06:36.619819Z","time spent":"435.343538ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T16:06:37.055203Z","caller":"traceutil/trace.go:171","msg":"trace[2072026096] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-create-prmk8; range_end:; response_count:1; response_revision:2634; }","duration":"172.632515ms","start":"2026-04-13T16:06:36.882544Z","end":"2026-04-13T16:06:37.055176Z","steps":["trace[2072026096] 'agreement among raft nodes before linearized reading' (duration: 172.204646ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:06:37.05541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:06:36.616859Z","time spent":"438.004048ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T16:06:42.784328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.320753ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T16:06:42.784442Z","caller":"traceutil/trace.go:171","msg":"trace[389324004] linearizableReadLoop","detail":"{readStateIndex:2890; appliedIndex:2889; }","duration":"169.691498ms","start":"2026-04-13T16:06:42.614733Z","end":"2026-04-13T16:06:42.784424Z","steps":["trace[389324004] 'read index received' (duration: 39.084909ms)","trace[389324004] 'applied index is now lower than readState.Index' (duration: 130.605139ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T16:06:42.784555Z","caller":"traceutil/trace.go:171","msg":"trace[1581677549] transaction","detail":"{read_only:false; response_revision:2779; number_of_response:1; }","duration":"178.032937ms","start":"2026-04-13T16:06:42.606497Z","end":"2026-04-13T16:06:42.78453Z","steps":["trace[1581677549] 'process raft request' (duration: 47.390387ms)","trace[1581677549] 'compare' (duration: 130.144459ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T16:06:42.784626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.905182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-13T16:06:42.784664Z","caller":"traceutil/trace.go:171","msg":"trace[1132132037] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2779; }","duration":"169.944393ms","start":"2026-04-13T16:06:42.61471Z","end":"2026-04-13T16:06:42.784654Z","steps":["trace[1132132037] 'agreement among raft nodes before linearized reading' (duration: 169.760009ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:06:43.186833Z","caller":"traceutil/trace.go:171","msg":"trace[1851599380] linearizableReadLoop","detail":"{readStateIndex:2891; appliedIndex:2890; }","duration":"259.93797ms","start":"2026-04-13T16:06:42.926861Z","end":"2026-04-13T16:06:43.186799Z","steps":["trace[1851599380] 'read index received' (duration: 249.873761ms)","trace[1851599380] 'applied index is now lower than readState.Index' (duration: 10.062449ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T16:06:43.187196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.319598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-patch-m2z4v\" ","response":"range_response_count:1 size:4178"} {"level":"info","ts":"2026-04-13T16:06:43.187209Z","caller":"traceutil/trace.go:171","msg":"trace[831859769] transaction","detail":"{read_only:false; response_revision:2780; number_of_response:1; }","duration":"398.242604ms","start":"2026-04-13T16:06:42.788917Z","end":"2026-04-13T16:06:43.187159Z","steps":["trace[831859769] 'process raft request' (duration: 387.868609ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:06:43.187261Z","caller":"traceutil/trace.go:171","msg":"trace[1801123708] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-patch-m2z4v; range_end:; response_count:1; response_revision:2780; }","duration":"260.425131ms","start":"2026-04-13T16:06:42.926819Z","end":"2026-04-13T16:06:43.187244Z","steps":["trace[1801123708] 'agreement among raft nodes before linearized reading' (duration: 260.250957ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:06:43.187422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:06:42.788893Z","time spent":"398.425258ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T16:06:44.221176Z","caller":"traceutil/trace.go:171","msg":"trace[2008811273] transaction","detail":"{read_only:false; response_revision:2786; number_of_response:1; }","duration":"279.089995ms","start":"2026-04-13T16:06:43.942066Z","end":"2026-04-13T16:06:44.221156Z","steps":["trace[2008811273] 'process raft request' (duration: 278.950462ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:07:03.51788Z","caller":"traceutil/trace.go:171","msg":"trace[1820485286] transaction","detail":"{read_only:false; response_revision:2891; number_of_response:1; }","duration":"114.145125ms","start":"2026-04-13T16:07:03.403705Z","end":"2026-04-13T16:07:03.51785Z","steps":["trace[1820485286] 'process raft request' (duration: 93.334502ms)","trace[1820485286] 'compare' (duration: 20.68496ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T16:07:03.544982Z","caller":"traceutil/trace.go:171","msg":"trace[834620536] transaction","detail":"{read_only:false; response_revision:2892; number_of_response:1; }","duration":"141.18083ms","start":"2026-04-13T16:07:03.403773Z","end":"2026-04-13T16:07:03.544954Z","steps":["trace[834620536] 'process raft request' (duration: 140.935825ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:07:03.544975Z","caller":"traceutil/trace.go:171","msg":"trace[668281220] transaction","detail":"{read_only:false; response_revision:2893; number_of_response:1; }","duration":"140.991356ms","start":"2026-04-13T16:07:03.403953Z","end":"2026-04-13T16:07:03.544944Z","steps":["trace[668281220] 'process raft request' (duration: 140.887304ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:07:03.545188Z","caller":"traceutil/trace.go:171","msg":"trace[2074314513] transaction","detail":"{read_only:false; response_revision:2894; number_of_response:1; }","duration":"141.092248ms","start":"2026-04-13T16:07:03.404073Z","end":"2026-04-13T16:07:03.545165Z","steps":["trace[2074314513] 'process raft request' (duration: 140.817492ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:07:04.955962Z","caller":"traceutil/trace.go:171","msg":"trace[996777913] transaction","detail":"{read_only:false; response_revision:2895; number_of_response:1; }","duration":"100.182258ms","start":"2026-04-13T16:07:04.855749Z","end":"2026-04-13T16:07:04.955931Z","steps":["trace[996777913] 'process raft request' (duration: 99.861641ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:07:05.653734Z","caller":"traceutil/trace.go:171","msg":"trace[540023587] linearizableReadLoop","detail":"{readStateIndex:3013; appliedIndex:3012; }","duration":"135.664475ms","start":"2026-04-13T16:07:05.518049Z","end":"2026-04-13T16:07:05.653713Z","steps":["trace[540023587] 'read index received' (duration: 135.475991ms)","trace[540023587] 'applied index is now lower than readState.Index' (duration: 187.804µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T16:07:05.653808Z","caller":"traceutil/trace.go:171","msg":"trace[289608023] transaction","detail":"{read_only:false; response_revision:2896; number_of_response:1; }","duration":"247.711912ms","start":"2026-04-13T16:07:05.406077Z","end":"2026-04-13T16:07:05.653788Z","steps":["trace[289608023] 'process raft request' (duration: 247.493657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:07:05.653883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.806728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T16:07:05.653914Z","caller":"traceutil/trace.go:171","msg":"trace[119246465] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:2896; }","duration":"135.885259ms","start":"2026-04-13T16:07:05.51802Z","end":"2026-04-13T16:07:05.653906Z","steps":["trace[119246465] 'agreement among raft nodes before linearized reading' (duration: 135.807948ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:07:05.654083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.740475ms","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-13T16:07:05.654122Z","caller":"traceutil/trace.go:171","msg":"trace[1053131638] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2896; }","duration":"131.823147ms","start":"2026-04-13T16:07:05.52229Z","end":"2026-04-13T16:07:05.654113Z","steps":["trace[1053131638] 'agreement among raft nodes before linearized reading' (duration: 131.695474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:07:05.654182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.001371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-13T16:07:05.654211Z","caller":"traceutil/trace.go:171","msg":"trace[1884703877] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2896; }","duration":"106.051851ms","start":"2026-04-13T16:07:05.548152Z","end":"2026-04-13T16:07:05.654204Z","steps":["trace[1884703877] 'agreement among raft nodes before linearized reading' (duration: 105.963949ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:07:05.654244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.167814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-13T16:07:05.654277Z","caller":"traceutil/trace.go:171","msg":"trace[13382496] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2896; }","duration":"106.243596ms","start":"2026-04-13T16:07:05.548024Z","end":"2026-04-13T16:07:05.654268Z","steps":["trace[13382496] 'agreement among raft nodes before linearized reading' (duration: 106.160704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:07:05.65441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.151343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-13T16:07:05.654516Z","caller":"traceutil/trace.go:171","msg":"trace[12357105] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2896; }","duration":"106.321338ms","start":"2026-04-13T16:07:05.54817Z","end":"2026-04-13T16:07:05.654491Z","steps":["trace[12357105] 'agreement among raft nodes before linearized reading' (duration: 106.009131ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:07:06.058791Z","caller":"traceutil/trace.go:171","msg":"trace[217149562] transaction","detail":"{read_only:false; response_revision:2898; number_of_response:1; }","duration":"400.211759ms","start":"2026-04-13T16:07:05.658549Z","end":"2026-04-13T16:07:06.058761Z","steps":["trace[217149562] 'process raft request' (duration: 399.973533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:07:06.05898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:07:05.658523Z","time spent":"400.343702ms","remote":"127.0.0.1:60574","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-13T16:07:06.059107Z","caller":"traceutil/trace.go:171","msg":"trace[440177027] transaction","detail":"{read_only:false; response_revision:2899; number_of_response:1; }","duration":"400.502456ms","start":"2026-04-13T16:07:05.658574Z","end":"2026-04-13T16:07:06.059076Z","steps":["trace[440177027] 'process raft request' (duration: 400.121907ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:07:06.05914Z","caller":"traceutil/trace.go:171","msg":"trace[531907243] transaction","detail":"{read_only:false; response_revision:2900; number_of_response:1; }","duration":"400.481905ms","start":"2026-04-13T16:07:05.658629Z","end":"2026-04-13T16:07:06.059111Z","steps":["trace[531907243] 'process raft request' (duration: 400.348282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:07:06.059301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:07:05.65861Z","time spent":"400.612938ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T16:07:06.059286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:07:05.658552Z","time spent":"400.659219ms","remote":"127.0.0.1:60574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T16:07:07.25186Z","caller":"traceutil/trace.go:171","msg":"trace[1002437643] transaction","detail":"{read_only:false; response_revision:2901; number_of_response:1; }","duration":"291.957838ms","start":"2026-04-13T16:07:06.959879Z","end":"2026-04-13T16:07:07.251837Z","steps":["trace[1002437643] 'process raft request' (duration: 291.832765ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:07:07.260156Z","caller":"traceutil/trace.go:171","msg":"trace[1555322361] transaction","detail":"{read_only:false; response_revision:2902; number_of_response:1; }","duration":"280.144599ms","start":"2026-04-13T16:07:06.979992Z","end":"2026-04-13T16:07:07.260136Z","steps":["trace[1555322361] 'process raft request' (duration: 280.009796ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:07:09.373323Z","caller":"traceutil/trace.go:171","msg":"trace[1226979693] transaction","detail":"{read_only:false; response_revision:2928; number_of_response:1; }","duration":"279.960305ms","start":"2026-04-13T16:07:09.093324Z","end":"2026-04-13T16:07:09.373284Z","steps":["trace[1226979693] 'process raft request' (duration: 197.563511ms)","trace[1226979693] 'compare' (duration: 82.23132ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T16:07:09.382369Z","caller":"traceutil/trace.go:171","msg":"trace[880953117] transaction","detail":"{read_only:false; response_revision:2929; number_of_response:1; }","duration":"288.943049ms","start":"2026-04-13T16:07:09.093397Z","end":"2026-04-13T16:07:09.38234Z","steps":["trace[880953117] 'process raft request' (duration: 288.777745ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:07:09.382547Z","caller":"traceutil/trace.go:171","msg":"trace[1952103781] transaction","detail":"{read_only:false; response_revision:2930; number_of_response:1; }","duration":"126.018525ms","start":"2026-04-13T16:07:09.256498Z","end":"2026-04-13T16:07:09.382516Z","steps":["trace[1952103781] 'process raft request' (duration: 125.79658ms)"],"step_count":1}