{"level":"warn","ts":"2026-03-31T18:21:34.162657Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-31T18:21:34.162855Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.161: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.161:2380","--initial-cluster=instance=https://199.19.213.161:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.161:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.161: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-03-31T18:21:34.162969Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-31T18:21:34.163156Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.161:2380"]} {"level":"info","ts":"2026-03-31T18:21:34.163253Z","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-03-31T18:21:34.164465Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.161:2379"]} {"level":"info","ts":"2026-03-31T18:21:34.164592Z","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.161:2380"],"listen-peer-urls":["https://199.19.213.161:2380"],"advertise-client-urls":["https://199.19.213.161:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.161:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.161: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-03-31T18:21:34.16974Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.890486ms"} {"level":"info","ts":"2026-03-31T18:21:34.178306Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2460b0ba85bf91ab","cluster-id":"c077309761674c46"} {"level":"info","ts":"2026-03-31T18:21:34.178422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab switched to configuration voters=()"} {"level":"info","ts":"2026-03-31T18:21:34.178462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab became follower at term 0"} {"level":"info","ts":"2026-03-31T18:21:34.178477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2460b0ba85bf91ab [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-31T18:21:34.178493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab became follower at term 1"} {"level":"info","ts":"2026-03-31T18:21:34.178537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab switched to configuration voters=(2621289298283958699)"} {"level":"warn","ts":"2026-03-31T18:21:34.188522Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-31T18:21:34.189724Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-31T18:21:34.193791Z","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-03-31T18:21:34.196007Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2460b0ba85bf91ab","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-31T18:21:34.196276Z","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-03-31T18:21:34.196371Z","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-03-31T18:21:34.196381Z","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-03-31T18:21:34.196315Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2460b0ba85bf91ab","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-31T18:21:34.198229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab switched to configuration voters=(2621289298283958699)"} {"level":"info","ts":"2026-03-31T18:21:34.19846Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c077309761674c46","local-member-id":"2460b0ba85bf91ab","added-peer-id":"2460b0ba85bf91ab","added-peer-peer-urls":["https://199.19.213.161:2380"]} {"level":"info","ts":"2026-03-31T18:21:34.201569Z","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-03-31T18:21:34.201841Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.161:2380"} {"level":"info","ts":"2026-03-31T18:21:34.201964Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.161:2380"} {"level":"info","ts":"2026-03-31T18:21:34.202239Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2460b0ba85bf91ab","initial-advertise-peer-urls":["https://199.19.213.161:2380"],"listen-peer-urls":["https://199.19.213.161:2380"],"advertise-client-urls":["https://199.19.213.161:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.161:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-31T18:21:34.202368Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-31T18:21:34.480869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab is starting a new election at term 1"} {"level":"info","ts":"2026-03-31T18:21:34.481003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab became pre-candidate at term 1"} {"level":"info","ts":"2026-03-31T18:21:34.481034Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab received MsgPreVoteResp from 2460b0ba85bf91ab at term 1"} {"level":"info","ts":"2026-03-31T18:21:34.481062Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab became candidate at term 2"} {"level":"info","ts":"2026-03-31T18:21:34.481079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab received MsgVoteResp from 2460b0ba85bf91ab at term 2"} {"level":"info","ts":"2026-03-31T18:21:34.4811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab became leader at term 2"} {"level":"info","ts":"2026-03-31T18:21:34.48112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2460b0ba85bf91ab elected leader 2460b0ba85bf91ab at term 2"} {"level":"info","ts":"2026-03-31T18:21:34.482174Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T18:21:34.483144Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-31T18:21:34.483202Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-31T18:21:34.483147Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2460b0ba85bf91ab","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.161:2379]}","request-path":"/0/members/2460b0ba85bf91ab/attributes","cluster-id":"c077309761674c46","publish-timeout":"7s"} {"level":"info","ts":"2026-03-31T18:21:34.484425Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-31T18:21:34.484497Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c077309761674c46","local-member-id":"2460b0ba85bf91ab","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T18:21:34.484521Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-31T18:21:34.484604Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T18:21:34.484642Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T18:21:34.486578Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.161:2379"} {"level":"info","ts":"2026-03-31T18:21:34.487327Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-03-31T18:21:44.178484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.04274ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:21:44.178927Z","caller":"traceutil/trace.go:171","msg":"trace[548449297] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"340.2157ms","start":"2026-03-31T18:21:43.838663Z","end":"2026-03-31T18:21:44.178879Z","steps":["trace[548449297] 'process raft request' (duration: 124.918648ms)","trace[548449297] 'compare' (duration: 213.879287ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:44.179064Z","caller":"traceutil/trace.go:171","msg":"trace[975243644] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"340.371963ms","start":"2026-03-31T18:21:43.838665Z","end":"2026-03-31T18:21:44.179037Z","steps":["trace[975243644] 'process raft request' (duration: 340.016117ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:44.179038Z","caller":"traceutil/trace.go:171","msg":"trace[450595347] linearizableReadLoop","detail":"{readStateIndex:327; appliedIndex:324; }","duration":"332.242654ms","start":"2026-03-31T18:21:43.84677Z","end":"2026-03-31T18:21:44.179013Z","steps":["trace[450595347] 'read index received' (duration: 116.727708ms)","trace[450595347] 'applied index is now lower than readState.Index' (duration: 215.513406ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:21:44.179141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:43.838639Z","time spent":"340.394994ms","remote":"127.0.0.1:34616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:21:44.179207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:43.83862Z","time spent":"340.515156ms","remote":"127.0.0.1:34616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2264,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:21:44.179368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.597201ms","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-03-31T18:21:44.179345Z","caller":"traceutil/trace.go:171","msg":"trace[940234501] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"340.057708ms","start":"2026-03-31T18:21:43.839251Z","end":"2026-03-31T18:21:44.179309Z","steps":["trace[940234501] 'process raft request' (duration: 339.688581ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:44.179427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.014492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-03-31T18:21:44.179459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.944817ms","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-03-31T18:21:44.17948Z","caller":"traceutil/trace.go:171","msg":"trace[1930312800] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:316; }","duration":"232.000848ms","start":"2026-03-31T18:21:43.947473Z","end":"2026-03-31T18:21:44.179474Z","steps":["trace[1930312800] 'agreement among raft nodes before linearized reading' (duration: 231.957097ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:44.179476Z","caller":"traceutil/trace.go:171","msg":"trace[1884255105] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:316; }","duration":"132.101864ms","start":"2026-03-31T18:21:44.047361Z","end":"2026-03-31T18:21:44.179463Z","steps":["trace[1884255105] 'agreement among raft nodes before linearized reading' (duration: 132.008852ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:44.179528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:43.839227Z","time spent":"340.21193ms","remote":"127.0.0.1:34438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4355,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:21:44.179555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.611415ms","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-03-31T18:21:44.179657Z","caller":"traceutil/trace.go:171","msg":"trace[1568972244] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:316; }","duration":"181.729946ms","start":"2026-03-31T18:21:43.997889Z","end":"2026-03-31T18:21:44.179619Z","steps":["trace[1568972244] 'agreement among raft nodes before linearized reading' (duration: 181.537703ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:44.179404Z","caller":"traceutil/trace.go:171","msg":"trace[1807560810] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:316; }","duration":"332.722873ms","start":"2026-03-31T18:21:43.846671Z","end":"2026-03-31T18:21:44.179393Z","steps":["trace[1807560810] 'agreement among raft nodes before linearized reading' (duration: 332.637512ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:44.179828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:43.846654Z","time spent":"333.166561ms","remote":"127.0.0.1:34458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":237,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"warn","ts":"2026-03-31T18:21:44.18028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.411402ms","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-03-31T18:21:44.180349Z","caller":"traceutil/trace.go:171","msg":"trace[2028128232] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:316; }","duration":"282.530284ms","start":"2026-03-31T18:21:43.897804Z","end":"2026-03-31T18:21:44.180334Z","steps":["trace[2028128232] 'agreement among raft nodes before linearized reading' (duration: 281.614477ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:44.445549Z","caller":"traceutil/trace.go:171","msg":"trace[1712622674] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"259.352568ms","start":"2026-03-31T18:21:44.18617Z","end":"2026-03-31T18:21:44.445523Z","steps":["trace[1712622674] 'process raft request' (duration: 176.882508ms)","trace[1712622674] 'compare' (duration: 82.307007ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:44.448874Z","caller":"traceutil/trace.go:171","msg":"trace[1053743122] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"262.389623ms","start":"2026-03-31T18:21:44.186446Z","end":"2026-03-31T18:21:44.448836Z","steps":["trace[1053743122] 'process raft request' (duration: 262.175239ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:44.449058Z","caller":"traceutil/trace.go:171","msg":"trace[1770382826] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"258.105715ms","start":"2026-03-31T18:21:44.190926Z","end":"2026-03-31T18:21:44.449032Z","steps":["trace[1770382826] 'process raft request' (duration: 258.038794ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:44.449157Z","caller":"traceutil/trace.go:171","msg":"trace[581749641] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"260.371387ms","start":"2026-03-31T18:21:44.188768Z","end":"2026-03-31T18:21:44.44914Z","steps":["trace[581749641] 'process raft request' (duration: 260.074781ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:44.449231Z","caller":"traceutil/trace.go:171","msg":"trace[1298256987] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"259.193396ms","start":"2026-03-31T18:21:44.189973Z","end":"2026-03-31T18:21:44.449166Z","steps":["trace[1298256987] 'process raft request' (duration: 258.94328ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:44.448935Z","caller":"traceutil/trace.go:171","msg":"trace[381369292] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"260.327985ms","start":"2026-03-31T18:21:44.188568Z","end":"2026-03-31T18:21:44.448896Z","steps":["trace[381369292] 'process raft request' (duration: 260.155042ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:44.449374Z","caller":"traceutil/trace.go:171","msg":"trace[1774391453] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"260.682512ms","start":"2026-03-31T18:21:44.188677Z","end":"2026-03-31T18:21:44.449359Z","steps":["trace[1774391453] 'process raft request' (duration: 260.116701ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:45.834393Z","caller":"traceutil/trace.go:171","msg":"trace[1208042977] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"139.991369ms","start":"2026-03-31T18:21:45.69433Z","end":"2026-03-31T18:21:45.834321Z","steps":["trace[1208042977] 'process raft request' (duration: 117.849879ms)","trace[1208042977] 'compare' (duration: 21.790764ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:48.143678Z","caller":"traceutil/trace.go:171","msg":"trace[231541044] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"190.984784ms","start":"2026-03-31T18:21:47.952676Z","end":"2026-03-31T18:21:48.14366Z","steps":["trace[231541044] 'process raft request' (duration: 190.538426ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:48.623397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.905038ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-03-31T18:21:48.623489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:48.144813Z","time spent":"478.672825ms","remote":"127.0.0.1:34284","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-03-31T18:21:48.623506Z","caller":"traceutil/trace.go:171","msg":"trace[690767906] linearizableReadLoop","detail":"{readStateIndex:375; appliedIndex:374; }","duration":"124.181216ms","start":"2026-03-31T18:21:48.499311Z","end":"2026-03-31T18:21:48.623492Z","steps":["trace[690767906] 'read index received' (duration: 31.13µs)","trace[690767906] 'applied index is now lower than readState.Index' (duration: 124.148776ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:21:48.62357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.250977ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:21:48.623687Z","caller":"traceutil/trace.go:171","msg":"trace[1146020838] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:362; }","duration":"124.37385ms","start":"2026-03-31T18:21:48.499305Z","end":"2026-03-31T18:21:48.623678Z","steps":["trace[1146020838] 'agreement among raft nodes before linearized reading' (duration: 124.221887ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:49.125907Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656276751673147,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T18:21:49.626633Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656276751673147,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T18:21:50.127591Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656276751673147,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T18:21:50.62857Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656276751673147,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T18:21:50.743755Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.119482093s","expected-duration":"1s"} {"level":"warn","ts":"2026-03-31T18:21:51.065307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.24515241s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:21:51.065443Z","caller":"traceutil/trace.go:171","msg":"trace[1745877704] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:362; }","duration":"2.245299052s","start":"2026-03-31T18:21:48.820127Z","end":"2026-03-31T18:21:51.065426Z","steps":["trace[1745877704] 'range keys from in-memory index tree' (duration: 2.24513792s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:51.066104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.04824ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:21:51.06634Z","caller":"traceutil/trace.go:171","msg":"trace[1429390820] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"2.442078293s","start":"2026-03-31T18:21:48.624204Z","end":"2026-03-31T18:21:51.066282Z","steps":["trace[1429390820] 'process raft request' (duration: 2.119760718s)","trace[1429390820] 'compare' (duration: 321.594521ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:21:51.066416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:48.624184Z","time spent":"2.442199145s","remote":"127.0.0.1:34284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T18:21:51.084213Z","caller":"traceutil/trace.go:171","msg":"trace[1765638835] linearizableReadLoop","detail":"{readStateIndex:377; appliedIndex:375; }","duration":"2.458544588s","start":"2026-03-31T18:21:48.625647Z","end":"2026-03-31T18:21:51.084192Z","steps":["trace[1765638835] 'read index received' (duration: 2.118325643s)","trace[1765638835] 'applied index is now lower than readState.Index' (duration: 340.217624ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:51.084347Z","caller":"traceutil/trace.go:171","msg":"trace[633327637] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"984.827239ms","start":"2026-03-31T18:21:50.09951Z","end":"2026-03-31T18:21:51.084337Z","steps":["trace[633327637] 'process raft request' (duration: 984.529464ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:51.084462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:50.099482Z","time spent":"984.900381ms","remote":"127.0.0.1:34514","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-03-31T18:21:51.08463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.458977386s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5336"} {"level":"warn","ts":"2026-03-31T18:21:51.084665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.455133576s","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-03-31T18:21:51.084672Z","caller":"traceutil/trace.go:171","msg":"trace[1998390045] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:364; }","duration":"2.459033026s","start":"2026-03-31T18:21:48.625626Z","end":"2026-03-31T18:21:51.084659Z","steps":["trace[1998390045] 'agreement among raft nodes before linearized reading' (duration: 2.458958605s)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:51.084699Z","caller":"traceutil/trace.go:171","msg":"trace[519106286] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:364; }","duration":"2.455185287s","start":"2026-03-31T18:21:48.629504Z","end":"2026-03-31T18:21:51.084689Z","steps":["trace[519106286] 'agreement among raft nodes before linearized reading' (duration: 2.455092235s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:51.084696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.892043741s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-03-31T18:21:51.084707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:48.625618Z","time spent":"2.459081027s","remote":"127.0.0.1:34442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5359,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"warn","ts":"2026-03-31T18:21:51.084721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:48.629496Z","time spent":"2.455219898s","remote":"127.0.0.1:34514","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-03-31T18:21:51.084729Z","caller":"traceutil/trace.go:171","msg":"trace[1104901185] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:364; }","duration":"1.892076571s","start":"2026-03-31T18:21:49.192642Z","end":"2026-03-31T18:21:51.084719Z","steps":["trace[1104901185] 'agreement among raft nodes before linearized reading' (duration: 1.89201605s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:51.084757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:49.192593Z","time spent":"1.892159053s","remote":"127.0.0.1:34514","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-03-31T18:21:51.084828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.440407036s","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-03-31T18:21:51.084847Z","caller":"traceutil/trace.go:171","msg":"trace[1068529405] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:364; }","duration":"2.440447457s","start":"2026-03-31T18:21:48.644394Z","end":"2026-03-31T18:21:51.084841Z","steps":["trace[1068529405] 'agreement among raft nodes before linearized reading' (duration: 2.440414236s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:51.084822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.10872367s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-03-31T18:21:51.084867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:48.644383Z","time spent":"2.440480218s","remote":"127.0.0.1:34514","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-03-31T18:21:51.084901Z","caller":"traceutil/trace.go:171","msg":"trace[343774409] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:364; }","duration":"2.108849663s","start":"2026-03-31T18:21:48.976033Z","end":"2026-03-31T18:21:51.084883Z","steps":["trace[343774409] 'agreement among raft nodes before linearized reading' (duration: 2.10867266s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:51.084933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:48.976013Z","time spent":"2.108911894s","remote":"127.0.0.1:34514","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-03-31T18:21:51.084916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.912157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:21:51.08501Z","caller":"traceutil/trace.go:171","msg":"trace[386827142] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:364; }","duration":"368.05352ms","start":"2026-03-31T18:21:50.716933Z","end":"2026-03-31T18:21:51.084987Z","steps":["trace[386827142] 'agreement among raft nodes before linearized reading' (duration: 367.906878ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:51.085055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:50.716914Z","time spent":"368.132631ms","remote":"127.0.0.1:34264","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-03-31T18:21:55.618093Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656276751673181,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-31T18:21:55.681605Z","caller":"traceutil/trace.go:171","msg":"trace[1975576689] linearizableReadLoop","detail":"{readStateIndex:391; appliedIndex:390; }","duration":"563.825571ms","start":"2026-03-31T18:21:55.117755Z","end":"2026-03-31T18:21:55.681581Z","steps":["trace[1975576689] 'read index received' (duration: 563.544547ms)","trace[1975576689] 'applied index is now lower than readState.Index' (duration: 279.984µs)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:21:55.681774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.001834ms","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-03-31T18:21:55.681697Z","caller":"traceutil/trace.go:171","msg":"trace[1231323722] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"574.233616ms","start":"2026-03-31T18:21:55.10741Z","end":"2026-03-31T18:21:55.681644Z","steps":["trace[1231323722] 'process raft request' (duration: 573.957822ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:55.68182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.368286ms","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-03-31T18:21:55.681895Z","caller":"traceutil/trace.go:171","msg":"trace[650466297] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:377; }","duration":"559.457167ms","start":"2026-03-31T18:21:55.122421Z","end":"2026-03-31T18:21:55.681878Z","steps":["trace[650466297] 'agreement among raft nodes before linearized reading' (duration: 559.348206ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:55.681928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:55.122416Z","time spent":"559.504428ms","remote":"127.0.0.1:34514","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-03-31T18:21:55.682076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.386686ms","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-03-31T18:21:55.682098Z","caller":"traceutil/trace.go:171","msg":"trace[1202568256] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:377; }","duration":"559.426617ms","start":"2026-03-31T18:21:55.122665Z","end":"2026-03-31T18:21:55.682092Z","steps":["trace[1202568256] 'agreement among raft nodes before linearized reading' (duration: 559.389266ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:55.682112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:55.122629Z","time spent":"559.479027ms","remote":"127.0.0.1:34514","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-03-31T18:21:55.681822Z","caller":"traceutil/trace.go:171","msg":"trace[231990708] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:377; }","duration":"564.086155ms","start":"2026-03-31T18:21:55.117722Z","end":"2026-03-31T18:21:55.681808Z","steps":["trace[231990708] 'agreement among raft nodes before linearized reading' (duration: 563.996394ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:21:55.682352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:55.117709Z","time spent":"564.628064ms","remote":"127.0.0.1:34514","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-03-31T18:21:55.68284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:21:55.107368Z","time spent":"574.526462ms","remote":"127.0.0.1:34514","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-03-31T18:21:55.842638Z","caller":"traceutil/trace.go:171","msg":"trace[1316471779] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"156.907768ms","start":"2026-03-31T18:21:55.685704Z","end":"2026-03-31T18:21:55.842612Z","steps":["trace[1316471779] 'process raft request' (duration: 142.003255ms)","trace[1316471779] 'compare' (duration: 14.531726ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:21:55.844349Z","caller":"traceutil/trace.go:171","msg":"trace[658097467] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"156.741435ms","start":"2026-03-31T18:21:55.687583Z","end":"2026-03-31T18:21:55.844325Z","steps":["trace[658097467] 'process raft request' (duration: 156.650203ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:55.844453Z","caller":"traceutil/trace.go:171","msg":"trace[1617725201] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"138.992895ms","start":"2026-03-31T18:21:55.705448Z","end":"2026-03-31T18:21:55.84444Z","steps":["trace[1617725201] 'process raft request' (duration: 138.822232ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:21:55.844354Z","caller":"traceutil/trace.go:171","msg":"trace[164816596] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"156.957538ms","start":"2026-03-31T18:21:55.687365Z","end":"2026-03-31T18:21:55.844323Z","steps":["trace[164816596] 'process raft request' (duration: 156.766085ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:02.20974Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656276751673251,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T18:22:02.232556Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.027433047s","expected-duration":"1s"} {"level":"info","ts":"2026-03-31T18:22:02.232866Z","caller":"traceutil/trace.go:171","msg":"trace[644000553] linearizableReadLoop","detail":"{readStateIndex:435; appliedIndex:434; }","duration":"523.658642ms","start":"2026-03-31T18:22:01.709187Z","end":"2026-03-31T18:22:02.232845Z","steps":["trace[644000553] 'read index received' (duration: 523.48198ms)","trace[644000553] 'applied index is now lower than readState.Index' (duration: 175.842µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:22:02.23293Z","caller":"traceutil/trace.go:171","msg":"trace[1793098103] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"1.027919084s","start":"2026-03-31T18:22:01.204981Z","end":"2026-03-31T18:22:02.2329Z","steps":["trace[1793098103] 'process raft request' (duration: 1.027748872s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:02.23299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.804984ms","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-03-31T18:22:02.233027Z","caller":"traceutil/trace.go:171","msg":"trace[1046426171] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:420; }","duration":"523.894376ms","start":"2026-03-31T18:22:01.709122Z","end":"2026-03-31T18:22:02.233016Z","steps":["trace[1046426171] 'agreement among raft nodes before linearized reading' (duration: 523.810325ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:02.233059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:01.709103Z","time spent":"523.946277ms","remote":"127.0.0.1:34514","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-03-31T18:22:02.233081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.464919ms","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-03-31T18:22:02.233085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.783514ms","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-03-31T18:22:02.233095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.78946ms","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-03-31T18:22:02.233118Z","caller":"traceutil/trace.go:171","msg":"trace[1423525536] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:420; }","duration":"358.54135ms","start":"2026-03-31T18:22:01.874567Z","end":"2026-03-31T18:22:02.233108Z","steps":["trace[1423525536] 'agreement among raft nodes before linearized reading' (duration: 358.452368ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:02.233125Z","caller":"traceutil/trace.go:171","msg":"trace[383853588] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:420; }","duration":"358.857925ms","start":"2026-03-31T18:22:01.874257Z","end":"2026-03-31T18:22:02.233115Z","steps":["trace[383853588] 'agreement among raft nodes before linearized reading' (duration: 358.779903ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:02.233148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:01.874551Z","time spent":"358.589431ms","remote":"127.0.0.1:34514","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-03-31T18:22:02.233151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:01.874244Z","time spent":"358.900766ms","remote":"127.0.0.1:34514","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-03-31T18:22:02.233147Z","caller":"traceutil/trace.go:171","msg":"trace[1269424469] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:420; }","duration":"362.899991ms","start":"2026-03-31T18:22:01.870233Z","end":"2026-03-31T18:22:02.233133Z","steps":["trace[1269424469] 'agreement among raft nodes before linearized reading' (duration: 362.765929ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:02.233197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:01.870214Z","time spent":"362.974422ms","remote":"127.0.0.1:34514","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-03-31T18:22:02.23339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:01.204957Z","time spent":"1.028028336s","remote":"127.0.0.1:34514","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-03-31T18:22:02.233696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.25835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:02.233767Z","caller":"traceutil/trace.go:171","msg":"trace[1256666819] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:420; }","duration":"341.371021ms","start":"2026-03-31T18:22:01.892379Z","end":"2026-03-31T18:22:02.23375Z","steps":["trace[1256666819] 'agreement among raft nodes before linearized reading' (duration: 340.765691ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:02.233797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:01.892362Z","time spent":"341.428362ms","remote":"127.0.0.1:34264","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-03-31T18:22:02.629196Z","caller":"traceutil/trace.go:171","msg":"trace[520468936] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"391.750875ms","start":"2026-03-31T18:22:02.237425Z","end":"2026-03-31T18:22:02.629176Z","steps":["trace[520468936] 'process raft request' (duration: 391.694724ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:02.629254Z","caller":"traceutil/trace.go:171","msg":"trace[388668447] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"392.264073ms","start":"2026-03-31T18:22:02.236972Z","end":"2026-03-31T18:22:02.629236Z","steps":["trace[388668447] 'process raft request' (duration: 391.014523ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:02.629329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:02.237416Z","time spent":"391.847036ms","remote":"127.0.0.1:34514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:22:02.629338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:02.236954Z","time spent":"392.340454ms","remote":"127.0.0.1:34514","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-03-31T18:22:02.629475Z","caller":"traceutil/trace.go:171","msg":"trace[1209092194] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"390.610986ms","start":"2026-03-31T18:22:02.238848Z","end":"2026-03-31T18:22:02.629459Z","steps":["trace[1209092194] 'process raft request' (duration: 390.298021ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:02.629522Z","caller":"traceutil/trace.go:171","msg":"trace[1671498722] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"392.360875ms","start":"2026-03-31T18:22:02.237149Z","end":"2026-03-31T18:22:02.62951Z","steps":["trace[1671498722] 'process raft request' (duration: 391.918678ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:02.629559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:02.238839Z","time spent":"390.686497ms","remote":"127.0.0.1:34514","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-03-31T18:22:02.6296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:02.237142Z","time spent":"392.410125ms","remote":"127.0.0.1:34514","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-03-31T18:22:06.794768Z","caller":"traceutil/trace.go:171","msg":"trace[2054923977] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"131.016086ms","start":"2026-03-31T18:22:06.663724Z","end":"2026-03-31T18:22:06.79474Z","steps":["trace[2054923977] 'process raft request' (duration: 130.955495ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:06.794809Z","caller":"traceutil/trace.go:171","msg":"trace[1119553719] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"135.057289ms","start":"2026-03-31T18:22:06.659714Z","end":"2026-03-31T18:22:06.794771Z","steps":["trace[1119553719] 'process raft request' (duration: 134.793295ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:06.794894Z","caller":"traceutil/trace.go:171","msg":"trace[173049159] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"135.074199ms","start":"2026-03-31T18:22:06.65976Z","end":"2026-03-31T18:22:06.794834Z","steps":["trace[173049159] 'process raft request' (duration: 134.883246ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:07.730066Z","caller":"traceutil/trace.go:171","msg":"trace[1296462626] linearizableReadLoop","detail":"{readStateIndex:449; appliedIndex:448; }","duration":"138.243516ms","start":"2026-03-31T18:22:07.591802Z","end":"2026-03-31T18:22:07.730045Z","steps":["trace[1296462626] 'read index received' (duration: 59.009724ms)","trace[1296462626] 'applied index is now lower than readState.Index' (duration: 79.232392ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:22:07.73059Z","caller":"traceutil/trace.go:171","msg":"trace[542576951] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"374.077902ms","start":"2026-03-31T18:22:07.35648Z","end":"2026-03-31T18:22:07.730558Z","steps":["trace[542576951] 'process raft request' (duration: 294.412564ms)","trace[542576951] 'compare' (duration: 78.559571ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:22:07.730741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:07.356449Z","time spent":"374.201223ms","remote":"127.0.0.1:34514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:22:07.734254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.429902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12677"} {"level":"info","ts":"2026-03-31T18:22:07.734297Z","caller":"traceutil/trace.go:171","msg":"trace[239355250] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:433; }","duration":"142.522504ms","start":"2026-03-31T18:22:07.591763Z","end":"2026-03-31T18:22:07.734285Z","steps":["trace[239355250] 'agreement among raft nodes before linearized reading' (duration: 138.358238ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:08.833849Z","caller":"traceutil/trace.go:171","msg":"trace[1554523253] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"147.59842ms","start":"2026-03-31T18:22:08.686229Z","end":"2026-03-31T18:22:08.833827Z","steps":["trace[1554523253] 'process raft request' (duration: 147.099612ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:09.307346Z","caller":"traceutil/trace.go:171","msg":"trace[1708141372] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"127.052938ms","start":"2026-03-31T18:22:09.180242Z","end":"2026-03-31T18:22:09.307295Z","steps":["trace[1708141372] 'process raft request' (duration: 126.984627ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:09.307385Z","caller":"traceutil/trace.go:171","msg":"trace[83669469] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"127.18408ms","start":"2026-03-31T18:22:09.180158Z","end":"2026-03-31T18:22:09.307342Z","steps":["trace[83669469] 'process raft request' (duration: 111.035749ms)","trace[83669469] 'compare' (duration: 15.764805ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:22:09.525524Z","caller":"traceutil/trace.go:171","msg":"trace[970202354] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"117.45727ms","start":"2026-03-31T18:22:09.40805Z","end":"2026-03-31T18:22:09.525507Z","steps":["trace[970202354] 'process raft request' (duration: 117.42511ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:09.525611Z","caller":"traceutil/trace.go:171","msg":"trace[1783065799] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"117.688693ms","start":"2026-03-31T18:22:09.407868Z","end":"2026-03-31T18:22:09.525557Z","steps":["trace[1783065799] 'process raft request' (duration: 62.090392ms)","trace[1783065799] 'compare' (duration: 55.373318ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:22:09.870106Z","caller":"traceutil/trace.go:171","msg":"trace[380246262] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"162.839963ms","start":"2026-03-31T18:22:09.707231Z","end":"2026-03-31T18:22:09.870071Z","steps":["trace[380246262] 'process raft request' (duration: 162.541198ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:10.049611Z","caller":"traceutil/trace.go:171","msg":"trace[1330406065] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"145.715644ms","start":"2026-03-31T18:22:09.903878Z","end":"2026-03-31T18:22:10.049593Z","steps":["trace[1330406065] 'process raft request' (duration: 145.573681ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:10.049757Z","caller":"traceutil/trace.go:171","msg":"trace[1954043647] linearizableReadLoop","detail":"{readStateIndex:469; appliedIndex:469; }","duration":"141.939326ms","start":"2026-03-31T18:22:09.907766Z","end":"2026-03-31T18:22:10.049706Z","steps":["trace[1954043647] 'read index received' (duration: 141.905386ms)","trace[1954043647] 'applied index is now lower than readState.Index' (duration: 27.79µs)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:22:10.049991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.20484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:10.0501Z","caller":"traceutil/trace.go:171","msg":"trace[1145423157] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:452; }","duration":"142.367132ms","start":"2026-03-31T18:22:09.907714Z","end":"2026-03-31T18:22:10.050081Z","steps":["trace[1145423157] 'agreement among raft nodes before linearized reading' (duration: 142.133628ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:10.102301Z","caller":"traceutil/trace.go:171","msg":"trace[19974409] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"122.141505ms","start":"2026-03-31T18:22:09.980128Z","end":"2026-03-31T18:22:10.102269Z","steps":["trace[19974409] 'process raft request' (duration: 121.85453ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:10.217806Z","caller":"traceutil/trace.go:171","msg":"trace[1525133890] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"163.700801ms","start":"2026-03-31T18:22:10.054058Z","end":"2026-03-31T18:22:10.217759Z","steps":["trace[1525133890] 'process raft request' (duration: 144.534735ms)","trace[1525133890] 'compare' (duration: 18.890592ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:22:10.217935Z","caller":"traceutil/trace.go:171","msg":"trace[2022565435] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"163.264665ms","start":"2026-03-31T18:22:10.054633Z","end":"2026-03-31T18:22:10.217898Z","steps":["trace[2022565435] 'process raft request' (duration: 163.015331ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:10.217927Z","caller":"traceutil/trace.go:171","msg":"trace[1618772609] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"161.702941ms","start":"2026-03-31T18:22:10.05615Z","end":"2026-03-31T18:22:10.217852Z","steps":["trace[1618772609] 'process raft request' (duration: 161.543889ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:10.218198Z","caller":"traceutil/trace.go:171","msg":"trace[2064006842] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"160.858637ms","start":"2026-03-31T18:22:10.057328Z","end":"2026-03-31T18:22:10.218187Z","steps":["trace[2064006842] 'process raft request' (duration: 160.39109ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:10.645423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.532506ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:22:10.6458Z","caller":"traceutil/trace.go:171","msg":"trace[49579620] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"358.783637ms","start":"2026-03-31T18:22:10.28699Z","end":"2026-03-31T18:22:10.645774Z","steps":["trace[49579620] 'process raft request' (duration: 358.581584ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:10.645791Z","caller":"traceutil/trace.go:171","msg":"trace[149094112] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"360.32421ms","start":"2026-03-31T18:22:10.285435Z","end":"2026-03-31T18:22:10.645759Z","steps":["trace[149094112] 'process raft request' (duration: 152.295337ms)","trace[149094112] 'compare' (duration: 207.14374ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:22:10.645956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:10.285413Z","time spent":"360.454982ms","remote":"127.0.0.1:34748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4339,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:22:10.64593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:10.28696Z","time spent":"358.928958ms","remote":"127.0.0.1:34340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":671,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T18:22:10.680903Z","caller":"traceutil/trace.go:171","msg":"trace[172691134] linearizableReadLoop","detail":"{readStateIndex:485; appliedIndex:481; }","duration":"322.665ms","start":"2026-03-31T18:22:10.358215Z","end":"2026-03-31T18:22:10.68088Z","steps":["trace[172691134] 'read index received' (duration: 79.478875ms)","trace[172691134] 'applied index is now lower than readState.Index' (duration: 243.184735ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:22:10.68092Z","caller":"traceutil/trace.go:171","msg":"trace[1361124732] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"353.15817ms","start":"2026-03-31T18:22:10.327718Z","end":"2026-03-31T18:22:10.680876Z","steps":["trace[1361124732] 'process raft request' (duration: 352.737324ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:10.681057Z","caller":"traceutil/trace.go:171","msg":"trace[71299568] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"337.828544ms","start":"2026-03-31T18:22:10.343174Z","end":"2026-03-31T18:22:10.681003Z","steps":["trace[71299568] 'process raft request' (duration: 337.6132ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:10.681262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:10.327694Z","time spent":"353.438925ms","remote":"127.0.0.1:34738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14448,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:22:10.681309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:10.343149Z","time spent":"338.012047ms","remote":"127.0.0.1:34442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16950,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:22:10.681592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.357181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329960"} {"level":"info","ts":"2026-03-31T18:22:10.681686Z","caller":"traceutil/trace.go:171","msg":"trace[1302819442] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:468; }","duration":"323.492283ms","start":"2026-03-31T18:22:10.358178Z","end":"2026-03-31T18:22:10.68167Z","steps":["trace[1302819442] 'agreement among raft nodes before linearized reading' (duration: 322.806613ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:10.681725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:10.358169Z","time spent":"323.547275ms","remote":"127.0.0.1:34356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":4,"response size":329983,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"info","ts":"2026-03-31T18:22:10.851013Z","caller":"traceutil/trace.go:171","msg":"trace[490150908] linearizableReadLoop","detail":"{readStateIndex:487; appliedIndex:485; }","duration":"169.914157ms","start":"2026-03-31T18:22:10.681074Z","end":"2026-03-31T18:22:10.850988Z","steps":["trace[490150908] 'read index received' (duration: 102.981266ms)","trace[490150908] 'applied index is now lower than readState.Index' (duration: 66.931771ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:22:10.851093Z","caller":"traceutil/trace.go:171","msg":"trace[354609968] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"197.423641ms","start":"2026-03-31T18:22:10.65362Z","end":"2026-03-31T18:22:10.851043Z","steps":["trace[354609968] 'process raft request' (duration: 197.306749ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:10.851214Z","caller":"traceutil/trace.go:171","msg":"trace[2097641878] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"199.853288ms","start":"2026-03-31T18:22:10.65133Z","end":"2026-03-31T18:22:10.851183Z","steps":["trace[2097641878] 'process raft request' (duration: 132.773074ms)","trace[2097641878] 'compare' (duration: 66.642507ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:22:10.851573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.094847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-f5jxc\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-03-31T18:22:10.851652Z","caller":"traceutil/trace.go:171","msg":"trace[1673912297] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-f5jxc; range_end:; response_count:1; response_revision:470; }","duration":"164.208408ms","start":"2026-03-31T18:22:10.687418Z","end":"2026-03-31T18:22:10.851627Z","steps":["trace[1673912297] 'agreement among raft nodes before linearized reading' (duration: 163.975615ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:10.851633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.048133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"} {"level":"warn","ts":"2026-03-31T18:22:10.851691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.947431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"} {"level":"info","ts":"2026-03-31T18:22:10.851734Z","caller":"traceutil/trace.go:171","msg":"trace[1635724161] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:470; }","duration":"415.000612ms","start":"2026-03-31T18:22:10.43672Z","end":"2026-03-31T18:22:10.85172Z","steps":["trace[1635724161] 'agreement among raft nodes before linearized reading' (duration: 414.415133ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:10.851724Z","caller":"traceutil/trace.go:171","msg":"trace[1109672020] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:470; }","duration":"415.189014ms","start":"2026-03-31T18:22:10.436511Z","end":"2026-03-31T18:22:10.8517Z","steps":["trace[1109672020] 'agreement among raft nodes before linearized reading' (duration: 414.87788ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:10.851763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:10.436703Z","time spent":"415.052383ms","remote":"127.0.0.1:34458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":543,"request content":"key:\"/registry/serviceaccounts/kube-system/cilium\" "} {"level":"warn","ts":"2026-03-31T18:22:10.85178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:10.436489Z","time spent":"415.282097ms","remote":"127.0.0.1:34458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":561,"request content":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" "} {"level":"info","ts":"2026-03-31T18:22:11.059968Z","caller":"traceutil/trace.go:171","msg":"trace[1405719718] linearizableReadLoop","detail":"{readStateIndex:489; appliedIndex:488; }","duration":"170.074526ms","start":"2026-03-31T18:22:10.889862Z","end":"2026-03-31T18:22:11.059936Z","steps":["trace[1405719718] 'read index received' (duration: 119.206077ms)","trace[1405719718] 'applied index is now lower than readState.Index' (duration: 50.867179ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:22:11.060191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.294999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:11.060171Z","caller":"traceutil/trace.go:171","msg":"trace[579265859] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"200.85954ms","start":"2026-03-31T18:22:10.859258Z","end":"2026-03-31T18:22:11.060118Z","steps":["trace[579265859] 'process raft request' (duration: 149.838049ms)","trace[579265859] 'compare' (duration: 50.703666ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:22:11.060289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.699642ms","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-03-31T18:22:11.060313Z","caller":"traceutil/trace.go:171","msg":"trace[429657532] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:472; }","duration":"125.778263ms","start":"2026-03-31T18:22:10.934528Z","end":"2026-03-31T18:22:11.060306Z","steps":["trace[429657532] 'agreement among raft nodes before linearized reading' (duration: 125.726542ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:11.060296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.504298ms","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-03-31T18:22:11.060229Z","caller":"traceutil/trace.go:171","msg":"trace[178766014] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:472; }","duration":"170.422061ms","start":"2026-03-31T18:22:10.889797Z","end":"2026-03-31T18:22:11.060219Z","steps":["trace[178766014] 'agreement among raft nodes before linearized reading' (duration: 170.300719ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:11.060388Z","caller":"traceutil/trace.go:171","msg":"trace[757855878] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:472; }","duration":"136.648101ms","start":"2026-03-31T18:22:10.923719Z","end":"2026-03-31T18:22:11.060367Z","steps":["trace[757855878] 'agreement among raft nodes before linearized reading' (duration: 136.444458ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:11.060375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.952166ms","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-03-31T18:22:11.060619Z","caller":"traceutil/trace.go:171","msg":"trace[408613275] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:472; }","duration":"126.21636ms","start":"2026-03-31T18:22:10.934345Z","end":"2026-03-31T18:22:11.060561Z","steps":["trace[408613275] 'agreement among raft nodes before linearized reading' (duration: 125.925966ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:11.309519Z","caller":"traceutil/trace.go:171","msg":"trace[464399454] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"244.856522ms","start":"2026-03-31T18:22:11.064624Z","end":"2026-03-31T18:22:11.30948Z","steps":["trace[464399454] 'process raft request' (duration: 240.926541ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:11.378922Z","caller":"traceutil/trace.go:171","msg":"trace[330121704] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"312.583999ms","start":"2026-03-31T18:22:11.066317Z","end":"2026-03-31T18:22:11.378901Z","steps":["trace[330121704] 'process raft request' (duration: 312.550379ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:11.378987Z","caller":"traceutil/trace.go:171","msg":"trace[1282187789] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"312.746132ms","start":"2026-03-31T18:22:11.066204Z","end":"2026-03-31T18:22:11.37895Z","steps":["trace[1282187789] 'process raft request' (duration: 312.553269ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:11.379051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:11.066306Z","time spent":"312.682571ms","remote":"127.0.0.1:34514","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-03-31T18:22:11.379119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:11.066174Z","time spent":"312.873083ms","remote":"127.0.0.1:34514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T18:22:12.210122Z","caller":"traceutil/trace.go:171","msg":"trace[453948899] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"104.602213ms","start":"2026-03-31T18:22:12.105497Z","end":"2026-03-31T18:22:12.210099Z","steps":["trace[453948899] 'process raft request' (duration: 104.500982ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:12.329043Z","caller":"traceutil/trace.go:171","msg":"trace[878811706] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"208.12027ms","start":"2026-03-31T18:22:12.120895Z","end":"2026-03-31T18:22:12.329015Z","steps":["trace[878811706] 'process raft request' (duration: 207.650233ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:12.329346Z","caller":"traceutil/trace.go:171","msg":"trace[732132648] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"208.473046ms","start":"2026-03-31T18:22:12.120853Z","end":"2026-03-31T18:22:12.329326Z","steps":["trace[732132648] 'process raft request' (duration: 207.538552ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:12.329374Z","caller":"traceutil/trace.go:171","msg":"trace[540540970] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"208.530328ms","start":"2026-03-31T18:22:12.120795Z","end":"2026-03-31T18:22:12.329325Z","steps":["trace[540540970] 'process raft request' (duration: 207.463192ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:12.329931Z","caller":"traceutil/trace.go:171","msg":"trace[1747227388] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"206.023778ms","start":"2026-03-31T18:22:12.123892Z","end":"2026-03-31T18:22:12.329915Z","steps":["trace[1747227388] 'process raft request' (duration: 204.787949ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:12.330108Z","caller":"traceutil/trace.go:171","msg":"trace[1942601250] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"208.902332ms","start":"2026-03-31T18:22:12.121192Z","end":"2026-03-31T18:22:12.330094Z","steps":["trace[1942601250] 'process raft request' (duration: 207.40798ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:12.330438Z","caller":"traceutil/trace.go:171","msg":"trace[559107725] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"221.058597ms","start":"2026-03-31T18:22:12.109366Z","end":"2026-03-31T18:22:12.330424Z","steps":["trace[559107725] 'process raft request' (duration: 218.687001ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:12.330692Z","caller":"traceutil/trace.go:171","msg":"trace[640655332] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"197.306726ms","start":"2026-03-31T18:22:12.133372Z","end":"2026-03-31T18:22:12.330679Z","steps":["trace[640655332] 'process raft request' (duration: 195.381207ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:12.330916Z","caller":"traceutil/trace.go:171","msg":"trace[2088852571] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"220.474528ms","start":"2026-03-31T18:22:12.110408Z","end":"2026-03-31T18:22:12.330882Z","steps":["trace[2088852571] 'process raft request' (duration: 217.799118ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:12.328945Z","caller":"traceutil/trace.go:171","msg":"trace[1081585149] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"181.319423ms","start":"2026-03-31T18:22:12.147603Z","end":"2026-03-31T18:22:12.328923Z","steps":["trace[1081585149] 'process raft request' (duration: 181.268352ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:12.330997Z","caller":"traceutil/trace.go:171","msg":"trace[549540581] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"196.982582ms","start":"2026-03-31T18:22:12.134Z","end":"2026-03-31T18:22:12.330983Z","steps":["trace[549540581] 'process raft request' (duration: 194.807348ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:12.509271Z","caller":"traceutil/trace.go:171","msg":"trace[261069018] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"293.208417ms","start":"2026-03-31T18:22:12.216022Z","end":"2026-03-31T18:22:12.509231Z","steps":["trace[261069018] 'process raft request' (duration: 231.866983ms)","trace[261069018] 'compare' (duration: 61.122051ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:22:12.509466Z","caller":"traceutil/trace.go:171","msg":"trace[638804217] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"293.378249ms","start":"2026-03-31T18:22:12.216059Z","end":"2026-03-31T18:22:12.509437Z","steps":["trace[638804217] 'process raft request' (duration: 293.118525ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:12.509633Z","caller":"traceutil/trace.go:171","msg":"trace[477798261] transaction","detail":"{read_only:false; number_of_response:1; response_revision:488; }","duration":"292.034859ms","start":"2026-03-31T18:22:12.217586Z","end":"2026-03-31T18:22:12.50962Z","steps":["trace[477798261] 'process raft request' (duration: 291.663473ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:12.509667Z","caller":"traceutil/trace.go:171","msg":"trace[1262957300] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"216.300005ms","start":"2026-03-31T18:22:12.293314Z","end":"2026-03-31T18:22:12.509614Z","steps":["trace[1262957300] 'process raft request' (duration: 216.134552ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:12.570709Z","caller":"traceutil/trace.go:171","msg":"trace[1155557857] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"231.70932ms","start":"2026-03-31T18:22:12.338923Z","end":"2026-03-31T18:22:12.570633Z","steps":["trace[1155557857] 'process raft request' (duration: 231.105331ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:12.571542Z","caller":"traceutil/trace.go:171","msg":"trace[1644267716] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"230.321609ms","start":"2026-03-31T18:22:12.341118Z","end":"2026-03-31T18:22:12.57144Z","steps":["trace[1644267716] 'process raft request' (duration: 229.447615ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:12.572192Z","caller":"traceutil/trace.go:171","msg":"trace[1077852041] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"224.907176ms","start":"2026-03-31T18:22:12.347264Z","end":"2026-03-31T18:22:12.572171Z","steps":["trace[1077852041] 'process raft request' (duration: 223.965621ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:12.573147Z","caller":"traceutil/trace.go:171","msg":"trace[410657589] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"223.681888ms","start":"2026-03-31T18:22:12.349447Z","end":"2026-03-31T18:22:12.573129Z","steps":["trace[410657589] 'process raft request' (duration: 222.233175ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:12.574788Z","caller":"traceutil/trace.go:171","msg":"trace[2094816418] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"223.482644ms","start":"2026-03-31T18:22:12.351277Z","end":"2026-03-31T18:22:12.574759Z","steps":["trace[2094816418] 'process raft request' (duration: 221.310771ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:12.577254Z","caller":"traceutil/trace.go:171","msg":"trace[210008874] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"219.991791ms","start":"2026-03-31T18:22:12.357248Z","end":"2026-03-31T18:22:12.57724Z","steps":["trace[210008874] 'process raft request' (duration: 217.699447ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:12.579732Z","caller":"traceutil/trace.go:171","msg":"trace[1603187323] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"220.299406ms","start":"2026-03-31T18:22:12.357132Z","end":"2026-03-31T18:22:12.577431Z","steps":["trace[1603187323] 'process raft request' (duration: 215.779877ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:12.58028Z","caller":"traceutil/trace.go:171","msg":"trace[426979399] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"222.967026ms","start":"2026-03-31T18:22:12.357294Z","end":"2026-03-31T18:22:12.580261Z","steps":["trace[426979399] 'process raft request' (duration: 220.147433ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:13.016348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.608517ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:22:13.016573Z","caller":"traceutil/trace.go:171","msg":"trace[1757282386] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"498.691546ms","start":"2026-03-31T18:22:12.517837Z","end":"2026-03-31T18:22:13.016529Z","steps":["trace[1757282386] 'process raft request' (duration: 203.736134ms)","trace[1757282386] 'compare' (duration: 294.482395ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:22:13.016678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:12.517805Z","time spent":"498.824328ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T18:22:13.016723Z","caller":"traceutil/trace.go:171","msg":"trace[173396679] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"498.690756ms","start":"2026-03-31T18:22:12.51802Z","end":"2026-03-31T18:22:13.01671Z","steps":["trace[173396679] 'process raft request' (duration: 498.427382ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:13.016791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:12.518006Z","time spent":"498.749197ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7326,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T18:22:13.016876Z","caller":"traceutil/trace.go:171","msg":"trace[1546280876] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"482.498659ms","start":"2026-03-31T18:22:12.534369Z","end":"2026-03-31T18:22:13.016867Z","steps":["trace[1546280876] 'process raft request' (duration: 482.169984ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:13.016873Z","caller":"traceutil/trace.go:171","msg":"trace[298316907] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"481.27348ms","start":"2026-03-31T18:22:12.535569Z","end":"2026-03-31T18:22:13.016843Z","steps":["trace[298316907] 'process raft request' (duration: 481.093477ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:13.016919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:12.534336Z","time spent":"482.55849ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:22:13.01704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:12.535562Z","time spent":"481.385241ms","remote":"127.0.0.1:34514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T18:22:13.094323Z","caller":"traceutil/trace.go:171","msg":"trace[345459537] linearizableReadLoop","detail":"{readStateIndex:525; appliedIndex:519; }","duration":"216.629243ms","start":"2026-03-31T18:22:12.877672Z","end":"2026-03-31T18:22:13.094301Z","steps":["trace[345459537] 'read index received' (duration: 216.179536ms)","trace[345459537] 'applied index is now lower than readState.Index' (duration: 448.707µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:22:13.094433Z","caller":"traceutil/trace.go:171","msg":"trace[181471017] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"498.370605ms","start":"2026-03-31T18:22:12.596052Z","end":"2026-03-31T18:22:13.094423Z","steps":["trace[181471017] 'process raft request' (duration: 497.923308ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:13.094515Z","caller":"traceutil/trace.go:171","msg":"trace[1930102633] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"514.139564ms","start":"2026-03-31T18:22:12.580343Z","end":"2026-03-31T18:22:13.094482Z","steps":["trace[1930102633] 'process raft request' (duration: 513.480195ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:13.094652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:12.580291Z","time spent":"514.299017ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T18:22:13.094783Z","caller":"traceutil/trace.go:171","msg":"trace[1146315334] transaction","detail":"{read_only:false; number_of_response:1; response_revision:502; }","duration":"507.494394ms","start":"2026-03-31T18:22:12.587268Z","end":"2026-03-31T18:22:13.094762Z","steps":["trace[1146315334] 'process raft request' (duration: 506.655371ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:13.094864Z","caller":"traceutil/trace.go:171","msg":"trace[857077231] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"479.635409ms","start":"2026-03-31T18:22:12.615213Z","end":"2026-03-31T18:22:13.094848Z","steps":["trace[857077231] 'process raft request' (duration: 478.886588ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:13.094907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:12.587243Z","time spent":"507.590065ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7375,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:22:13.094941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:12.615194Z","time spent":"479.71024ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T18:22:13.095067Z","caller":"traceutil/trace.go:171","msg":"trace[573314933] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"498.70626ms","start":"2026-03-31T18:22:12.596339Z","end":"2026-03-31T18:22:13.095045Z","steps":["trace[573314933] 'process raft request' (duration: 497.710325ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:13.095129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:12.59633Z","time spent":"498.771471ms","remote":"127.0.0.1:34340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":731,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-31T18:22:13.095144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.472705ms","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-03-31T18:22:13.095094Z","caller":"traceutil/trace.go:171","msg":"trace[520472622] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"441.380546ms","start":"2026-03-31T18:22:12.65366Z","end":"2026-03-31T18:22:13.095041Z","steps":["trace[520472622] 'process raft request' (duration: 440.535483ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:13.095192Z","caller":"traceutil/trace.go:171","msg":"trace[1643171928] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:506; }","duration":"217.541307ms","start":"2026-03-31T18:22:12.877636Z","end":"2026-03-31T18:22:13.095177Z","steps":["trace[1643171928] 'agreement among raft nodes before linearized reading' (duration: 217.407925ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:13.095427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:12.653614Z","time spent":"441.616789ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:22:13.094753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:12.596026Z","time spent":"498.431316ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:22:13.594989Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656276751673402,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T18:22:14.09592Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656276751673402,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T18:22:14.597078Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656276751673402,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T18:22:14.706157Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.612222077s","expected-duration":"1s"} {"level":"info","ts":"2026-03-31T18:22:14.716883Z","caller":"traceutil/trace.go:171","msg":"trace[1487428256] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"1.68832169s","start":"2026-03-31T18:22:13.028516Z","end":"2026-03-31T18:22:14.716838Z","steps":["trace[1487428256] 'process raft request' (duration: 1.688133237s)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:14.716869Z","caller":"traceutil/trace.go:171","msg":"trace[1544320093] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"1.690754266s","start":"2026-03-31T18:22:13.026035Z","end":"2026-03-31T18:22:14.716789Z","steps":["trace[1544320093] 'process raft request' (duration: 1.680336469s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:14.717131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:13.02851Z","time spent":"1.688456232s","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10846,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:22:14.717188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:13.026021Z","time spent":"1.690987329s","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T18:22:14.717489Z","caller":"traceutil/trace.go:171","msg":"trace[864900485] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"1.617325264s","start":"2026-03-31T18:22:13.100149Z","end":"2026-03-31T18:22:14.717474Z","steps":["trace[864900485] 'process raft request' (duration: 1.616602443s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:14.717584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:13.100101Z","time spent":"1.617425006s","remote":"127.0.0.1:34800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T18:22:14.71776Z","caller":"traceutil/trace.go:171","msg":"trace[1718527853] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"1.615324144s","start":"2026-03-31T18:22:13.102425Z","end":"2026-03-31T18:22:14.717749Z","steps":["trace[1718527853] 'process raft request' (duration: 1.614359439s)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:14.717864Z","caller":"traceutil/trace.go:171","msg":"trace[2002313825] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"1.614191327s","start":"2026-03-31T18:22:13.103646Z","end":"2026-03-31T18:22:14.717837Z","steps":["trace[2002313825] 'process raft request' (duration: 1.613257863s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:14.717979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:13.103631Z","time spent":"1.614293569s","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7693,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T18:22:14.717995Z","caller":"traceutil/trace.go:171","msg":"trace[213428308] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"1.534866385s","start":"2026-03-31T18:22:13.183092Z","end":"2026-03-31T18:22:14.717958Z","steps":["trace[213428308] 'process raft request' (duration: 1.533942251s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:14.717859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:13.102401Z","time spent":"1.615429796s","remote":"127.0.0.1:34340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":807,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-31T18:22:14.718153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:13.18305Z","time spent":"1.535033697s","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-31T18:22:14.718246Z","caller":"traceutil/trace.go:171","msg":"trace[824369141] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"1.61573359s","start":"2026-03-31T18:22:13.102478Z","end":"2026-03-31T18:22:14.718212Z","steps":["trace[824369141] 'process raft request' (duration: 1.614343488s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:14.718404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:13.102402Z","time spent":"1.615920283s","remote":"127.0.0.1:34514","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-03-31T18:22:14.727339Z","caller":"traceutil/trace.go:171","msg":"trace[1056710706] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:525; }","duration":"1.63292038s","start":"2026-03-31T18:22:13.094391Z","end":"2026-03-31T18:22:14.727312Z","steps":["trace[1056710706] 'read index received' (duration: 1.612048845s)","trace[1056710706] 'applied index is now lower than readState.Index' (duration: 20.869795ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:22:14.727517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.835691682s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:14.727599Z","caller":"traceutil/trace.go:171","msg":"trace[913213207] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:513; }","duration":"1.835808043s","start":"2026-03-31T18:22:12.891754Z","end":"2026-03-31T18:22:14.727562Z","steps":["trace[913213207] 'agreement among raft nodes before linearized reading' (duration: 1.835683132s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:14.727639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.413192419s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-03-31T18:22:14.727663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:12.891743Z","time spent":"1.835910075s","remote":"127.0.0.1:34264","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-03-31T18:22:14.727682Z","caller":"traceutil/trace.go:171","msg":"trace[2074297054] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:513; }","duration":"1.413292731s","start":"2026-03-31T18:22:13.314377Z","end":"2026-03-31T18:22:14.72767Z","steps":["trace[2074297054] 'agreement among raft nodes before linearized reading' (duration: 1.41320522s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:14.727719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:13.314325Z","time spent":"1.413385713s","remote":"127.0.0.1:34514","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-03-31T18:22:14.72776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.343931751s","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-03-31T18:22:14.727828Z","caller":"traceutil/trace.go:171","msg":"trace[726267299] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:513; }","duration":"1.344036833s","start":"2026-03-31T18:22:13.383778Z","end":"2026-03-31T18:22:14.727815Z","steps":["trace[726267299] 'agreement among raft nodes before linearized reading' (duration: 1.343904671s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:14.727873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:13.383763Z","time spent":"1.344102954s","remote":"127.0.0.1:34514","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-03-31T18:22:14.727958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.544031123s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:14.727986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.344174596s","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-03-31T18:22:14.728005Z","caller":"traceutil/trace.go:171","msg":"trace[550883009] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:513; }","duration":"1.544112324s","start":"2026-03-31T18:22:13.183882Z","end":"2026-03-31T18:22:14.727994Z","steps":["trace[550883009] 'agreement among raft nodes before linearized reading' (duration: 1.543684098s)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:14.72803Z","caller":"traceutil/trace.go:171","msg":"trace[1345800938] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:513; }","duration":"1.344259536s","start":"2026-03-31T18:22:13.383746Z","end":"2026-03-31T18:22:14.728005Z","steps":["trace[1345800938] 'agreement among raft nodes before linearized reading' (duration: 1.344211375s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:14.728056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:13.383717Z","time spent":"1.344333538s","remote":"127.0.0.1:34514","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-03-31T18:22:14.728057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:13.183856Z","time spent":"1.544190526s","remote":"127.0.0.1:44922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-03-31T18:22:14.728059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.543415743s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:14.728094Z","caller":"traceutil/trace.go:171","msg":"trace[194977815] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:513; }","duration":"1.543489125s","start":"2026-03-31T18:22:13.184594Z","end":"2026-03-31T18:22:14.728083Z","steps":["trace[194977815] 'agreement among raft nodes before linearized reading' (duration: 1.543415844s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:14.728147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:13.184585Z","time spent":"1.543551516s","remote":"127.0.0.1:44922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-03-31T18:22:14.728267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.544324137s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:14.728298Z","caller":"traceutil/trace.go:171","msg":"trace[140389951] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:513; }","duration":"1.544386658s","start":"2026-03-31T18:22:13.183904Z","end":"2026-03-31T18:22:14.728291Z","steps":["trace[140389951] 'agreement among raft nodes before linearized reading' (duration: 1.544338358s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:14.728319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:13.183899Z","time spent":"1.544414499s","remote":"127.0.0.1:44922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"info","ts":"2026-03-31T18:22:15.297135Z","caller":"traceutil/trace.go:171","msg":"trace[1286299567] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"154.936252ms","start":"2026-03-31T18:22:15.142168Z","end":"2026-03-31T18:22:15.297104Z","steps":["trace[1286299567] 'process raft request' (duration: 152.707499ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:15.307441Z","caller":"traceutil/trace.go:171","msg":"trace[891136813] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"159.247907ms","start":"2026-03-31T18:22:15.14815Z","end":"2026-03-31T18:22:15.307398Z","steps":["trace[891136813] 'process raft request' (duration: 158.10988ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:16.219247Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656276751673416,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T18:22:16.719874Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656276751673416,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T18:22:16.751812Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.067608843s","expected-duration":"1s"} {"level":"info","ts":"2026-03-31T18:22:16.759364Z","caller":"traceutil/trace.go:171","msg":"trace[68547179] linearizableReadLoop","detail":"{readStateIndex:572; appliedIndex:571; }","duration":"1.040337723s","start":"2026-03-31T18:22:15.718987Z","end":"2026-03-31T18:22:16.759325Z","steps":["trace[68547179] 'read index received' (duration: 1.032926864s)","trace[68547179] 'applied index is now lower than readState.Index' (duration: 7.406199ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:22:16.759627Z","caller":"traceutil/trace.go:171","msg":"trace[1087091634] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"1.082038129s","start":"2026-03-31T18:22:15.677523Z","end":"2026-03-31T18:22:16.759561Z","steps":["trace[1087091634] 'process raft request' (duration: 1.074831642s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:16.759721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.087557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:16.760251Z","caller":"traceutil/trace.go:171","msg":"trace[439497551] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:552; }","duration":"869.232049ms","start":"2026-03-31T18:22:15.890576Z","end":"2026-03-31T18:22:16.759808Z","steps":["trace[439497551] 'agreement among raft nodes before linearized reading' (duration: 869.051307ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:16.760711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:15.677476Z","time spent":"1.082230762s","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:22:16.760385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:15.890558Z","time spent":"869.814819ms","remote":"127.0.0.1:34264","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-03-31T18:22:16.761938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.042943102s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-03-31T18:22:16.761991Z","caller":"traceutil/trace.go:171","msg":"trace[1677301663] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:552; }","duration":"1.043028134s","start":"2026-03-31T18:22:15.718946Z","end":"2026-03-31T18:22:16.761974Z","steps":["trace[1677301663] 'agreement among raft nodes before linearized reading' (duration: 1.041698845s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:16.762023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:15.718926Z","time spent":"1.043087925s","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":103,"response count":1,"response size":29593,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-03-31T18:22:24.681979Z","caller":"traceutil/trace.go:171","msg":"trace[1663373916] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"627.382583ms","start":"2026-03-31T18:22:24.054567Z","end":"2026-03-31T18:22:24.68195Z","steps":["trace[1663373916] 'process raft request' (duration: 627.18554ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:24.682168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:24.054527Z","time spent":"627.549745ms","remote":"127.0.0.1:34442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:22:26.415289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.523479032s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T18:22:26.415328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.521830858s","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-03-31T18:22:26.415377Z","caller":"traceutil/trace.go:171","msg":"trace[86560989] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"1.523615854s","start":"2026-03-31T18:22:24.891737Z","end":"2026-03-31T18:22:26.415353Z","steps":["trace[86560989] 'range keys from in-memory index tree' (duration: 1.52339249s)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:26.41539Z","caller":"traceutil/trace.go:171","msg":"trace[514120369] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:603; }","duration":"1.521929669s","start":"2026-03-31T18:22:24.893443Z","end":"2026-03-31T18:22:26.415373Z","steps":["trace[514120369] 'range keys from in-memory index tree' (duration: 1.521692145s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:26.415418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:24.891715Z","time spent":"1.523694435s","remote":"127.0.0.1:34264","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-03-31T18:22:26.415424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:24.893429Z","time spent":"1.52198822s","remote":"127.0.0.1:34514","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-03-31T18:22:26.415319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.504291887s","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-03-31T18:22:26.415438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.498104049s","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-03-31T18:22:26.415467Z","caller":"traceutil/trace.go:171","msg":"trace[505888000] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:603; }","duration":"1.504474469s","start":"2026-03-31T18:22:24.910981Z","end":"2026-03-31T18:22:26.415455Z","steps":["trace[505888000] 'range keys from in-memory index tree' (duration: 1.504161355s)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:26.415487Z","caller":"traceutil/trace.go:171","msg":"trace[343933412] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:603; }","duration":"1.498159319s","start":"2026-03-31T18:22:24.917308Z","end":"2026-03-31T18:22:26.415468Z","steps":["trace[343933412] 'range keys from in-memory index tree' (duration: 1.498029078s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:26.415508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:24.910961Z","time spent":"1.504536831s","remote":"127.0.0.1:34514","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-03-31T18:22:26.415528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:24.917302Z","time spent":"1.49821821s","remote":"127.0.0.1:34514","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-03-31T18:22:26.415327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.56179641s","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-03-31T18:22:26.415566Z","caller":"traceutil/trace.go:171","msg":"trace[499198865] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:603; }","duration":"1.562112334s","start":"2026-03-31T18:22:24.853447Z","end":"2026-03-31T18:22:26.41556Z","steps":["trace[499198865] 'range keys from in-memory index tree' (duration: 1.561514426s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:26.415588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:24.853432Z","time spent":"1.562149885s","remote":"127.0.0.1:34514","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-03-31T18:22:26.925712Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656276751673582,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T18:22:27.425962Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656276751673582,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T18:22:27.430314Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.009387124s","expected-duration":"1s"} {"level":"info","ts":"2026-03-31T18:22:27.430627Z","caller":"traceutil/trace.go:171","msg":"trace[1174001599] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"1.009770399s","start":"2026-03-31T18:22:26.420839Z","end":"2026-03-31T18:22:27.430609Z","steps":["trace[1174001599] 'process raft request' (duration: 1.009635587s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:27.43075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:26.420818Z","time spent":"1.009845331s","remote":"127.0.0.1:34514","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-03-31T18:22:27.517009Z","caller":"traceutil/trace.go:171","msg":"trace[392286513] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"1.096069446s","start":"2026-03-31T18:22:26.420916Z","end":"2026-03-31T18:22:27.516985Z","steps":["trace[392286513] 'process raft request' (duration: 1.095912754s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:27.517187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:26.420896Z","time spent":"1.096188349s","remote":"127.0.0.1:34514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T18:22:27.517304Z","caller":"traceutil/trace.go:171","msg":"trace[77518584] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:626; }","duration":"1.092120241s","start":"2026-03-31T18:22:26.425159Z","end":"2026-03-31T18:22:27.517279Z","steps":["trace[77518584] 'read index received' (duration: 1.00560307s)","trace[77518584] 'applied index is now lower than readState.Index' (duration: 86.516051ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:22:27.517359Z","caller":"traceutil/trace.go:171","msg":"trace[1772570484] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"1.094944541s","start":"2026-03-31T18:22:26.422397Z","end":"2026-03-31T18:22:27.517342Z","steps":["trace[1772570484] 'process raft request' (duration: 1.094550655s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:27.517427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:26.422372Z","time spent":"1.095020372s","remote":"127.0.0.1:34514","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-03-31T18:22:27.517468Z","caller":"traceutil/trace.go:171","msg":"trace[1504700132] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"1.093280537s","start":"2026-03-31T18:22:26.424173Z","end":"2026-03-31T18:22:27.517453Z","steps":["trace[1504700132] 'process raft request' (duration: 1.092999544s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:27.517619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:26.424156Z","time spent":"1.093394219s","remote":"127.0.0.1:34514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:22:27.517427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.092248483s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:27.518023Z","caller":"traceutil/trace.go:171","msg":"trace[157120489] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:607; }","duration":"1.092864391s","start":"2026-03-31T18:22:26.425129Z","end":"2026-03-31T18:22:27.517994Z","steps":["trace[157120489] 'agreement among raft nodes before linearized reading' (duration: 1.092245372s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:27.518141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:26.425119Z","time spent":"1.092963102s","remote":"127.0.0.1:34264","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-03-31T18:22:28.492662Z","caller":"traceutil/trace.go:171","msg":"trace[107905586] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"105.483042ms","start":"2026-03-31T18:22:28.387154Z","end":"2026-03-31T18:22:28.492637Z","steps":["trace[107905586] 'process raft request' (duration: 105.30721ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:30.492052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.175379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:30.492159Z","caller":"traceutil/trace.go:171","msg":"trace[2093224760] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:648; }","duration":"229.352102ms","start":"2026-03-31T18:22:30.262781Z","end":"2026-03-31T18:22:30.492133Z","steps":["trace[2093224760] 'range keys from in-memory index tree' (duration: 229.056087ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:32.435248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.879274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-03-31T18:22:32.435403Z","caller":"traceutil/trace.go:171","msg":"trace[78889907] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:670; }","duration":"173.093178ms","start":"2026-03-31T18:22:32.262288Z","end":"2026-03-31T18:22:32.435381Z","steps":["trace[78889907] 'range keys from in-memory index tree' (duration: 172.696883ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:39.036991Z","caller":"traceutil/trace.go:171","msg":"trace[2095757581] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"134.317304ms","start":"2026-03-31T18:22:38.902551Z","end":"2026-03-31T18:22:39.036869Z","steps":["trace[2095757581] 'process raft request' (duration: 134.154182ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:39.205559Z","caller":"traceutil/trace.go:171","msg":"trace[932451405] linearizableReadLoop","detail":"{readStateIndex:753; appliedIndex:752; }","duration":"116.527911ms","start":"2026-03-31T18:22:39.088994Z","end":"2026-03-31T18:22:39.205522Z","steps":["trace[932451405] 'read index received' (duration: 116.219127ms)","trace[932451405] 'applied index is now lower than readState.Index' (duration: 307.614µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:22:39.205724Z","caller":"traceutil/trace.go:171","msg":"trace[990405373] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"148.585239ms","start":"2026-03-31T18:22:39.057076Z","end":"2026-03-31T18:22:39.205662Z","steps":["trace[990405373] 'process raft request' (duration: 148.233055ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:39.205805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.768584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-31T18:22:39.205851Z","caller":"traceutil/trace.go:171","msg":"trace[208164857] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:727; }","duration":"116.871475ms","start":"2026-03-31T18:22:39.088968Z","end":"2026-03-31T18:22:39.20584Z","steps":["trace[208164857] 'agreement among raft nodes before linearized reading' (duration: 116.686232ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:39.421714Z","caller":"traceutil/trace.go:171","msg":"trace[1285436747] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"175.666902ms","start":"2026-03-31T18:22:39.24602Z","end":"2026-03-31T18:22:39.421687Z","steps":["trace[1285436747] 'process raft request' (duration: 164.536413ms)","trace[1285436747] 'compare' (duration: 10.975187ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:22:43.773313Z","caller":"traceutil/trace.go:171","msg":"trace[1725381662] linearizableReadLoop","detail":"{readStateIndex:781; appliedIndex:780; }","duration":"158.850963ms","start":"2026-03-31T18:22:43.614445Z","end":"2026-03-31T18:22:43.773296Z","steps":["trace[1725381662] 'read index received' (duration: 154.304053ms)","trace[1725381662] 'applied index is now lower than readState.Index' (duration: 4.54593ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:22:43.773515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.060516ms","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-03-31T18:22:43.773544Z","caller":"traceutil/trace.go:171","msg":"trace[253258415] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:753; }","duration":"159.132916ms","start":"2026-03-31T18:22:43.614405Z","end":"2026-03-31T18:22:43.773538Z","steps":["trace[253258415] 'agreement among raft nodes before linearized reading' (duration: 158.994054ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:43.773607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.60969ms","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-03-31T18:22:43.773672Z","caller":"traceutil/trace.go:171","msg":"trace[1359203941] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:753; }","duration":"123.710951ms","start":"2026-03-31T18:22:43.649948Z","end":"2026-03-31T18:22:43.773659Z","steps":["trace[1359203941] 'agreement among raft nodes before linearized reading' (duration: 123.489608ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:43.773607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.512289ms","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-03-31T18:22:43.773749Z","caller":"traceutil/trace.go:171","msg":"trace[1292880706] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:753; }","duration":"111.708112ms","start":"2026-03-31T18:22:43.662027Z","end":"2026-03-31T18:22:43.773735Z","steps":["trace[1292880706] 'agreement among raft nodes before linearized reading' (duration: 111.460129ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:43.773748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.729631ms","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-03-31T18:22:43.773831Z","caller":"traceutil/trace.go:171","msg":"trace[23067807] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:753; }","duration":"111.856374ms","start":"2026-03-31T18:22:43.661959Z","end":"2026-03-31T18:22:43.773815Z","steps":["trace[23067807] 'agreement among raft nodes before linearized reading' (duration: 111.623711ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:47.391616Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656276751673998,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-31T18:22:47.831098Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.617839049s","expected-duration":"1s"} {"level":"info","ts":"2026-03-31T18:22:47.831549Z","caller":"traceutil/trace.go:171","msg":"trace[1335822371] linearizableReadLoop","detail":"{readStateIndex:801; appliedIndex:800; }","duration":"940.244204ms","start":"2026-03-31T18:22:46.891283Z","end":"2026-03-31T18:22:47.831527Z","steps":["trace[1335822371] 'read index received' (duration: 940.039471ms)","trace[1335822371] 'applied index is now lower than readState.Index' (duration: 203.733µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T18:22:47.83168Z","caller":"traceutil/trace.go:171","msg":"trace[1213080712] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"1.618459047s","start":"2026-03-31T18:22:46.213172Z","end":"2026-03-31T18:22:47.831631Z","steps":["trace[1213080712] 'process raft request' (duration: 1.618155803s)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:47.831751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"940.438436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:47.831832Z","caller":"traceutil/trace.go:171","msg":"trace[488635216] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:773; }","duration":"940.537137ms","start":"2026-03-31T18:22:46.891252Z","end":"2026-03-31T18:22:47.831789Z","steps":["trace[488635216] 'agreement among raft nodes before linearized reading' (duration: 940.425486ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:47.83187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:46.891236Z","time spent":"940.625208ms","remote":"127.0.0.1:34264","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-03-31T18:22:47.831795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:46.213157Z","time spent":"1.618576139s","remote":"127.0.0.1:34442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:22:47.83199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.130527ms","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":"info","ts":"2026-03-31T18:22:47.832088Z","caller":"traceutil/trace.go:171","msg":"trace[1998652238] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:773; }","duration":"170.300719ms","start":"2026-03-31T18:22:47.661773Z","end":"2026-03-31T18:22:47.832074Z","steps":["trace[1998652238] 'agreement among raft nodes before linearized reading' (duration: 170.030685ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:48.27014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.233958ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-31T18:22:48.270495Z","caller":"traceutil/trace.go:171","msg":"trace[1870206505] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"434.863189ms","start":"2026-03-31T18:22:47.835619Z","end":"2026-03-31T18:22:48.270482Z","steps":["trace[1870206505] 'process raft request' (duration: 434.668006ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:48.270414Z","caller":"traceutil/trace.go:171","msg":"trace[80531572] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"435.105853ms","start":"2026-03-31T18:22:47.835236Z","end":"2026-03-31T18:22:48.270342Z","steps":["trace[80531572] 'process raft request' (duration: 207.589732ms)","trace[80531572] 'compare' (duration: 227.121856ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:22:48.270547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:47.835605Z","time spent":"434.92019ms","remote":"127.0.0.1:34514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:22:48.270644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:47.835208Z","time spent":"435.342357ms","remote":"127.0.0.1:34514","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-03-31T18:22:48.27066Z","caller":"traceutil/trace.go:171","msg":"trace[2085257462] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"434.08309ms","start":"2026-03-31T18:22:47.836563Z","end":"2026-03-31T18:22:48.270646Z","steps":["trace[2085257462] 'process raft request' (duration: 433.818007ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:22:48.270741Z","caller":"traceutil/trace.go:171","msg":"trace[890190493] linearizableReadLoop","detail":"{readStateIndex:805; appliedIndex:801; }","duration":"378.579229ms","start":"2026-03-31T18:22:47.892156Z","end":"2026-03-31T18:22:48.270736Z","steps":["trace[890190493] 'read index received' (duration: 150.494221ms)","trace[890190493] 'applied index is now lower than readState.Index' (duration: 228.084488ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:22:48.270772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:47.836553Z","time spent":"434.141771ms","remote":"127.0.0.1:34514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:22:48.270804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.65635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:22:48.270793Z","caller":"traceutil/trace.go:171","msg":"trace[63721819] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"433.398121ms","start":"2026-03-31T18:22:47.837379Z","end":"2026-03-31T18:22:48.270778Z","steps":["trace[63721819] 'process raft request' (duration: 433.226498ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:48.271488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:47.837369Z","time spent":"434.076539ms","remote":"127.0.0.1:34514","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-03-31T18:22:48.270818Z","caller":"traceutil/trace.go:171","msg":"trace[43788884] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:777; }","duration":"378.700981ms","start":"2026-03-31T18:22:47.892113Z","end":"2026-03-31T18:22:48.270814Z","steps":["trace[43788884] 'agreement among raft nodes before linearized reading' (duration: 378.666361ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:48.271573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:22:47.892097Z","time spent":"379.463251ms","remote":"127.0.0.1:34264","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-03-31T18:22:48.270877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.723213ms","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-03-31T18:22:48.271692Z","caller":"traceutil/trace.go:171","msg":"trace[201462202] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:777; }","duration":"214.574003ms","start":"2026-03-31T18:22:48.057108Z","end":"2026-03-31T18:22:48.271682Z","steps":["trace[201462202] 'agreement among raft nodes before linearized reading' (duration: 213.722352ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:22:48.270925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.059688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.161\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-03-31T18:22:48.271824Z","caller":"traceutil/trace.go:171","msg":"trace[1631568420] range","detail":"{range_begin:/registry/masterleases/199.19.213.161; range_end:; response_count:1; response_revision:777; }","duration":"187.95964ms","start":"2026-03-31T18:22:48.083848Z","end":"2026-03-31T18:22:48.271808Z","steps":["trace[1631568420] 'agreement among raft nodes before linearized reading' (duration: 187.040508ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:23:14.818102Z","caller":"traceutil/trace.go:171","msg":"trace[1697591882] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"126.142842ms","start":"2026-03-31T18:23:14.691926Z","end":"2026-03-31T18:23:14.818069Z","steps":["trace[1697591882] 'process raft request' (duration: 126.098661ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:23:14.818407Z","caller":"traceutil/trace.go:171","msg":"trace[339906044] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"130.858529ms","start":"2026-03-31T18:23:14.687538Z","end":"2026-03-31T18:23:14.818396Z","steps":["trace[339906044] 'process raft request' (duration: 130.438044ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:23:14.818439Z","caller":"traceutil/trace.go:171","msg":"trace[79397321] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"131.325404ms","start":"2026-03-31T18:23:14.687061Z","end":"2026-03-31T18:23:14.818386Z","steps":["trace[79397321] 'process raft request' (duration: 63.972082ms)","trace[79397321] 'compare' (duration: 66.750255ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:24:44.542805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.478778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:24:44.542915Z","caller":"traceutil/trace.go:171","msg":"trace[1653177736] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1320; }","duration":"744.650333ms","start":"2026-03-31T18:24:43.798239Z","end":"2026-03-31T18:24:44.542889Z","steps":["trace[1653177736] 'count revisions from in-memory index tree' (duration: 744.330332ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:24:44.542976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:24:43.798209Z","time spent":"744.751438ms","remote":"127.0.0.1:34478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-03-31T18:24:44.543471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.510801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:24:44.543597Z","caller":"traceutil/trace.go:171","msg":"trace[259412883] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1320; }","duration":"652.653246ms","start":"2026-03-31T18:24:43.890917Z","end":"2026-03-31T18:24:44.54357Z","steps":["trace[259412883] 'range keys from in-memory index tree' (duration: 652.391056ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:24:44.543654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:24:43.890845Z","time spent":"652.798752ms","remote":"127.0.0.1:34264","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-03-31T18:24:44.543919Z","caller":"traceutil/trace.go:171","msg":"trace[2112945032] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"306.022588ms","start":"2026-03-31T18:24:44.23787Z","end":"2026-03-31T18:24:44.543893Z","steps":["trace[2112945032] 'process raft request' (duration: 301.508755ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:24:44.54419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:24:44.237826Z","time spent":"306.278049ms","remote":"127.0.0.1:34514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T18:24:53.560012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.483579ms","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-03-31T18:24:53.560085Z","caller":"traceutil/trace.go:171","msg":"trace[518521831] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1355; }","duration":"361.604053ms","start":"2026-03-31T18:24:53.198467Z","end":"2026-03-31T18:24:53.560071Z","steps":["trace[518521831] 'range keys from in-memory index tree' (duration: 361.314821ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:24:53.560109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.769042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-03-31T18:24:53.560115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:24:53.198448Z","time spent":"361.660126ms","remote":"127.0.0.1:34514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-03-31T18:24:53.560137Z","caller":"traceutil/trace.go:171","msg":"trace[1549579428] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1355; }","duration":"145.844305ms","start":"2026-03-31T18:24:53.414286Z","end":"2026-03-31T18:24:53.56013Z","steps":["trace[1549579428] 'range keys from in-memory index tree' (duration: 145.650208ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:24:53.560214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.999681ms","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-03-31T18:24:53.559997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.258197ms","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-03-31T18:24:53.56026Z","caller":"traceutil/trace.go:171","msg":"trace[2079333550] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1355; }","duration":"128.079375ms","start":"2026-03-31T18:24:53.432168Z","end":"2026-03-31T18:24:53.560247Z","steps":["trace[2079333550] 'range keys from in-memory index tree' (duration: 127.894958ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:24:53.560337Z","caller":"traceutil/trace.go:171","msg":"trace[875510417] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1355; }","duration":"117.624731ms","start":"2026-03-31T18:24:53.44266Z","end":"2026-03-31T18:24:53.560285Z","steps":["trace[875510417] 'range keys from in-memory index tree' (duration: 116.986457ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:24:53.971124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.389461ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-03-31T18:24:54.292772Z","caller":"traceutil/trace.go:171","msg":"trace[646516249] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"729.474132ms","start":"2026-03-31T18:24:53.563267Z","end":"2026-03-31T18:24:54.292741Z","steps":["trace[646516249] 'process raft request' (duration: 729.217023ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:24:54.292959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:24:53.563241Z","time spent":"729.622468ms","remote":"127.0.0.1:34514","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-03-31T18:24:54.293385Z","caller":"traceutil/trace.go:171","msg":"trace[2089898753] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"730.084764ms","start":"2026-03-31T18:24:53.563279Z","end":"2026-03-31T18:24:54.293363Z","steps":["trace[2089898753] 'process raft request' (duration: 729.399219ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:24:54.293494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:24:53.563244Z","time spent":"730.196089ms","remote":"127.0.0.1:34514","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-03-31T18:24:54.293719Z","caller":"traceutil/trace.go:171","msg":"trace[509152833] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"729.323446ms","start":"2026-03-31T18:24:53.56438Z","end":"2026-03-31T18:24:54.293704Z","steps":["trace[509152833] 'process raft request' (duration: 728.954033ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:24:54.29389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:24:53.564359Z","time spent":"729.43434ms","remote":"127.0.0.1:34514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T18:24:54.294021Z","caller":"traceutil/trace.go:171","msg":"trace[242805010] linearizableReadLoop","detail":"{readStateIndex:1416; appliedIndex:1412; }","duration":"403.182853ms","start":"2026-03-31T18:24:53.890806Z","end":"2026-03-31T18:24:54.293989Z","steps":["trace[242805010] 'read index received' (duration: 401.602405ms)","trace[242805010] 'applied index is now lower than readState.Index' (duration: 1.578848ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T18:24:54.29416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.36385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T18:24:54.294221Z","caller":"traceutil/trace.go:171","msg":"trace[1788166331] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1359; }","duration":"403.498765ms","start":"2026-03-31T18:24:53.890706Z","end":"2026-03-31T18:24:54.294205Z","steps":["trace[1788166331] 'agreement among raft nodes before linearized reading' (duration: 403.403772ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:24:54.294264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:24:53.890646Z","time spent":"403.608379ms","remote":"127.0.0.1:34264","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-03-31T18:24:54.294498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.82124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-31T18:24:54.294606Z","caller":"traceutil/trace.go:171","msg":"trace[1733154925] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1359; }","duration":"266.989397ms","start":"2026-03-31T18:24:54.027596Z","end":"2026-03-31T18:24:54.294585Z","steps":["trace[1733154925] 'agreement among raft nodes before linearized reading' (duration: 266.585052ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T18:24:54.294067Z","caller":"traceutil/trace.go:171","msg":"trace[659847713] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"729.180523ms","start":"2026-03-31T18:24:53.564841Z","end":"2026-03-31T18:24:54.294021Z","steps":["trace[659847713] 'process raft request' (duration: 728.673923ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T18:24:54.294889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:24:53.564824Z","time spent":"730.005342ms","remote":"127.0.0.1:34514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}