{"level":"warn","ts":"2026-05-07T03:19:36.6477Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-07T03:19:36.647903Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.162:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.162:2380","--initial-cluster=instance=https://199.204.45.162:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.162:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.162: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-05-07T03:19:36.648189Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-07T03:19:36.64821Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-05-07T03:19:36.648234Z","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-05-07T03:19:36.648932Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"]} {"level":"info","ts":"2026-05-07T03:19:36.649067Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.162: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-05-07T03:19:36.729362Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"77.033323ms"} {"level":"info","ts":"2026-05-07T03:19:36.832646Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2d372260bb4c37a","cluster-id":"52bb6ec15e8722ff"} {"level":"info","ts":"2026-05-07T03:19:36.832787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=()"} {"level":"info","ts":"2026-05-07T03:19:36.832837Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 0"} {"level":"info","ts":"2026-05-07T03:19:36.832857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2d372260bb4c37a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-07T03:19:36.83287Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 1"} {"level":"info","ts":"2026-05-07T03:19:36.832951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"warn","ts":"2026-05-07T03:19:36.850529Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-07T03:19:36.85239Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-07T03:19:36.855339Z","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-05-07T03:19:36.863149Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2d372260bb4c37a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-07T03:19:36.864798Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2d372260bb4c37a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-07T03:19:36.864926Z","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-05-07T03:19:36.864964Z","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-05-07T03:19:36.864978Z","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-05-07T03:19:36.868166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"info","ts":"2026-05-07T03:19:36.868581Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","added-peer-id":"2d372260bb4c37a","added-peer-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-05-07T03:19:36.869215Z","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-05-07T03:19:36.869345Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-05-07T03:19:36.869363Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-05-07T03:19:36.869511Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2d372260bb4c37a","initial-advertise-peer-urls":["https://199.204.45.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-07T03:19:36.869562Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-07T03:19:37.533487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a is starting a new election at term 1"} {"level":"info","ts":"2026-05-07T03:19:37.533568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became pre-candidate at term 1"} {"level":"info","ts":"2026-05-07T03:19:37.533601Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgPreVoteResp from 2d372260bb4c37a at term 1"} {"level":"info","ts":"2026-05-07T03:19:37.53362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became candidate at term 2"} {"level":"info","ts":"2026-05-07T03:19:37.533673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgVoteResp from 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-05-07T03:19:37.533699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became leader at term 2"} {"level":"info","ts":"2026-05-07T03:19:37.533713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2d372260bb4c37a elected leader 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-05-07T03:19:37.544804Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T03:19:37.55249Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2d372260bb4c37a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.162:2379]}","request-path":"/0/members/2d372260bb4c37a/attributes","cluster-id":"52bb6ec15e8722ff","publish-timeout":"7s"} {"level":"info","ts":"2026-05-07T03:19:37.552492Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-07T03:19:37.55255Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-07T03:19:37.552945Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-07T03:19:37.553063Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-07T03:19:37.554433Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-07T03:19:37.554984Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.162:2379"} {"level":"info","ts":"2026-05-07T03:19:37.557147Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T03:19:37.557276Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T03:19:37.557312Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T03:19:39.083713Z","caller":"traceutil/trace.go:171","msg":"trace[1569551222] transaction","detail":"{read_only:false; response_revision:51; number_of_response:1; }","duration":"100.389605ms","start":"2026-05-07T03:19:38.983297Z","end":"2026-05-07T03:19:39.083687Z","steps":["trace[1569551222] 'process raft request' (duration: 86.971675ms)","trace[1569551222] 'compare' (duration: 13.010024ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:19:40.233477Z","caller":"traceutil/trace.go:171","msg":"trace[72330245] transaction","detail":"{read_only:false; response_revision:122; number_of_response:1; }","duration":"137.074733ms","start":"2026-05-07T03:19:40.096375Z","end":"2026-05-07T03:19:40.233449Z","steps":["trace[72330245] 'process raft request' (duration: 75.304404ms)","trace[72330245] 'compare' (duration: 61.640395ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:19:40.568545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.492532ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-07T03:19:40.568677Z","caller":"traceutil/trace.go:171","msg":"trace[75243861] transaction","detail":"{read_only:false; response_revision:124; number_of_response:1; }","duration":"312.084888ms","start":"2026-05-07T03:19:40.256574Z","end":"2026-05-07T03:19:40.568659Z","steps":["trace[75243861] 'process raft request' (duration: 105.045725ms)","trace[75243861] 'compare' (duration: 206.354427ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:19:40.568732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:19:40.256551Z","time spent":"312.159701ms","remote":"127.0.0.1:32834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":685,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T03:19:42.587489Z","caller":"traceutil/trace.go:171","msg":"trace[500758957] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"111.800907ms","start":"2026-05-07T03:19:42.475656Z","end":"2026-05-07T03:19:42.587457Z","steps":["trace[500758957] 'process raft request' (duration: 104.24463ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:42.628164Z","caller":"traceutil/trace.go:171","msg":"trace[1088144066] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"106.151921ms","start":"2026-05-07T03:19:42.52199Z","end":"2026-05-07T03:19:42.628142Z","steps":["trace[1088144066] 'process raft request' (duration: 106.028407ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:43.289309Z","caller":"traceutil/trace.go:171","msg":"trace[943395560] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"122.528318ms","start":"2026-05-07T03:19:43.166763Z","end":"2026-05-07T03:19:43.289291Z","steps":["trace[943395560] 'process raft request' (duration: 122.484456ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:43.289533Z","caller":"traceutil/trace.go:171","msg":"trace[133204099] linearizableReadLoop","detail":"{readStateIndex:295; appliedIndex:294; }","duration":"152.529951ms","start":"2026-05-07T03:19:43.136985Z","end":"2026-05-07T03:19:43.289515Z","steps":["trace[133204099] 'read index received' (duration: 76.853698ms)","trace[133204099] 'applied index is now lower than readState.Index' (duration: 75.674163ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:19:43.289767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.749889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-07T03:19:43.289494Z","caller":"traceutil/trace.go:171","msg":"trace[1191326751] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"173.551392ms","start":"2026-05-07T03:19:43.115927Z","end":"2026-05-07T03:19:43.289478Z","steps":["trace[1191326751] 'process raft request' (duration: 97.941571ms)","trace[1191326751] 'compare' (duration: 75.125993ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:19:43.289853Z","caller":"traceutil/trace.go:171","msg":"trace[122191462] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:290; }","duration":"152.900406ms","start":"2026-05-07T03:19:43.136932Z","end":"2026-05-07T03:19:43.289832Z","steps":["trace[122191462] 'agreement among raft nodes before linearized reading' (duration: 152.687587ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:43.423364Z","caller":"traceutil/trace.go:171","msg":"trace[151841770] transaction","detail":"{read_only:false; number_of_response:0; response_revision:290; }","duration":"137.79654ms","start":"2026-05-07T03:19:43.285541Z","end":"2026-05-07T03:19:43.423338Z","steps":["trace[151841770] 'process raft request' (duration: 136.727269ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:43.423426Z","caller":"traceutil/trace.go:171","msg":"trace[680241216] transaction","detail":"{read_only:false; number_of_response:0; response_revision:290; }","duration":"135.028314ms","start":"2026-05-07T03:19:43.288378Z","end":"2026-05-07T03:19:43.423406Z","steps":["trace[680241216] 'process raft request' (duration: 134.901159ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:43.423422Z","caller":"traceutil/trace.go:171","msg":"trace[1080523941] transaction","detail":"{read_only:false; number_of_response:0; response_revision:290; }","duration":"136.299833ms","start":"2026-05-07T03:19:43.28709Z","end":"2026-05-07T03:19:43.423389Z","steps":["trace[1080523941] 'process raft request' (duration: 136.159227ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:43.423606Z","caller":"traceutil/trace.go:171","msg":"trace[50892119] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"135.085626ms","start":"2026-05-07T03:19:43.288469Z","end":"2026-05-07T03:19:43.423554Z","steps":["trace[50892119] 'process raft request' (duration: 134.834456ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:43.42367Z","caller":"traceutil/trace.go:171","msg":"trace[1245500029] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"133.688783ms","start":"2026-05-07T03:19:43.289922Z","end":"2026-05-07T03:19:43.423611Z","steps":["trace[1245500029] 'process raft request' (duration: 133.464044ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:43.423675Z","caller":"traceutil/trace.go:171","msg":"trace[693631593] linearizableReadLoop","detail":"{readStateIndex:301; appliedIndex:297; }","duration":"133.86223ms","start":"2026-05-07T03:19:43.289796Z","end":"2026-05-07T03:19:43.423658Z","steps":["trace[693631593] 'read index received' (duration: 37.429796ms)","trace[693631593] 'applied index is now lower than readState.Index' (duration: 96.431524ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:19:43.42365Z","caller":"traceutil/trace.go:171","msg":"trace[1662580914] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"130.769992ms","start":"2026-05-07T03:19:43.292824Z","end":"2026-05-07T03:19:43.423594Z","steps":["trace[1662580914] 'process raft request' (duration: 130.634257ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:43.42377Z","caller":"traceutil/trace.go:171","msg":"trace[918099456] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"130.819754ms","start":"2026-05-07T03:19:43.292941Z","end":"2026-05-07T03:19:43.423761Z","steps":["trace[918099456] 'process raft request' (duration: 130.571024ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:19:43.423885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.316104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T03:19:43.423934Z","caller":"traceutil/trace.go:171","msg":"trace[552320566] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:295; }","duration":"257.408877ms","start":"2026-05-07T03:19:43.166513Z","end":"2026-05-07T03:19:43.423921Z","steps":["trace[552320566] 'agreement among raft nodes before linearized reading' (duration: 257.282012ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:43.424083Z","caller":"traceutil/trace.go:171","msg":"trace[482122430] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"130.283064ms","start":"2026-05-07T03:19:43.293787Z","end":"2026-05-07T03:19:43.42407Z","steps":["trace[482122430] 'process raft request' (duration: 129.785295ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:19:43.423936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.679217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-05-07T03:19:43.425765Z","caller":"traceutil/trace.go:171","msg":"trace[96001946] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:295; }","duration":"259.544478ms","start":"2026-05-07T03:19:43.166198Z","end":"2026-05-07T03:19:43.425743Z","steps":["trace[96001946] 'agreement among raft nodes before linearized reading' (duration: 257.677177ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:43.574435Z","caller":"traceutil/trace.go:171","msg":"trace[608907484] linearizableReadLoop","detail":"{readStateIndex:311; appliedIndex:309; }","duration":"114.18346ms","start":"2026-05-07T03:19:43.46023Z","end":"2026-05-07T03:19:43.574413Z","steps":["trace[608907484] 'read index received' (duration: 84.495619ms)","trace[608907484] 'applied index is now lower than readState.Index' (duration: 29.687041ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:19:43.574536Z","caller":"traceutil/trace.go:171","msg":"trace[1785606785] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"123.418383ms","start":"2026-05-07T03:19:43.451107Z","end":"2026-05-07T03:19:43.574525Z","steps":["trace[1785606785] 'process raft request' (duration: 93.609577ms)","trace[1785606785] 'compare' (duration: 29.537945ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:19:43.574601Z","caller":"traceutil/trace.go:171","msg":"trace[1240361778] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"119.451251ms","start":"2026-05-07T03:19:43.455118Z","end":"2026-05-07T03:19:43.574569Z","steps":["trace[1240361778] 'process raft request' (duration: 119.244803ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:19:43.574696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.597533ms","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-05-07T03:19:43.574747Z","caller":"traceutil/trace.go:171","msg":"trace[74804219] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:301; }","duration":"126.687156ms","start":"2026-05-07T03:19:43.448045Z","end":"2026-05-07T03:19:43.574732Z","steps":["trace[74804219] 'agreement among raft nodes before linearized reading' (duration: 126.569442ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:19:43.574991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.254532ms","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-05-07T03:19:43.575122Z","caller":"traceutil/trace.go:171","msg":"trace[556456963] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:301; }","duration":"125.384607ms","start":"2026-05-07T03:19:43.449654Z","end":"2026-05-07T03:19:43.575038Z","steps":["trace[556456963] 'agreement among raft nodes before linearized reading' (duration: 125.065325ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:43.5831Z","caller":"traceutil/trace.go:171","msg":"trace[2054762729] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"115.643186ms","start":"2026-05-07T03:19:43.467438Z","end":"2026-05-07T03:19:43.583081Z","steps":["trace[2054762729] 'process raft request' (duration: 115.568193ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:43.583156Z","caller":"traceutil/trace.go:171","msg":"trace[233561971] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"119.580495ms","start":"2026-05-07T03:19:43.463546Z","end":"2026-05-07T03:19:43.583127Z","steps":["trace[233561971] 'process raft request' (duration: 119.397948ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:43.583184Z","caller":"traceutil/trace.go:171","msg":"trace[1094611882] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"110.363404ms","start":"2026-05-07T03:19:43.472794Z","end":"2026-05-07T03:19:43.583157Z","steps":["trace[1094611882] 'process raft request' (duration: 110.24802ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:53.9862Z","caller":"traceutil/trace.go:171","msg":"trace[327810978] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"113.967124ms","start":"2026-05-07T03:19:53.872157Z","end":"2026-05-07T03:19:53.986124Z","steps":["trace[327810978] 'process raft request' (duration: 112.430703ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:57.927444Z","caller":"traceutil/trace.go:171","msg":"trace[691424584] linearizableReadLoop","detail":"{readStateIndex:439; appliedIndex:438; }","duration":"238.521529ms","start":"2026-05-07T03:19:57.688898Z","end":"2026-05-07T03:19:57.92742Z","steps":["trace[691424584] 'read index received' (duration: 238.281858ms)","trace[691424584] 'applied index is now lower than readState.Index' (duration: 238.071µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:19:57.927526Z","caller":"traceutil/trace.go:171","msg":"trace[1734711611] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"239.651882ms","start":"2026-05-07T03:19:57.687828Z","end":"2026-05-07T03:19:57.92748Z","steps":["trace[1734711611] 'process raft request' (duration: 239.368641ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:19:57.927646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.62835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T03:19:57.927773Z","caller":"traceutil/trace.go:171","msg":"trace[587548570] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:422; }","duration":"151.714971ms","start":"2026-05-07T03:19:57.775983Z","end":"2026-05-07T03:19:57.927698Z","steps":["trace[587548570] 'agreement among raft nodes before linearized reading' (duration: 151.59432ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:19:57.927892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.86279ms","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-05-07T03:19:57.928086Z","caller":"traceutil/trace.go:171","msg":"trace[1891937639] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:422; }","duration":"239.216131ms","start":"2026-05-07T03:19:57.688842Z","end":"2026-05-07T03:19:57.928058Z","steps":["trace[1891937639] 'agreement among raft nodes before linearized reading' (duration: 238.685939ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:19:59.597762Z","caller":"traceutil/trace.go:171","msg":"trace[1345899251] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"103.86652ms","start":"2026-05-07T03:19:59.493874Z","end":"2026-05-07T03:19:59.59774Z","steps":["trace[1345899251] 'process raft request' (duration: 103.742359ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:00.700656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.045199ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-07T03:20:00.700763Z","caller":"traceutil/trace.go:171","msg":"trace[1983532076] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"336.329019ms","start":"2026-05-07T03:20:00.364406Z","end":"2026-05-07T03:20:00.700735Z","steps":["trace[1983532076] 'process raft request' (duration: 169.140349ms)","trace[1983532076] 'compare' (duration: 166.871378ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:20:00.700848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:00.364379Z","time spent":"336.434419ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3678,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T03:20:00.887101Z","caller":"traceutil/trace.go:171","msg":"trace[1473735670] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"182.159986ms","start":"2026-05-07T03:20:00.704923Z","end":"2026-05-07T03:20:00.887083Z","steps":["trace[1473735670] 'process raft request' (duration: 132.774727ms)","trace[1473735670] 'compare' (duration: 49.286369ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:00.887784Z","caller":"traceutil/trace.go:171","msg":"trace[896657217] linearizableReadLoop","detail":"{readStateIndex:453; appliedIndex:450; }","duration":"113.106621ms","start":"2026-05-07T03:20:00.77467Z","end":"2026-05-07T03:20:00.887776Z","steps":["trace[896657217] 'read index received' (duration: 63.030529ms)","trace[896657217] 'applied index is now lower than readState.Index' (duration: 50.075692ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:00.887891Z","caller":"traceutil/trace.go:171","msg":"trace[1677182605] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"181.930865ms","start":"2026-05-07T03:20:00.705934Z","end":"2026-05-07T03:20:00.887864Z","steps":["trace[1677182605] 'process raft request' (duration: 181.767615ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:00.887884Z","caller":"traceutil/trace.go:171","msg":"trace[318240735] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"178.985262ms","start":"2026-05-07T03:20:00.708874Z","end":"2026-05-07T03:20:00.887859Z","steps":["trace[318240735] 'process raft request' (duration: 178.863192ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:00.887968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.275842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T03:20:00.88839Z","caller":"traceutil/trace.go:171","msg":"trace[1134624907] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:436; }","duration":"113.733444ms","start":"2026-05-07T03:20:00.774639Z","end":"2026-05-07T03:20:00.888372Z","steps":["trace[1134624907] 'agreement among raft nodes before linearized reading' (duration: 113.238202ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:01.104448Z","caller":"traceutil/trace.go:171","msg":"trace[83226804] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"137.805299ms","start":"2026-05-07T03:20:00.966623Z","end":"2026-05-07T03:20:01.104429Z","steps":["trace[83226804] 'process raft request' (duration: 101.40121ms)","trace[83226804] 'compare' (duration: 36.235458ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:01.104655Z","caller":"traceutil/trace.go:171","msg":"trace[233899002] linearizableReadLoop","detail":"{readStateIndex:460; appliedIndex:458; }","duration":"136.806495ms","start":"2026-05-07T03:20:00.967824Z","end":"2026-05-07T03:20:01.10463Z","steps":["trace[233899002] 'read index received' (duration: 11.502311ms)","trace[233899002] 'applied index is now lower than readState.Index' (duration: 125.303104ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:01.104835Z","caller":"traceutil/trace.go:171","msg":"trace[174070588] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"136.276942ms","start":"2026-05-07T03:20:00.96853Z","end":"2026-05-07T03:20:01.104807Z","steps":["trace[174070588] 'process raft request' (duration: 135.85854ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:01.104883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.037616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-05-07T03:20:01.104914Z","caller":"traceutil/trace.go:171","msg":"trace[201083924] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:444; }","duration":"137.086236ms","start":"2026-05-07T03:20:00.967816Z","end":"2026-05-07T03:20:01.104902Z","steps":["trace[201083924] 'agreement among raft nodes before linearized reading' (duration: 137.000836ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:08.43869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.652024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-07T03:20:08.438793Z","caller":"traceutil/trace.go:171","msg":"trace[1158271019] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:477; }","duration":"155.820325ms","start":"2026-05-07T03:20:08.282951Z","end":"2026-05-07T03:20:08.438772Z","steps":["trace[1158271019] 'range keys from in-memory index tree' (duration: 155.499943ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:12.254574Z","caller":"traceutil/trace.go:171","msg":"trace[1809494330] linearizableReadLoop","detail":"{readStateIndex:508; appliedIndex:507; }","duration":"112.429301ms","start":"2026-05-07T03:20:12.1421Z","end":"2026-05-07T03:20:12.254529Z","steps":["trace[1809494330] 'read index received' (duration: 80.062669ms)","trace[1809494330] 'applied index is now lower than readState.Index' (duration: 32.364022ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:12.254687Z","caller":"traceutil/trace.go:171","msg":"trace[240601639] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"220.401339ms","start":"2026-05-07T03:20:12.03424Z","end":"2026-05-07T03:20:12.254641Z","steps":["trace[240601639] 'process raft request' (duration: 187.975607ms)","trace[240601639] 'compare' (duration: 32.062478ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:20:12.254898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.785134ms","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-05-07T03:20:12.255185Z","caller":"traceutil/trace.go:171","msg":"trace[545713302] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:488; }","duration":"113.128918ms","start":"2026-05-07T03:20:12.142034Z","end":"2026-05-07T03:20:12.255163Z","steps":["trace[545713302] 'agreement among raft nodes before linearized reading' (duration: 112.727164ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:12.671897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.664095ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-07T03:20:12.672055Z","caller":"traceutil/trace.go:171","msg":"trace[1001070924] linearizableReadLoop","detail":"{readStateIndex:516; appliedIndex:515; }","duration":"142.481509ms","start":"2026-05-07T03:20:12.529503Z","end":"2026-05-07T03:20:12.671985Z","steps":["trace[1001070924] 'read index received' (duration: 59.381µs)","trace[1001070924] 'applied index is now lower than readState.Index' (duration: 142.420688ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:12.672124Z","caller":"traceutil/trace.go:171","msg":"trace[2050023255] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"344.824653ms","start":"2026-05-07T03:20:12.327255Z","end":"2026-05-07T03:20:12.672079Z","steps":["trace[2050023255] 'process raft request' (duration: 162.909526ms)","trace[2050023255] 'compare' (duration: 181.518534ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:20:12.672244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.733321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-07T03:20:12.672294Z","caller":"traceutil/trace.go:171","msg":"trace[1115563099] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:496; }","duration":"142.828312ms","start":"2026-05-07T03:20:12.529436Z","end":"2026-05-07T03:20:12.672264Z","steps":["trace[1115563099] 'agreement among raft nodes before linearized reading' (duration: 142.663191ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:12.672293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:12.32723Z","time spent":"344.990096ms","remote":"127.0.0.1:32812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-07T03:20:13.044414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.184036ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T03:20:13.04478Z","caller":"traceutil/trace.go:171","msg":"trace[665848734] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"217.026263ms","start":"2026-05-07T03:20:12.827683Z","end":"2026-05-07T03:20:13.044709Z","steps":["trace[665848734] 'process raft request' (duration: 106.251211ms)","trace[665848734] 'compare' (duration: 109.971984ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:13.044953Z","caller":"traceutil/trace.go:171","msg":"trace[1621475673] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"216.962183ms","start":"2026-05-07T03:20:12.827968Z","end":"2026-05-07T03:20:13.044931Z","steps":["trace[1621475673] 'process raft request' (duration: 216.596529ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:13.044951Z","caller":"traceutil/trace.go:171","msg":"trace[1877083186] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"211.925424ms","start":"2026-05-07T03:20:12.833009Z","end":"2026-05-07T03:20:13.044935Z","steps":["trace[1877083186] 'process raft request' (duration: 211.834983ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:13.135448Z","caller":"traceutil/trace.go:171","msg":"trace[1565538991] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"272.429471ms","start":"2026-05-07T03:20:12.862983Z","end":"2026-05-07T03:20:13.135413Z","steps":["trace[1565538991] 'process raft request' (duration: 272.271789ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:13.135577Z","caller":"traceutil/trace.go:171","msg":"trace[2106007039] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"272.544162ms","start":"2026-05-07T03:20:12.863009Z","end":"2026-05-07T03:20:13.135553Z","steps":["trace[2106007039] 'process raft request' (duration: 272.34817ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:13.135773Z","caller":"traceutil/trace.go:171","msg":"trace[230537525] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"271.986067ms","start":"2026-05-07T03:20:12.863765Z","end":"2026-05-07T03:20:13.135751Z","steps":["trace[230537525] 'process raft request' (duration: 271.666324ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:13.142668Z","caller":"traceutil/trace.go:171","msg":"trace[923302198] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"252.909026ms","start":"2026-05-07T03:20:12.889741Z","end":"2026-05-07T03:20:13.14265Z","steps":["trace[923302198] 'process raft request' (duration: 247.702154ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:13.484798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.767178ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-07T03:20:13.484925Z","caller":"traceutil/trace.go:171","msg":"trace[1194753420] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"435.422166ms","start":"2026-05-07T03:20:13.049476Z","end":"2026-05-07T03:20:13.484898Z","steps":["trace[1194753420] 'process raft request' (duration: 242.476816ms)","trace[1194753420] 'compare' (duration: 192.564206ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:13.484949Z","caller":"traceutil/trace.go:171","msg":"trace[153253541] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:526; }","duration":"434.663398ms","start":"2026-05-07T03:20:13.050233Z","end":"2026-05-07T03:20:13.484896Z","steps":["trace[153253541] 'read index received' (duration: 85.0124ms)","trace[153253541] 'applied index is now lower than readState.Index' (duration: 349.648698ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:20:13.485077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:13.049453Z","time spent":"435.529457ms","remote":"127.0.0.1:60810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":671,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-07T03:20:13.485216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.968111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-nm7n7\" ","response":"range_response_count:1 size:15076"} {"level":"info","ts":"2026-05-07T03:20:13.485323Z","caller":"traceutil/trace.go:171","msg":"trace[689599531] range","detail":"{range_begin:/registry/pods/kube-system/cilium-nm7n7; range_end:; response_count:1; response_revision:511; }","duration":"435.098702ms","start":"2026-05-07T03:20:13.050199Z","end":"2026-05-07T03:20:13.485297Z","steps":["trace[689599531] 'agreement among raft nodes before linearized reading' (duration: 434.784259ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:13.48538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:13.05018Z","time spent":"435.184104ms","remote":"127.0.0.1:60936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":15098,"request content":"key:\"/registry/pods/kube-system/cilium-nm7n7\" "} {"level":"info","ts":"2026-05-07T03:20:13.493182Z","caller":"traceutil/trace.go:171","msg":"trace[1166817879] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"352.363565ms","start":"2026-05-07T03:20:13.140803Z","end":"2026-05-07T03:20:13.493167Z","steps":["trace[1166817879] 'process raft request' (duration: 352.246294ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:13.493285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:13.140782Z","time spent":"352.442256ms","remote":"127.0.0.1:60936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3622,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:20:13.493459Z","caller":"traceutil/trace.go:171","msg":"trace[1220375670] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"348.658398ms","start":"2026-05-07T03:20:13.14476Z","end":"2026-05-07T03:20:13.493419Z","steps":["trace[1220375670] 'process raft request' (duration: 348.369756ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:13.493608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.764079ms","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:329948"} {"level":"info","ts":"2026-05-07T03:20:13.493661Z","caller":"traceutil/trace.go:171","msg":"trace[1711919387] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:514; }","duration":"272.85113ms","start":"2026-05-07T03:20:13.220796Z","end":"2026-05-07T03:20:13.493647Z","steps":["trace[1711919387] 'agreement among raft nodes before linearized reading' (duration: 272.641518ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:13.493707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:13.144742Z","time spent":"348.900381ms","remote":"127.0.0.1:60810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":736,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T03:20:13.493543Z","caller":"traceutil/trace.go:171","msg":"trace[2064887341] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"346.86066ms","start":"2026-05-07T03:20:13.146656Z","end":"2026-05-07T03:20:13.493516Z","steps":["trace[2064887341] 'process raft request' (duration: 346.674139ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:13.493897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:13.146646Z","time spent":"347.215444ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4294,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:13.493563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.004072ms","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-05-07T03:20:13.493986Z","caller":"traceutil/trace.go:171","msg":"trace[168107646] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:514; }","duration":"335.463376ms","start":"2026-05-07T03:20:13.158509Z","end":"2026-05-07T03:20:13.493972Z","steps":["trace[168107646] 'agreement among raft nodes before linearized reading' (duration: 334.965561ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:13.494017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:13.158491Z","time spent":"335.515696ms","remote":"127.0.0.1:60946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":542,"request content":"key:\"/registry/serviceaccounts/kube-system/cilium\" "} {"level":"warn","ts":"2026-05-07T03:20:13.493589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.417805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4335"} {"level":"info","ts":"2026-05-07T03:20:13.494164Z","caller":"traceutil/trace.go:171","msg":"trace[1059581310] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:514; }","duration":"348.013692ms","start":"2026-05-07T03:20:13.146135Z","end":"2026-05-07T03:20:13.494149Z","steps":["trace[1059581310] 'agreement among raft nodes before linearized reading' (duration: 347.381825ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:13.494198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:13.146122Z","time spent":"348.066112ms","remote":"127.0.0.1:32956","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":4357,"request content":"key:\"/registry/deployments/kube-system/cilium-operator\" "} {"level":"warn","ts":"2026-05-07T03:20:13.493524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.808259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/cilium\" ","response":"range_response_count:1 size:14463"} {"level":"info","ts":"2026-05-07T03:20:13.494709Z","caller":"traceutil/trace.go:171","msg":"trace[167513693] range","detail":"{range_begin:/registry/daemonsets/kube-system/cilium; range_end:; response_count:1; response_revision:514; }","duration":"437.83515ms","start":"2026-05-07T03:20:13.056679Z","end":"2026-05-07T03:20:13.494514Z","steps":["trace[167513693] 'agreement among raft nodes before linearized reading' (duration: 436.742119ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:13.494751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:13.056664Z","time spent":"438.074733ms","remote":"127.0.0.1:32976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":14485,"request content":"key:\"/registry/daemonsets/kube-system/cilium\" "} {"level":"warn","ts":"2026-05-07T03:20:13.863013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.649937ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T03:20:13.863198Z","caller":"traceutil/trace.go:171","msg":"trace[1691469370] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:535; }","duration":"305.94159ms","start":"2026-05-07T03:20:13.557246Z","end":"2026-05-07T03:20:13.863188Z","steps":["trace[1691469370] 'read index received' (duration: 151.052731ms)","trace[1691469370] 'applied index is now lower than readState.Index' (duration: 154.888239ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:13.863331Z","caller":"traceutil/trace.go:171","msg":"trace[1434153973] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"356.8141ms","start":"2026-05-07T03:20:13.506511Z","end":"2026-05-07T03:20:13.863325Z","steps":["trace[1434153973] 'process raft request' (duration: 356.648668ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:13.863364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:13.506496Z","time spent":"356.84933ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4339,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:20:13.863434Z","caller":"traceutil/trace.go:171","msg":"trace[671979320] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"361.77179ms","start":"2026-05-07T03:20:13.501645Z","end":"2026-05-07T03:20:13.863417Z","steps":["trace[671979320] 'process raft request' (duration: 206.659368ms)","trace[671979320] 'compare' (duration: 154.488646ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:20:13.863517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:13.501623Z","time spent":"361.85506ms","remote":"127.0.0.1:32956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4617,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:20:13.86356Z","caller":"traceutil/trace.go:171","msg":"trace[1007557023] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"360.84799ms","start":"2026-05-07T03:20:13.502708Z","end":"2026-05-07T03:20:13.863556Z","steps":["trace[1007557023] 'process raft request' (duration: 360.388806ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:13.863596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:13.502391Z","time spent":"361.188513ms","remote":"127.0.0.1:60936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16950,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:13.863718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.765919ms","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:329948"} {"level":"warn","ts":"2026-05-07T03:20:13.863774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.94891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"} {"level":"info","ts":"2026-05-07T03:20:13.86378Z","caller":"traceutil/trace.go:171","msg":"trace[1798885872] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:518; }","duration":"277.861519ms","start":"2026-05-07T03:20:13.585902Z","end":"2026-05-07T03:20:13.863764Z","steps":["trace[1798885872] 'agreement among raft nodes before linearized reading' (duration: 277.443265ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:13.863791Z","caller":"traceutil/trace.go:171","msg":"trace[820988774] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:518; }","duration":"203.99745ms","start":"2026-05-07T03:20:13.659788Z","end":"2026-05-07T03:20:13.863785Z","steps":["trace[820988774] 'agreement among raft nodes before linearized reading' (duration: 203.92133ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:13.863718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.455466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/cilium\" ","response":"range_response_count:1 size:14463"} {"level":"info","ts":"2026-05-07T03:20:13.863921Z","caller":"traceutil/trace.go:171","msg":"trace[958333694] range","detail":"{range_begin:/registry/daemonsets/kube-system/cilium; range_end:; response_count:1; response_revision:518; }","duration":"306.701449ms","start":"2026-05-07T03:20:13.557205Z","end":"2026-05-07T03:20:13.863907Z","steps":["trace[958333694] 'agreement among raft nodes before linearized reading' (duration: 306.354985ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:13.863982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:13.557191Z","time spent":"306.780169ms","remote":"127.0.0.1:32976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":14485,"request content":"key:\"/registry/daemonsets/kube-system/cilium\" "} {"level":"info","ts":"2026-05-07T03:20:14.168532Z","caller":"traceutil/trace.go:171","msg":"trace[960556649] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"295.160627ms","start":"2026-05-07T03:20:13.873349Z","end":"2026-05-07T03:20:14.16851Z","steps":["trace[960556649] 'process raft request' (duration: 295.023346ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:14.386981Z","caller":"traceutil/trace.go:171","msg":"trace[1599168934] linearizableReadLoop","detail":"{readStateIndex:540; appliedIndex:538; }","duration":"508.675427ms","start":"2026-05-07T03:20:13.878279Z","end":"2026-05-07T03:20:14.386954Z","steps":["trace[1599168934] 'read index received' (duration: 290.039926ms)","trace[1599168934] 'applied index is now lower than readState.Index' (duration: 218.634361ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:14.387297Z","caller":"traceutil/trace.go:171","msg":"trace[1256967233] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"511.163132ms","start":"2026-05-07T03:20:13.876095Z","end":"2026-05-07T03:20:14.387258Z","steps":["trace[1256967233] 'process raft request' (duration: 413.130374ms)","trace[1256967233] 'compare' (duration: 97.541143ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:14.387311Z","caller":"traceutil/trace.go:171","msg":"trace[272248497] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"327.888526ms","start":"2026-05-07T03:20:14.059328Z","end":"2026-05-07T03:20:14.387217Z","steps":["trace[272248497] 'process raft request' (duration: 327.562062ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:14.38735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.056531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/cilium-operator-869df985b8\" ","response":"range_response_count:1 size:4354"} {"level":"info","ts":"2026-05-07T03:20:14.387401Z","caller":"traceutil/trace.go:171","msg":"trace[354775432] range","detail":"{range_begin:/registry/replicasets/kube-system/cilium-operator-869df985b8; range_end:; response_count:1; response_revision:521; }","duration":"509.143331ms","start":"2026-05-07T03:20:13.878245Z","end":"2026-05-07T03:20:14.387388Z","steps":["trace[354775432] 'agreement among raft nodes before linearized reading' (duration: 508.98664ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:14.387425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.954517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-07T03:20:14.387452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:13.876073Z","time spent":"511.294353ms","remote":"127.0.0.1:60936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4668,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:20:14.387477Z","caller":"traceutil/trace.go:171","msg":"trace[2137082412] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:521; }","duration":"123.044318ms","start":"2026-05-07T03:20:14.264421Z","end":"2026-05-07T03:20:14.387465Z","steps":["trace[2137082412] 'agreement among raft nodes before linearized reading' (duration: 122.950127ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:14.387472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:14.059304Z","time spent":"328.081547ms","remote":"127.0.0.1:32772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:14.387547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.932302ms","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-05-07T03:20:14.387436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:13.878233Z","time spent":"509.194452ms","remote":"127.0.0.1:32986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":4376,"request content":"key:\"/registry/replicasets/kube-system/cilium-operator-869df985b8\" "} {"level":"info","ts":"2026-05-07T03:20:14.387586Z","caller":"traceutil/trace.go:171","msg":"trace[1154390695] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:521; }","duration":"111.984323ms","start":"2026-05-07T03:20:14.275593Z","end":"2026-05-07T03:20:14.387577Z","steps":["trace[1154390695] 'agreement among raft nodes before linearized reading' (duration: 111.921423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:14.387579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.615549ms","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-05-07T03:20:14.387654Z","caller":"traceutil/trace.go:171","msg":"trace[1143670084] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:521; }","duration":"112.728411ms","start":"2026-05-07T03:20:14.274911Z","end":"2026-05-07T03:20:14.387639Z","steps":["trace[1143670084] 'agreement among raft nodes before linearized reading' (duration: 112.60699ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:14.618377Z","caller":"traceutil/trace.go:171","msg":"trace[480448443] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"225.833106ms","start":"2026-05-07T03:20:14.392518Z","end":"2026-05-07T03:20:14.618351Z","steps":["trace[480448443] 'process raft request' (duration: 195.267228ms)","trace[480448443] 'compare' (duration: 30.440836ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:14.684077Z","caller":"traceutil/trace.go:171","msg":"trace[241527400] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"290.949422ms","start":"2026-05-07T03:20:14.393107Z","end":"2026-05-07T03:20:14.684057Z","steps":["trace[241527400] 'process raft request' (duration: 290.912652ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:14.684357Z","caller":"traceutil/trace.go:171","msg":"trace[1959407190] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"291.254926ms","start":"2026-05-07T03:20:14.393058Z","end":"2026-05-07T03:20:14.684313Z","steps":["trace[1959407190] 'process raft request' (duration: 290.866582ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:15.390167Z","caller":"traceutil/trace.go:171","msg":"trace[299701650] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"144.623537ms","start":"2026-05-07T03:20:15.245518Z","end":"2026-05-07T03:20:15.390141Z","steps":["trace[299701650] 'process raft request' (duration: 144.458715ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:15.554774Z","caller":"traceutil/trace.go:171","msg":"trace[976150368] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"238.951312ms","start":"2026-05-07T03:20:15.315796Z","end":"2026-05-07T03:20:15.554747Z","steps":["trace[976150368] 'process raft request' (duration: 238.887521ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:15.555196Z","caller":"traceutil/trace.go:171","msg":"trace[1531091537] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"309.3691ms","start":"2026-05-07T03:20:15.245812Z","end":"2026-05-07T03:20:15.555181Z","steps":["trace[1531091537] 'process raft request' (duration: 308.246128ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:15.555299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:15.245808Z","time spent":"309.422581ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T03:20:15.555452Z","caller":"traceutil/trace.go:171","msg":"trace[964418528] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"302.071422ms","start":"2026-05-07T03:20:15.253369Z","end":"2026-05-07T03:20:15.555441Z","steps":["trace[964418528] 'process raft request' (duration: 300.751708ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:15.555508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:15.253352Z","time spent":"302.126593ms","remote":"127.0.0.1:60810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":807,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T03:20:15.555656Z","caller":"traceutil/trace.go:171","msg":"trace[882199450] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"286.989469ms","start":"2026-05-07T03:20:15.268655Z","end":"2026-05-07T03:20:15.555644Z","steps":["trace[882199450] 'process raft request' (duration: 285.528984ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:15.55579Z","caller":"traceutil/trace.go:171","msg":"trace[1228224217] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"284.540073ms","start":"2026-05-07T03:20:15.271237Z","end":"2026-05-07T03:20:15.555777Z","steps":["trace[1228224217] 'process raft request' (duration: 283.002746ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:15.555922Z","caller":"traceutil/trace.go:171","msg":"trace[474951975] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"280.922254ms","start":"2026-05-07T03:20:15.274989Z","end":"2026-05-07T03:20:15.555911Z","steps":["trace[474951975] 'process raft request' (duration: 279.303377ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:15.556045Z","caller":"traceutil/trace.go:171","msg":"trace[161288719] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"279.855073ms","start":"2026-05-07T03:20:15.27618Z","end":"2026-05-07T03:20:15.556035Z","steps":["trace[161288719] 'process raft request' (duration: 278.157494ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:15.556175Z","caller":"traceutil/trace.go:171","msg":"trace[2088816443] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"278.164084ms","start":"2026-05-07T03:20:15.277999Z","end":"2026-05-07T03:20:15.556163Z","steps":["trace[2088816443] 'process raft request' (duration: 276.386675ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:15.556305Z","caller":"traceutil/trace.go:171","msg":"trace[383262196] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"274.147071ms","start":"2026-05-07T03:20:15.282147Z","end":"2026-05-07T03:20:15.556294Z","steps":["trace[383262196] 'process raft request' (duration: 272.290441ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:15.556432Z","caller":"traceutil/trace.go:171","msg":"trace[641661945] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"274.224892ms","start":"2026-05-07T03:20:15.282196Z","end":"2026-05-07T03:20:15.556421Z","steps":["trace[641661945] 'process raft request' (duration: 272.360292ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:15.557267Z","caller":"traceutil/trace.go:171","msg":"trace[822136583] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"308.4369ms","start":"2026-05-07T03:20:15.245764Z","end":"2026-05-07T03:20:15.554201Z","steps":["trace[822136583] 'process raft request' (duration: 308.174377ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:15.557488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:15.245757Z","time spent":"311.639395ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-07T03:20:16.005664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.919256ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-07T03:20:16.005898Z","caller":"traceutil/trace.go:171","msg":"trace[1193571023] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"614.780799ms","start":"2026-05-07T03:20:15.391081Z","end":"2026-05-07T03:20:16.005862Z","steps":["trace[1193571023] 'process raft request' (duration: 449.58299ms)","trace[1193571023] 'compare' (duration: 164.704884ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:20:16.006026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:15.391055Z","time spent":"614.913731ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T03:20:16.006047Z","caller":"traceutil/trace.go:171","msg":"trace[600488212] transaction","detail":"{read_only:false; number_of_response:1; response_revision:541; }","duration":"607.773964ms","start":"2026-05-07T03:20:15.398213Z","end":"2026-05-07T03:20:16.005987Z","steps":["trace[600488212] 'process raft request' (duration: 607.721123ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:16.006064Z","caller":"traceutil/trace.go:171","msg":"trace[2036936832] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"609.333971ms","start":"2026-05-07T03:20:15.396692Z","end":"2026-05-07T03:20:16.006026Z","steps":["trace[2036936832] 'process raft request' (duration: 609.176779ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:16.006125Z","caller":"traceutil/trace.go:171","msg":"trace[1087139071] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"610.678645ms","start":"2026-05-07T03:20:15.395258Z","end":"2026-05-07T03:20:16.005937Z","steps":["trace[1087139071] 'process raft request' (duration: 610.533954ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:16.006195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:15.398191Z","time spent":"607.936955ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6936,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:16.006221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:15.396683Z","time spent":"609.455442ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:16.006421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:15.395242Z","time spent":"610.970808ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T03:20:16.072673Z","caller":"traceutil/trace.go:171","msg":"trace[561131290] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"504.234925ms","start":"2026-05-07T03:20:15.568399Z","end":"2026-05-07T03:20:16.072634Z","steps":["trace[561131290] 'process raft request' (duration: 504.077533ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:16.072789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:15.568382Z","time spent":"504.354766ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T03:20:16.072779Z","caller":"traceutil/trace.go:171","msg":"trace[2009518206] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"502.92551ms","start":"2026-05-07T03:20:15.569835Z","end":"2026-05-07T03:20:16.072761Z","steps":["trace[2009518206] 'process raft request' (duration: 502.780449ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:16.072862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:15.569829Z","time spent":"502.993751ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T03:20:16.072948Z","caller":"traceutil/trace.go:171","msg":"trace[424232811] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"502.260123ms","start":"2026-05-07T03:20:15.57068Z","end":"2026-05-07T03:20:16.07294Z","steps":["trace[424232811] 'process raft request' (duration: 501.97024ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:16.072984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:15.570675Z","time spent":"502.291154ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T03:20:16.073073Z","caller":"traceutil/trace.go:171","msg":"trace[808420943] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"491.541028ms","start":"2026-05-07T03:20:15.581514Z","end":"2026-05-07T03:20:16.073055Z","steps":["trace[808420943] 'process raft request' (duration: 491.215244ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:16.073134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:15.581492Z","time spent":"491.606109ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:20:16.073085Z","caller":"traceutil/trace.go:171","msg":"trace[1543935570] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"488.392383ms","start":"2026-05-07T03:20:15.584562Z","end":"2026-05-07T03:20:16.072955Z","steps":["trace[1543935570] 'process raft request' (duration: 488.337553ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:16.073194Z","caller":"traceutil/trace.go:171","msg":"trace[310382620] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"498.22941ms","start":"2026-05-07T03:20:15.574956Z","end":"2026-05-07T03:20:16.073185Z","steps":["trace[310382620] 'process raft request' (duration: 497.727744ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:16.073225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:15.574913Z","time spent":"498.2943ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:16.073275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:15.584553Z","time spent":"488.644396ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:20:16.073328Z","caller":"traceutil/trace.go:171","msg":"trace[1109157339] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"491.738781ms","start":"2026-05-07T03:20:15.581583Z","end":"2026-05-07T03:20:16.073321Z","steps":["trace[1109157339] 'process raft request' (duration: 491.195405ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:16.073373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:15.581578Z","time spent":"491.772191ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:20:16.073494Z","caller":"traceutil/trace.go:171","msg":"trace[967126734] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"504.466457ms","start":"2026-05-07T03:20:15.568997Z","end":"2026-05-07T03:20:16.073463Z","steps":["trace[967126734] 'process raft request' (duration: 503.587157ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:16.073701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:15.56899Z","time spent":"504.662339ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T03:20:16.321528Z","caller":"traceutil/trace.go:171","msg":"trace[261363991] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"250.986064ms","start":"2026-05-07T03:20:16.070514Z","end":"2026-05-07T03:20:16.3215Z","steps":["trace[261363991] 'process raft request' (duration: 250.926164ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:16.321581Z","caller":"traceutil/trace.go:171","msg":"trace[1130987518] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"306.960708ms","start":"2026-05-07T03:20:16.014584Z","end":"2026-05-07T03:20:16.321545Z","steps":["trace[1130987518] 'process raft request' (duration: 226.851516ms)","trace[1130987518] 'compare' (duration: 79.573256ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:20:16.321897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:16.014565Z","time spent":"307.223291ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:20:16.321907Z","caller":"traceutil/trace.go:171","msg":"trace[1934617244] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"301.491107ms","start":"2026-05-07T03:20:16.020233Z","end":"2026-05-07T03:20:16.321724Z","steps":["trace[1934617244] 'process raft request' (duration: 301.018802ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:16.322474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:16.020207Z","time spent":"302.094313ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:20:16.529059Z","caller":"traceutil/trace.go:171","msg":"trace[664042421] transaction","detail":"{read_only:false; number_of_response:0; response_revision:552; }","duration":"451.399446ms","start":"2026-05-07T03:20:16.077609Z","end":"2026-05-07T03:20:16.529009Z","steps":["trace[664042421] 'process raft request' (duration: 451.229804ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:16.529184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:16.077585Z","time spent":"451.541187ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T03:20:16.529187Z","caller":"traceutil/trace.go:171","msg":"trace[847075736] transaction","detail":"{read_only:false; number_of_response:0; response_revision:552; }","duration":"451.510427ms","start":"2026-05-07T03:20:16.077645Z","end":"2026-05-07T03:20:16.529155Z","steps":["trace[847075736] 'process raft request' (duration: 451.298024ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:16.529338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:16.077625Z","time spent":"451.644769ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T03:20:16.533785Z","caller":"traceutil/trace.go:171","msg":"trace[756938750] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"438.103928ms","start":"2026-05-07T03:20:16.09566Z","end":"2026-05-07T03:20:16.533764Z","steps":["trace[756938750] 'process raft request' (duration: 435.722512ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:16.533803Z","caller":"traceutil/trace.go:171","msg":"trace[1693057616] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"416.7775ms","start":"2026-05-07T03:20:16.116989Z","end":"2026-05-07T03:20:16.533767Z","steps":["trace[1693057616] 'process raft request' (duration: 416.513937ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:16.534053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:16.11697Z","time spent":"416.997533ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:20:16.534091Z","caller":"traceutil/trace.go:171","msg":"trace[1540701597] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"439.281411ms","start":"2026-05-07T03:20:16.094796Z","end":"2026-05-07T03:20:16.534077Z","steps":["trace[1540701597] 'process raft request' (duration: 435.028193ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:16.53417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:16.094768Z","time spent":"439.375163ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:16.533909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:16.095642Z","time spent":"438.203309ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:20:16.592436Z","caller":"traceutil/trace.go:171","msg":"trace[1670500956] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"262.077468ms","start":"2026-05-07T03:20:16.330338Z","end":"2026-05-07T03:20:16.592416Z","steps":["trace[1670500956] 'process raft request' (duration: 261.919657ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:16.592751Z","caller":"traceutil/trace.go:171","msg":"trace[1043768191] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"261.798815ms","start":"2026-05-07T03:20:16.330942Z","end":"2026-05-07T03:20:16.592741Z","steps":["trace[1043768191] 'process raft request' (duration: 261.433871ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:16.593035Z","caller":"traceutil/trace.go:171","msg":"trace[562801182] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"260.629823ms","start":"2026-05-07T03:20:16.332335Z","end":"2026-05-07T03:20:16.592965Z","steps":["trace[562801182] 'process raft request' (duration: 260.281709ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:16.605566Z","caller":"traceutil/trace.go:171","msg":"trace[233970781] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"192.399033ms","start":"2026-05-07T03:20:16.413146Z","end":"2026-05-07T03:20:16.605545Z","steps":["trace[233970781] 'process raft request' (duration: 191.557833ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:18.1302Z","caller":"traceutil/trace.go:171","msg":"trace[157328904] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"883.70217ms","start":"2026-05-07T03:20:17.246472Z","end":"2026-05-07T03:20:18.130174Z","steps":["trace[157328904] 'process raft request' (duration: 861.971252ms)","trace[157328904] 'compare' (duration: 21.461045ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:20:18.130321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:17.246439Z","time spent":"883.820892ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65412,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:19.092887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.189788ms","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-05-07T03:20:19.093061Z","caller":"traceutil/trace.go:171","msg":"trace[711468478] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:592; }","duration":"603.35897ms","start":"2026-05-07T03:20:18.489645Z","end":"2026-05-07T03:20:19.093004Z","steps":["trace[711468478] 'range keys from in-memory index tree' (duration: 603.170978ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:19.093156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.787292ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-07T03:20:19.093811Z","caller":"traceutil/trace.go:171","msg":"trace[269444260] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"1.834256963s","start":"2026-05-07T03:20:17.259532Z","end":"2026-05-07T03:20:19.093789Z","steps":["trace[269444260] 'process raft request' (duration: 1.467747693s)","trace[269444260] 'compare' (duration: 365.391867ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:19.093883Z","caller":"traceutil/trace.go:171","msg":"trace[1442057140] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"1.826805218s","start":"2026-05-07T03:20:17.267054Z","end":"2026-05-07T03:20:19.093859Z","steps":["trace[1442057140] 'process raft request' (duration: 1.826586876s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:19.093922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:17.259508Z","time spent":"1.834360064s","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-07T03:20:19.094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:17.267025Z","time spent":"1.826909229s","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98698,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:20:19.390691Z","caller":"traceutil/trace.go:171","msg":"trace[613619252] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:616; }","duration":"751.409072ms","start":"2026-05-07T03:20:18.639233Z","end":"2026-05-07T03:20:19.390642Z","steps":["trace[613619252] 'read index received' (duration: 88.058545ms)","trace[613619252] 'applied index is now lower than readState.Index' (duration: 663.349777ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:19.390809Z","caller":"traceutil/trace.go:171","msg":"trace[845723658] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"1.23598863s","start":"2026-05-07T03:20:18.15481Z","end":"2026-05-07T03:20:19.390799Z","steps":["trace[845723658] 'process raft request' (duration: 1.235614265s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:19.391005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:18.154794Z","time spent":"1.236110711s","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":74745,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:19.391189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"751.927968ms","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-05-07T03:20:19.391273Z","caller":"traceutil/trace.go:171","msg":"trace[1262413307] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:595; }","duration":"752.062759ms","start":"2026-05-07T03:20:18.639191Z","end":"2026-05-07T03:20:19.391254Z","steps":["trace[1262413307] 'agreement among raft nodes before linearized reading' (duration: 751.792226ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:19.391432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:18.639173Z","time spent":"752.249202ms","remote":"127.0.0.1:32772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-07T03:20:19.891645Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744509316007380,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-07T03:20:19.998046Z","caller":"traceutil/trace.go:171","msg":"trace[1080341503] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"728.638001ms","start":"2026-05-07T03:20:19.26938Z","end":"2026-05-07T03:20:19.998018Z","steps":["trace[1080341503] 'process raft request' (duration: 728.54613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:19.998276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:19.269347Z","time spent":"728.791642ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T03:20:19.998346Z","caller":"traceutil/trace.go:171","msg":"trace[1422092737] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"884.577566ms","start":"2026-05-07T03:20:19.113741Z","end":"2026-05-07T03:20:19.998319Z","steps":["trace[1422092737] 'process raft request' (duration: 883.946918ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:19.998592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:19.113716Z","time spent":"884.737977ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:20.415066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.598706ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T03:20:20.415365Z","caller":"traceutil/trace.go:171","msg":"trace[891711894] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:619; }","duration":"1.024581131s","start":"2026-05-07T03:20:19.390768Z","end":"2026-05-07T03:20:20.415349Z","steps":["trace[891711894] 'read index received' (duration: 607.064786ms)","trace[891711894] 'applied index is now lower than readState.Index' (duration: 417.515425ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:20.415522Z","caller":"traceutil/trace.go:171","msg":"trace[926472104] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"1.01873429s","start":"2026-05-07T03:20:19.396769Z","end":"2026-05-07T03:20:20.415504Z","steps":["trace[926472104] 'process raft request' (duration: 850.623118ms)","trace[926472104] 'compare' (duration: 167.452964ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:20:20.415867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.703755516s","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-05-07T03:20:20.416001Z","caller":"traceutil/trace.go:171","msg":"trace[1336288649] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:599; }","duration":"1.703965408s","start":"2026-05-07T03:20:18.712005Z","end":"2026-05-07T03:20:20.41597Z","steps":["trace[1336288649] 'agreement among raft nodes before linearized reading' (duration: 1.703536152s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:20.416018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:19.39675Z","time spent":"1.019195975s","remote":"127.0.0.1:32772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:20.41567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.696604811s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-07T03:20:20.41606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:18.711993Z","time spent":"1.70405571s","remote":"127.0.0.1:32772","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":"info","ts":"2026-05-07T03:20:20.416082Z","caller":"traceutil/trace.go:171","msg":"trace[1736547637] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:599; }","duration":"1.697035626s","start":"2026-05-07T03:20:18.719031Z","end":"2026-05-07T03:20:20.416067Z","steps":["trace[1736547637] 'agreement among raft nodes before linearized reading' (duration: 1.696492989s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:20.416323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:18.719022Z","time spent":"1.697229938s","remote":"127.0.0.1:32772","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-05-07T03:20:20.415751Z","caller":"traceutil/trace.go:171","msg":"trace[447132950] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"1.010607051s","start":"2026-05-07T03:20:19.405114Z","end":"2026-05-07T03:20:20.415374Z","steps":["trace[447132950] 'process raft request' (duration: 1.010133755s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:20.416558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:19.405097Z","time spent":"1.01140307s","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20842,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:20.415623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.63917805s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T03:20:20.416791Z","caller":"traceutil/trace.go:171","msg":"trace[1893581356] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"1.640375455s","start":"2026-05-07T03:20:18.77639Z","end":"2026-05-07T03:20:20.416766Z","steps":["trace[1893581356] 'agreement among raft nodes before linearized reading' (duration: 1.639017088s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:20.416942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:18.776376Z","time spent":"1.640543867s","remote":"127.0.0.1:60708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-07T03:20:20.415699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.608211182s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-07T03:20:20.417141Z","caller":"traceutil/trace.go:171","msg":"trace[1033833338] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:599; }","duration":"1.609691301s","start":"2026-05-07T03:20:18.807434Z","end":"2026-05-07T03:20:20.417125Z","steps":["trace[1033833338] 'agreement among raft nodes before linearized reading' (duration: 1.608057291s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:20.417188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:18.807419Z","time spent":"1.609756022s","remote":"127.0.0.1:32772","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":"info","ts":"2026-05-07T03:20:20.461663Z","caller":"traceutil/trace.go:171","msg":"trace[975227888] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"438.101524ms","start":"2026-05-07T03:20:20.023545Z","end":"2026-05-07T03:20:20.461646Z","steps":["trace[975227888] 'process raft request' (duration: 437.903872ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:20.461803Z","caller":"traceutil/trace.go:171","msg":"trace[1571302329] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"436.309682ms","start":"2026-05-07T03:20:20.025478Z","end":"2026-05-07T03:20:20.461788Z","steps":["trace[1571302329] 'process raft request' (duration: 436.09771ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:20.461881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:20.02545Z","time spent":"436.384173ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":74754,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:20.462127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.140934ms","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-05-07T03:20:20.462156Z","caller":"traceutil/trace.go:171","msg":"trace[1548676159] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:601; }","duration":"426.223496ms","start":"2026-05-07T03:20:20.035925Z","end":"2026-05-07T03:20:20.462149Z","steps":["trace[1548676159] 'agreement among raft nodes before linearized reading' (duration: 426.083944ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:20.462275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:20.023526Z","time spent":"438.189696ms","remote":"127.0.0.1:32772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:20.46223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:20.035912Z","time spent":"426.311117ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":103,"response count":1,"response size":29592,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-05-07T03:20:20.700634Z","caller":"traceutil/trace.go:171","msg":"trace[1930127955] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"104.443332ms","start":"2026-05-07T03:20:20.596166Z","end":"2026-05-07T03:20:20.700609Z","steps":["trace[1930127955] 'read index received' (duration: 103.211357ms)","trace[1930127955] 'applied index is now lower than readState.Index' (duration: 1.231055ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:20.700843Z","caller":"traceutil/trace.go:171","msg":"trace[1333245715] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"120.93625ms","start":"2026-05-07T03:20:20.579886Z","end":"2026-05-07T03:20:20.700822Z","steps":["trace[1333245715] 'process raft request' (duration: 119.792925ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:20.700858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.665875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:151236"} {"level":"info","ts":"2026-05-07T03:20:20.700897Z","caller":"traceutil/trace.go:171","msg":"trace[1493920904] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:606; }","duration":"104.765806ms","start":"2026-05-07T03:20:20.596121Z","end":"2026-05-07T03:20:20.700887Z","steps":["trace[1493920904] 'agreement among raft nodes before linearized reading' (duration: 104.578304ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:21.479455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:20.799436Z","time spent":"679.985738ms","remote":"127.0.0.1:38526","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-07T03:20:21.479548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.455418ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T03:20:21.47962Z","caller":"traceutil/trace.go:171","msg":"trace[1151994126] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:630; }","duration":"730.455183ms","start":"2026-05-07T03:20:20.749154Z","end":"2026-05-07T03:20:21.479609Z","steps":["trace[1151994126] 'read index received' (duration: 381.926254ms)","trace[1151994126] 'applied index is now lower than readState.Index' (duration: 348.528199ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:21.479747Z","caller":"traceutil/trace.go:171","msg":"trace[1398616762] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"733.618302ms","start":"2026-05-07T03:20:20.746123Z","end":"2026-05-07T03:20:21.479742Z","steps":["trace[1398616762] 'process raft request' (duration: 384.899671ms)","trace[1398616762] 'compare' (duration: 348.358667ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:20:21.479868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:20.746106Z","time spent":"733.662033ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15664,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:21.479959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"730.781997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31145"} {"level":"info","ts":"2026-05-07T03:20:21.480012Z","caller":"traceutil/trace.go:171","msg":"trace[856466952] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:607; }","duration":"730.869728ms","start":"2026-05-07T03:20:20.749126Z","end":"2026-05-07T03:20:21.479996Z","steps":["trace[856466952] 'agreement among raft nodes before linearized reading' (duration: 730.646905ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:21.480051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:20.749111Z","time spent":"730.932739ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":31167,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-05-07T03:20:21.569813Z","caller":"traceutil/trace.go:171","msg":"trace[549765207] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"673.248335ms","start":"2026-05-07T03:20:20.896535Z","end":"2026-05-07T03:20:21.569783Z","steps":["trace[549765207] 'process raft request' (duration: 672.83501ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:21.569954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.779679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.162\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-05-07T03:20:21.570028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:20.896507Z","time spent":"673.394837ms","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:20:21.570066Z","caller":"traceutil/trace.go:171","msg":"trace[1261049500] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:608; }","duration":"522.957261ms","start":"2026-05-07T03:20:21.047084Z","end":"2026-05-07T03:20:21.570041Z","steps":["trace[1261049500] 'agreement among raft nodes before linearized reading' (duration: 522.720928ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:21.570129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:21.047063Z","time spent":"523.055952ms","remote":"127.0.0.1:60756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.162\" "} {"level":"warn","ts":"2026-05-07T03:20:22.070182Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744509316007403,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-07T03:20:22.765469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.748279ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T03:20:22.765702Z","caller":"traceutil/trace.go:171","msg":"trace[292479876] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"1.250858826s","start":"2026-05-07T03:20:21.514818Z","end":"2026-05-07T03:20:22.765677Z","steps":["trace[292479876] 'process raft request' (duration: 590.758902ms)","trace[292479876] 'compare' (duration: 659.07086ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:20:22.766045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:21.514789Z","time spent":"1.250975497s","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:23.775799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999769471s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-07T03:20:23.775892Z","caller":"traceutil/trace.go:171","msg":"trace[399980384] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999956113s","start":"2026-05-07T03:20:21.775914Z","end":"2026-05-07T03:20:23.775871Z","steps":["trace[399980384] 'agreement among raft nodes before linearized reading' (duration: 1.999828362s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:23.775943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:21.775885Z","time spent":"2.000046975s","remote":"127.0.0.1:60708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-07T03:20:23.893117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.02701815s","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-05-07T03:20:23.893395Z","caller":"traceutil/trace.go:171","msg":"trace[458320500] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:632; }","duration":"2.32362832s","start":"2026-05-07T03:20:21.569748Z","end":"2026-05-07T03:20:23.893377Z","steps":["trace[458320500] 'read index received' (duration: 535.758361ms)","trace[458320500] 'applied index is now lower than readState.Index' (duration: 1.787867269s)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:20:23.893489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:21.571309Z","time spent":"2.322177781s","remote":"127.0.0.1:60756","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-07T03:20:23.893768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.06372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T03:20:23.893837Z","caller":"traceutil/trace.go:171","msg":"trace[1362026543] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:610; }","duration":"117.168651ms","start":"2026-05-07T03:20:23.77665Z","end":"2026-05-07T03:20:23.893819Z","steps":["trace[1362026543] 'agreement among raft nodes before linearized reading' (duration: 117.049839ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:23.893856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.473822809s","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-05-07T03:20:23.893858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.406630249s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-07T03:20:23.893908Z","caller":"traceutil/trace.go:171","msg":"trace[1278735348] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:610; }","duration":"1.473931461s","start":"2026-05-07T03:20:22.41996Z","end":"2026-05-07T03:20:23.893891Z","steps":["trace[1278735348] 'agreement among raft nodes before linearized reading' (duration: 1.473738668s)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:23.893924Z","caller":"traceutil/trace.go:171","msg":"trace[1249067018] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:610; }","duration":"1.40671713s","start":"2026-05-07T03:20:22.487189Z","end":"2026-05-07T03:20:23.893906Z","steps":["trace[1249067018] 'agreement among raft nodes before linearized reading' (duration: 1.406517797s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:23.893943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:22.419933Z","time spent":"1.474001461s","remote":"127.0.0.1:32772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-07T03:20:23.893965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:22.487184Z","time spent":"1.406772911s","remote":"127.0.0.1:32772","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-05-07T03:20:23.893945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.407222077s","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-05-07T03:20:23.893963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.406638909s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-07T03:20:23.894047Z","caller":"traceutil/trace.go:171","msg":"trace[193096260] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:610; }","duration":"1.407370419s","start":"2026-05-07T03:20:22.486651Z","end":"2026-05-07T03:20:23.894022Z","steps":["trace[193096260] 'agreement among raft nodes before linearized reading' (duration: 1.407069605s)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:23.894054Z","caller":"traceutil/trace.go:171","msg":"trace[249464780] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:610; }","duration":"1.406766351s","start":"2026-05-07T03:20:22.487267Z","end":"2026-05-07T03:20:23.894033Z","steps":["trace[249464780] 'agreement among raft nodes before linearized reading' (duration: 1.406506277s)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:23.894093Z","caller":"traceutil/trace.go:171","msg":"trace[963873260] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"2.250784711s","start":"2026-05-07T03:20:21.643298Z","end":"2026-05-07T03:20:23.894082Z","steps":["trace[963873260] 'process raft request' (duration: 2.249915469s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:23.894097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:22.48663Z","time spent":"1.407458681s","remote":"127.0.0.1:32772","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-05-07T03:20:23.894098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:22.487254Z","time spent":"1.406836032s","remote":"127.0.0.1:32772","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-05-07T03:20:23.894142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.403559243s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tlsroutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:65214"} {"level":"info","ts":"2026-05-07T03:20:23.894184Z","caller":"traceutil/trace.go:171","msg":"trace[66727267] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tlsroutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:610; }","duration":"2.403635654s","start":"2026-05-07T03:20:21.490534Z","end":"2026-05-07T03:20:23.89417Z","steps":["trace[66727267] 'agreement among raft nodes before linearized reading' (duration: 2.403447381s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:23.894216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:21.490519Z","time spent":"2.403689064s","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":65236,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tlsroutes.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-05-07T03:20:23.894353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:21.643266Z","time spent":"2.250853822s","remote":"127.0.0.1:60788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:24.16138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.768218ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T03:20:24.16199Z","caller":"traceutil/trace.go:171","msg":"trace[1340847417] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"263.116136ms","start":"2026-05-07T03:20:23.898842Z","end":"2026-05-07T03:20:24.161958Z","steps":["trace[1340847417] 'process raft request' (duration: 262.69756ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:24.162028Z","caller":"traceutil/trace.go:171","msg":"trace[860735285] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"262.995404ms","start":"2026-05-07T03:20:23.898952Z","end":"2026-05-07T03:20:24.161948Z","steps":["trace[860735285] 'process raft request' (duration: 262.641799ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:24.162211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.987947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T03:20:24.162263Z","caller":"traceutil/trace.go:171","msg":"trace[927301867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:617; }","duration":"261.084568ms","start":"2026-05-07T03:20:23.901162Z","end":"2026-05-07T03:20:24.162246Z","steps":["trace[927301867] 'agreement among raft nodes before linearized reading' (duration: 260.989697ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:24.162305Z","caller":"traceutil/trace.go:171","msg":"trace[1065591438] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"266.320219ms","start":"2026-05-07T03:20:23.895931Z","end":"2026-05-07T03:20:24.162251Z","steps":["trace[1065591438] 'process raft request' (duration: 98.587128ms)","trace[1065591438] 'compare' (duration: 166.632906ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:24.16223Z","caller":"traceutil/trace.go:171","msg":"trace[1245082661] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"261.767158ms","start":"2026-05-07T03:20:23.90031Z","end":"2026-05-07T03:20:24.162077Z","steps":["trace[1245082661] 'process raft request' (duration: 261.539805ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:24.162412Z","caller":"traceutil/trace.go:171","msg":"trace[1128073671] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:635; }","duration":"260.924976ms","start":"2026-05-07T03:20:23.901222Z","end":"2026-05-07T03:20:24.162147Z","steps":["trace[1128073671] 'read index received' (duration: 92.893681ms)","trace[1128073671] 'applied index is now lower than readState.Index' (duration: 168.030155ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:24.162554Z","caller":"traceutil/trace.go:171","msg":"trace[1177312956] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"216.931529ms","start":"2026-05-07T03:20:23.945611Z","end":"2026-05-07T03:20:24.162542Z","steps":["trace[1177312956] 'process raft request' (duration: 216.391892ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:24.162231Z","caller":"traceutil/trace.go:171","msg":"trace[2088879207] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"261.795218ms","start":"2026-05-07T03:20:23.900351Z","end":"2026-05-07T03:20:24.162146Z","steps":["trace[2088879207] 'process raft request' (duration: 261.534634ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:24.162809Z","caller":"traceutil/trace.go:171","msg":"trace[1756432374] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"261.318022ms","start":"2026-05-07T03:20:23.901478Z","end":"2026-05-07T03:20:24.162796Z","steps":["trace[1756432374] 'process raft request' (duration: 260.439289ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:24.163079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.984909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31126"} {"level":"info","ts":"2026-05-07T03:20:24.163155Z","caller":"traceutil/trace.go:171","msg":"trace[159224385] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:617; }","duration":"256.06501ms","start":"2026-05-07T03:20:23.90705Z","end":"2026-05-07T03:20:24.163115Z","steps":["trace[159224385] 'agreement among raft nodes before linearized reading' (duration: 255.589043ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:24.612179Z","caller":"traceutil/trace.go:171","msg":"trace[1223312439] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"186.420923ms","start":"2026-05-07T03:20:24.425733Z","end":"2026-05-07T03:20:24.612153Z","steps":["trace[1223312439] 'process raft request' (duration: 186.254161ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:25.926941Z","caller":"traceutil/trace.go:171","msg":"trace[1711593774] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"115.97862ms","start":"2026-05-07T03:20:25.810943Z","end":"2026-05-07T03:20:25.926921Z","steps":["trace[1711593774] 'process raft request' (duration: 115.857459ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:26.053323Z","caller":"traceutil/trace.go:171","msg":"trace[1632697592] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"118.622344ms","start":"2026-05-07T03:20:25.934676Z","end":"2026-05-07T03:20:26.053298Z","steps":["trace[1632697592] 'process raft request' (duration: 66.381834ms)","trace[1632697592] 'compare' (duration: 51.947426ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:26.092137Z","caller":"traceutil/trace.go:171","msg":"trace[184384773] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"157.327118ms","start":"2026-05-07T03:20:25.934782Z","end":"2026-05-07T03:20:26.092109Z","steps":["trace[184384773] 'process raft request' (duration: 157.223777ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:26.394098Z","caller":"traceutil/trace.go:171","msg":"trace[1365607553] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"216.980407ms","start":"2026-05-07T03:20:26.177099Z","end":"2026-05-07T03:20:26.394079Z","steps":["trace[1365607553] 'process raft request' (duration: 198.548039ms)","trace[1365607553] 'compare' (duration: 18.238545ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:26.394097Z","caller":"traceutil/trace.go:171","msg":"trace[1601135500] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"216.964237ms","start":"2026-05-07T03:20:26.177113Z","end":"2026-05-07T03:20:26.394077Z","steps":["trace[1601135500] 'process raft request' (duration: 216.881686ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:26.394227Z","caller":"traceutil/trace.go:171","msg":"trace[1150836049] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"215.690778ms","start":"2026-05-07T03:20:26.178516Z","end":"2026-05-07T03:20:26.394207Z","steps":["trace[1150836049] 'process raft request' (duration: 215.524745ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:26.60287Z","caller":"traceutil/trace.go:171","msg":"trace[119899645] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"301.808901ms","start":"2026-05-07T03:20:26.300302Z","end":"2026-05-07T03:20:26.602111Z","steps":["trace[119899645] 'process raft request' (duration: 301.139321ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:26.603044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:26.300279Z","time spent":"302.679344ms","remote":"127.0.0.1:60828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036015,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-07T03:20:26.805379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.552601ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-07T03:20:26.805464Z","caller":"traceutil/trace.go:171","msg":"trace[1454223803] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"144.994599ms","start":"2026-05-07T03:20:26.660454Z","end":"2026-05-07T03:20:26.805448Z","steps":["trace[1454223803] 'read index received' (duration: 54.51µs)","trace[1454223803] 'applied index is now lower than readState.Index' (duration: 144.938939ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:20:26.805525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.06543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T03:20:26.805548Z","caller":"traceutil/trace.go:171","msg":"trace[14773318] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:626; }","duration":"145.125681ms","start":"2026-05-07T03:20:26.660414Z","end":"2026-05-07T03:20:26.80554Z","steps":["trace[14773318] 'agreement among raft nodes before linearized reading' (duration: 145.07073ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:27.358728Z","caller":"traceutil/trace.go:171","msg":"trace[1759820998] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"156.81657ms","start":"2026-05-07T03:20:27.201892Z","end":"2026-05-07T03:20:27.358709Z","steps":["trace[1759820998] 'process raft request' (duration: 156.398074ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:28.600398Z","caller":"traceutil/trace.go:171","msg":"trace[1817242920] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"196.51647ms","start":"2026-05-07T03:20:28.40386Z","end":"2026-05-07T03:20:28.600376Z","steps":["trace[1817242920] 'process raft request' (duration: 196.026893ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:28.636921Z","caller":"traceutil/trace.go:171","msg":"trace[1067492489] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"232.78022ms","start":"2026-05-07T03:20:28.404116Z","end":"2026-05-07T03:20:28.636897Z","steps":["trace[1067492489] 'process raft request' (duration: 232.648128ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:28.637202Z","caller":"traceutil/trace.go:171","msg":"trace[1360706665] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"232.988824ms","start":"2026-05-07T03:20:28.404194Z","end":"2026-05-07T03:20:28.637183Z","steps":["trace[1360706665] 'process raft request' (duration: 232.667039ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:28.637684Z","caller":"traceutil/trace.go:171","msg":"trace[481549016] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"182.049661ms","start":"2026-05-07T03:20:28.455607Z","end":"2026-05-07T03:20:28.637657Z","steps":["trace[481549016] 'process raft request' (duration: 181.666555ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:29.23752Z","caller":"traceutil/trace.go:171","msg":"trace[912237109] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"129.684336ms","start":"2026-05-07T03:20:29.10781Z","end":"2026-05-07T03:20:29.237495Z","steps":["trace[912237109] 'process raft request' (duration: 127.523423ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:29.472027Z","caller":"traceutil/trace.go:171","msg":"trace[1452937848] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"168.666109ms","start":"2026-05-07T03:20:29.303333Z","end":"2026-05-07T03:20:29.471999Z","steps":["trace[1452937848] 'process raft request' (duration: 162.505564ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:30.04252Z","caller":"traceutil/trace.go:171","msg":"trace[1691780737] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"166.414417ms","start":"2026-05-07T03:20:29.876085Z","end":"2026-05-07T03:20:30.0425Z","steps":["trace[1691780737] 'process raft request' (duration: 165.919009ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:30.449328Z","caller":"traceutil/trace.go:171","msg":"trace[2060505152] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"128.239861ms","start":"2026-05-07T03:20:30.32104Z","end":"2026-05-07T03:20:30.44928Z","steps":["trace[2060505152] 'process raft request' (duration: 72.277599ms)","trace[2060505152] 'compare' (duration: 55.8042ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:30.875839Z","caller":"traceutil/trace.go:171","msg":"trace[1689851823] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:668; }","duration":"271.021693ms","start":"2026-05-07T03:20:30.604788Z","end":"2026-05-07T03:20:30.87581Z","steps":["trace[1689851823] 'read index received' (duration: 270.220261ms)","trace[1689851823] 'applied index is now lower than readState.Index' (duration: 800.462µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:30.875936Z","caller":"traceutil/trace.go:171","msg":"trace[68446081] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"313.632066ms","start":"2026-05-07T03:20:30.562279Z","end":"2026-05-07T03:20:30.875911Z","steps":["trace[68446081] 'process raft request' (duration: 312.817943ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:30.876048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.247238ms","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-05-07T03:20:30.876082Z","caller":"traceutil/trace.go:171","msg":"trace[1695293466] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:643; }","duration":"271.298358ms","start":"2026-05-07T03:20:30.604772Z","end":"2026-05-07T03:20:30.87607Z","steps":["trace[1695293466] 'agreement among raft nodes before linearized reading' (duration: 271.161086ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:30.876164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:30.562248Z","time spent":"313.804868ms","remote":"127.0.0.1:60828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:20:31.16873Z","caller":"traceutil/trace.go:171","msg":"trace[2064444840] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"404.946664ms","start":"2026-05-07T03:20:30.763754Z","end":"2026-05-07T03:20:31.1687Z","steps":["trace[2064444840] 'process raft request' (duration: 375.582373ms)","trace[2064444840] 'compare' (duration: 29.165698ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:20:31.168872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:30.763731Z","time spent":"405.069846ms","remote":"127.0.0.1:32772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:20:31.168888Z","caller":"traceutil/trace.go:171","msg":"trace[312418600] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:669; }","duration":"292.872187ms","start":"2026-05-07T03:20:30.875911Z","end":"2026-05-07T03:20:31.168784Z","steps":["trace[312418600] 'read index received' (duration: 263.439444ms)","trace[312418600] 'applied index is now lower than readState.Index' (duration: 29.432023ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:31.168729Z","caller":"traceutil/trace.go:171","msg":"trace[522561379] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"231.788173ms","start":"2026-05-07T03:20:30.93692Z","end":"2026-05-07T03:20:31.168708Z","steps":["trace[522561379] 'process raft request' (duration: 231.752683ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:31.169074Z","caller":"traceutil/trace.go:171","msg":"trace[264059055] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"289.185089ms","start":"2026-05-07T03:20:30.879864Z","end":"2026-05-07T03:20:31.16905Z","steps":["trace[264059055] 'process raft request' (duration: 288.768812ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:31.169122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.158899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T03:20:31.169237Z","caller":"traceutil/trace.go:171","msg":"trace[536900573] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"393.306111ms","start":"2026-05-07T03:20:30.775916Z","end":"2026-05-07T03:20:31.169222Z","steps":["trace[536900573] 'agreement among raft nodes before linearized reading' (duration: 393.155818ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:31.169313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:30.775908Z","time spent":"393.393032ms","remote":"127.0.0.1:60722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-07T03:20:31.169337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.221477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.162\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-07T03:20:31.169396Z","caller":"traceutil/trace.go:171","msg":"trace[329652048] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:646; }","duration":"121.39965ms","start":"2026-05-07T03:20:31.047986Z","end":"2026-05-07T03:20:31.169385Z","steps":["trace[329652048] 'agreement among raft nodes before linearized reading' (duration: 121.178377ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:31.169393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.554953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-07T03:20:31.169218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.066701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-07T03:20:31.169438Z","caller":"traceutil/trace.go:171","msg":"trace[119755931] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:646; }","duration":"528.627014ms","start":"2026-05-07T03:20:30.640799Z","end":"2026-05-07T03:20:31.169426Z","steps":["trace[119755931] 'agreement among raft nodes before linearized reading' (duration: 528.454711ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:31.169498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:30.640792Z","time spent":"528.696485ms","remote":"127.0.0.1:32772","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-05-07T03:20:31.169455Z","caller":"traceutil/trace.go:171","msg":"trace[1463237634] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:646; }","duration":"529.350896ms","start":"2026-05-07T03:20:30.640084Z","end":"2026-05-07T03:20:31.169435Z","steps":["trace[1463237634] 'agreement among raft nodes before linearized reading' (duration: 529.012741ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:31.169584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:30.640064Z","time spent":"529.494078ms","remote":"127.0.0.1:32772","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":"info","ts":"2026-05-07T03:20:31.302402Z","caller":"traceutil/trace.go:171","msg":"trace[643215880] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:672; }","duration":"125.122339ms","start":"2026-05-07T03:20:31.177256Z","end":"2026-05-07T03:20:31.302378Z","steps":["trace[643215880] 'read index received' (duration: 16.80455ms)","trace[643215880] 'applied index is now lower than readState.Index' (duration: 108.317019ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:31.302494Z","caller":"traceutil/trace.go:171","msg":"trace[727651722] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"129.695903ms","start":"2026-05-07T03:20:31.172771Z","end":"2026-05-07T03:20:31.302467Z","steps":["trace[727651722] 'process raft request' (duration: 125.438775ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:31.302759Z","caller":"traceutil/trace.go:171","msg":"trace[1475682044] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"127.396796ms","start":"2026-05-07T03:20:31.175348Z","end":"2026-05-07T03:20:31.302745Z","steps":["trace[1475682044] 'process raft request' (duration: 126.99097ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:31.302995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.271432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T03:20:31.303042Z","caller":"traceutil/trace.go:171","msg":"trace[1766287088] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:648; }","duration":"125.811381ms","start":"2026-05-07T03:20:31.177216Z","end":"2026-05-07T03:20:31.303028Z","steps":["trace[1766287088] 'agreement among raft nodes before linearized reading' (duration: 125.253022ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:31.307058Z","caller":"traceutil/trace.go:171","msg":"trace[838453373] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"112.06912ms","start":"2026-05-07T03:20:31.194973Z","end":"2026-05-07T03:20:31.307042Z","steps":["trace[838453373] 'process raft request' (duration: 111.973159ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:32.277036Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744509316007510,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-07T03:20:32.777238Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744509316007510,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-07T03:20:33.27823Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744509316007510,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-07T03:20:33.314022Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.61887943s","expected-duration":"1s"} {"level":"info","ts":"2026-05-07T03:20:33.315145Z","caller":"traceutil/trace.go:171","msg":"trace[1013594090] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:678; }","duration":"1.538385998s","start":"2026-05-07T03:20:31.776733Z","end":"2026-05-07T03:20:33.315119Z","steps":["trace[1013594090] 'read index received' (duration: 1.537406572s)","trace[1013594090] 'applied index is now lower than readState.Index' (duration: 978.306µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:33.315254Z","caller":"traceutil/trace.go:171","msg":"trace[1630630893] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"1.621822058s","start":"2026-05-07T03:20:31.693413Z","end":"2026-05-07T03:20:33.315235Z","steps":["trace[1630630893] 'process raft request' (duration: 1.621126937s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:33.315286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.538542171s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T03:20:33.315335Z","caller":"traceutil/trace.go:171","msg":"trace[1210015751] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:652; }","duration":"1.538649363s","start":"2026-05-07T03:20:31.776673Z","end":"2026-05-07T03:20:33.315322Z","steps":["trace[1210015751] 'agreement among raft nodes before linearized reading' (duration: 1.538561031s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:33.315363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:31.693382Z","time spent":"1.621910639s","remote":"127.0.0.1:60828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:33.315604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"862.956629ms","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-05-07T03:20:33.315374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:31.776648Z","time spent":"1.538714663s","remote":"127.0.0.1:60722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-07T03:20:33.315671Z","caller":"traceutil/trace.go:171","msg":"trace[704534944] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:652; }","duration":"863.04538ms","start":"2026-05-07T03:20:32.452594Z","end":"2026-05-07T03:20:33.315639Z","steps":["trace[704534944] 'agreement among raft nodes before linearized reading' (duration: 862.909328ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:33.315716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:32.452573Z","time spent":"863.132732ms","remote":"127.0.0.1:32772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-07T03:20:33.315683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"996.239508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-nm7n7\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-05-07T03:20:33.31573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.205502ms","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-05-07T03:20:33.315799Z","caller":"traceutil/trace.go:171","msg":"trace[1504772461] range","detail":"{range_begin:/registry/pods/kube-system/cilium-nm7n7; range_end:; response_count:1; response_revision:652; }","duration":"996.417371ms","start":"2026-05-07T03:20:32.319354Z","end":"2026-05-07T03:20:33.315771Z","steps":["trace[1504772461] 'agreement among raft nodes before linearized reading' (duration: 996.053115ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:33.31618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:32.319334Z","time spent":"996.828708ms","remote":"127.0.0.1:60936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-nm7n7\" "} {"level":"info","ts":"2026-05-07T03:20:33.31762Z","caller":"traceutil/trace.go:171","msg":"trace[535741492] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:652; }","duration":"143.66391ms","start":"2026-05-07T03:20:33.172445Z","end":"2026-05-07T03:20:33.316109Z","steps":["trace[535741492] 'agreement among raft nodes before linearized reading' (duration: 143.04708ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:33.829771Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744509316007513,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-07T03:20:34.203868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.426184ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T03:20:34.204665Z","caller":"traceutil/trace.go:171","msg":"trace[1302143036] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"884.185354ms","start":"2026-05-07T03:20:33.320442Z","end":"2026-05-07T03:20:34.204628Z","steps":["trace[1302143036] 'process raft request' (duration: 745.888775ms)","trace[1302143036] 'compare' (duration: 137.263892ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:20:34.204825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:33.320412Z","time spent":"884.324877ms","remote":"127.0.0.1:32772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:34.546739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.483885ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T03:20:34.547017Z","caller":"traceutil/trace.go:171","msg":"trace[1808233902] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"1.224149565s","start":"2026-05-07T03:20:33.322838Z","end":"2026-05-07T03:20:34.546988Z","steps":["trace[1808233902] 'process raft request' (duration: 1.021313444s)","trace[1808233902] 'compare' (duration: 202.247441ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:34.547134Z","caller":"traceutil/trace.go:171","msg":"trace[715346537] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"1.219534019s","start":"2026-05-07T03:20:33.327567Z","end":"2026-05-07T03:20:34.547101Z","steps":["trace[715346537] 'process raft request' (duration: 1.219440667s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:34.547208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:33.32281Z","time spent":"1.224297838s","remote":"127.0.0.1:32772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:34.547332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:33.327558Z","time spent":"1.219660841s","remote":"127.0.0.1:32772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:20:34.547364Z","caller":"traceutil/trace.go:171","msg":"trace[1561779438] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"1.171390888s","start":"2026-05-07T03:20:33.375955Z","end":"2026-05-07T03:20:34.547346Z","steps":["trace[1561779438] 'process raft request' (duration: 1.171276916s)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:34.547362Z","caller":"traceutil/trace.go:171","msg":"trace[712221585] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:679; }","duration":"1.218068644s","start":"2026-05-07T03:20:33.329264Z","end":"2026-05-07T03:20:34.547333Z","steps":["trace[712221585] 'read index received' (duration: 737.038017ms)","trace[712221585] 'applied index is now lower than readState.Index' (duration: 481.029637ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:20:34.547412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:33.375929Z","time spent":"1.171461289s","remote":"127.0.0.1:60972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T03:20:34.547134Z","caller":"traceutil/trace.go:171","msg":"trace[332728261] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"1.223647107s","start":"2026-05-07T03:20:33.323456Z","end":"2026-05-07T03:20:34.547103Z","steps":["trace[332728261] 'process raft request' (duration: 1.223468194s)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:34.547361Z","caller":"traceutil/trace.go:171","msg":"trace[669060346] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"1.210841394s","start":"2026-05-07T03:20:33.336494Z","end":"2026-05-07T03:20:34.547335Z","steps":["trace[669060346] 'process raft request' (duration: 1.210551909s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:34.547568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.218279718s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T03:20:34.547566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:33.323435Z","time spent":"1.224019333s","remote":"127.0.0.1:32772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:20:34.547611Z","caller":"traceutil/trace.go:171","msg":"trace[121488261] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:658; }","duration":"1.218364789s","start":"2026-05-07T03:20:33.329234Z","end":"2026-05-07T03:20:34.547599Z","steps":["trace[121488261] 'agreement among raft nodes before linearized reading' (duration: 1.218201937s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:34.547649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:33.329221Z","time spent":"1.21842147s","remote":"127.0.0.1:60708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-07T03:20:34.547635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:33.336474Z","time spent":"1.211057798s","remote":"127.0.0.1:60936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:35.8563Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.291521001s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-07T03:20:36.922202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.064857434s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-07T03:20:36.922319Z","caller":"traceutil/trace.go:171","msg":"trace[1300200122] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"2.357623648s","start":"2026-05-07T03:20:34.564677Z","end":"2026-05-07T03:20:36.9223Z","steps":["trace[1300200122] 'process raft request' (duration: 1.291905558s)","trace[1300200122] 'compare' (duration: 1.064629641s)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:20:36.92238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:34.564657Z","time spent":"2.357691839s","remote":"127.0.0.1:60936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-07T03:20:37.035552Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.179051317s","expected-duration":"1s"} {"level":"info","ts":"2026-05-07T03:20:37.036975Z","caller":"traceutil/trace.go:171","msg":"trace[1325502957] linearizableReadLoop","detail":"{readStateIndex:687; appliedIndex:685; }","duration":"1.261736849s","start":"2026-05-07T03:20:35.775217Z","end":"2026-05-07T03:20:37.036954Z","steps":["trace[1325502957] 'read index received' (duration: 81.371328ms)","trace[1325502957] 'applied index is now lower than readState.Index' (duration: 1.180364591s)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:37.037071Z","caller":"traceutil/trace.go:171","msg":"trace[252420232] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"2.161122016s","start":"2026-05-07T03:20:34.875919Z","end":"2026-05-07T03:20:37.037041Z","steps":["trace[252420232] 'process raft request' (duration: 2.159842463s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:37.03713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.261889862s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T03:20:37.037163Z","caller":"traceutil/trace.go:171","msg":"trace[1295441944] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:660; }","duration":"1.261969344s","start":"2026-05-07T03:20:35.775184Z","end":"2026-05-07T03:20:37.037153Z","steps":["trace[1295441944] 'agreement among raft nodes before linearized reading' (duration: 1.261876642s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:37.037207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:35.775169Z","time spent":"1.262028754s","remote":"127.0.0.1:60708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-07T03:20:37.037218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:34.875891Z","time spent":"2.161250808s","remote":"127.0.0.1:32772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:20:37.074444Z","caller":"traceutil/trace.go:171","msg":"trace[442908329] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"147.997964ms","start":"2026-05-07T03:20:36.926426Z","end":"2026-05-07T03:20:37.074424Z","steps":["trace[442908329] 'process raft request' (duration: 147.560236ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:37.074479Z","caller":"traceutil/trace.go:171","msg":"trace[1106573944] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"147.717599ms","start":"2026-05-07T03:20:36.926737Z","end":"2026-05-07T03:20:37.074455Z","steps":["trace[1106573944] 'process raft request' (duration: 147.596887ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:37.074548Z","caller":"traceutil/trace.go:171","msg":"trace[370739262] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"146.189042ms","start":"2026-05-07T03:20:36.928342Z","end":"2026-05-07T03:20:37.074531Z","steps":["trace[370739262] 'process raft request' (duration: 146.02845ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:37.074549Z","caller":"traceutil/trace.go:171","msg":"trace[1377209104] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"145.800265ms","start":"2026-05-07T03:20:36.928725Z","end":"2026-05-07T03:20:37.074525Z","steps":["trace[1377209104] 'process raft request' (duration: 145.701524ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:37.074769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.569514ms","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-05-07T03:20:37.074815Z","caller":"traceutil/trace.go:171","msg":"trace[99873450] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:664; }","duration":"522.670466ms","start":"2026-05-07T03:20:36.552133Z","end":"2026-05-07T03:20:37.074803Z","steps":["trace[99873450] 'agreement among raft nodes before linearized reading' (duration: 522.528634ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:37.074844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:36.552106Z","time spent":"522.730207ms","remote":"127.0.0.1:32772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-07T03:20:37.074921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"866.54552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-07T03:20:37.074915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.171178ms","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-05-07T03:20:37.074959Z","caller":"traceutil/trace.go:171","msg":"trace[1338096949] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:664; }","duration":"866.628642ms","start":"2026-05-07T03:20:36.20832Z","end":"2026-05-07T03:20:37.074949Z","steps":["trace[1338096949] 'agreement among raft nodes before linearized reading' (duration: 866.53228ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:37.074982Z","caller":"traceutil/trace.go:171","msg":"trace[898109159] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:664; }","duration":"522.272529ms","start":"2026-05-07T03:20:36.552695Z","end":"2026-05-07T03:20:37.074968Z","steps":["trace[898109159] 'agreement among raft nodes before linearized reading' (duration: 522.053595ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:37.075031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:36.552686Z","time spent":"522.33867ms","remote":"127.0.0.1:32772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-07T03:20:37.074866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.794718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-07T03:20:37.074988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:36.2083Z","time spent":"866.679682ms","remote":"127.0.0.1:32772","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-05-07T03:20:37.075108Z","caller":"traceutil/trace.go:171","msg":"trace[800200310] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:664; }","duration":"523.068473ms","start":"2026-05-07T03:20:36.55202Z","end":"2026-05-07T03:20:37.075088Z","steps":["trace[800200310] 'agreement among raft nodes before linearized reading' (duration: 522.743868ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:37.075298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:36.551999Z","time spent":"523.279767ms","remote":"127.0.0.1:32772","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":"info","ts":"2026-05-07T03:20:37.541236Z","caller":"traceutil/trace.go:171","msg":"trace[60380941] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"207.892905ms","start":"2026-05-07T03:20:37.333319Z","end":"2026-05-07T03:20:37.541212Z","steps":["trace[60380941] 'process raft request' (duration: 207.724682ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:37.609146Z","caller":"traceutil/trace.go:171","msg":"trace[198662054] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"264.878426ms","start":"2026-05-07T03:20:37.344249Z","end":"2026-05-07T03:20:37.609127Z","steps":["trace[198662054] 'process raft request' (duration: 264.738793ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:38.373286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.756276ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"warn","ts":"2026-05-07T03:20:40.955898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.984082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T03:20:40.955976Z","caller":"traceutil/trace.go:171","msg":"trace[1837074042] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:683; }","duration":"179.110284ms","start":"2026-05-07T03:20:40.776849Z","end":"2026-05-07T03:20:40.955959Z","steps":["trace[1837074042] 'range keys from in-memory index tree' (duration: 178.8626ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:55.023234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.199805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T03:20:55.023301Z","caller":"traceutil/trace.go:171","msg":"trace[706518827] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:821; }","duration":"247.308377ms","start":"2026-05-07T03:20:54.775977Z","end":"2026-05-07T03:20:55.023285Z","steps":["trace[706518827] 'range keys from in-memory index tree' (duration: 247.142754ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:55.023365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.52976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T03:20:55.023444Z","caller":"traceutil/trace.go:171","msg":"trace[1316661195] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:821; }","duration":"521.640162ms","start":"2026-05-07T03:20:54.501785Z","end":"2026-05-07T03:20:55.023425Z","steps":["trace[1316661195] 'count revisions from in-memory index tree' (duration: 521.441749ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:55.02349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:54.501732Z","time spent":"521.744926ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-05-07T03:20:55.024196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.643738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-mcmkl\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-07T03:20:55.024246Z","caller":"traceutil/trace.go:171","msg":"trace[1943138815] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-mcmkl; range_end:; response_count:1; response_revision:821; }","duration":"596.72932ms","start":"2026-05-07T03:20:54.427504Z","end":"2026-05-07T03:20:55.024234Z","steps":["trace[1943138815] 'range keys from in-memory index tree' (duration: 596.502675ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:55.024276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:54.427487Z","time spent":"596.782171ms","remote":"127.0.0.1:60936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-mcmkl\" "} {"level":"warn","ts":"2026-05-07T03:20:55.614446Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744509316007943,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-07T03:20:56.115414Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744509316007943,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-07T03:20:56.543532Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.51055316s","expected-duration":"1s"} {"level":"info","ts":"2026-05-07T03:20:56.543884Z","caller":"traceutil/trace.go:171","msg":"trace[2030405974] linearizableReadLoop","detail":"{readStateIndex:855; appliedIndex:854; }","duration":"1.429610268s","start":"2026-05-07T03:20:55.114249Z","end":"2026-05-07T03:20:56.543859Z","steps":["trace[2030405974] 'read index received' (duration: 1.429472745s)","trace[2030405974] 'applied index is now lower than readState.Index' (duration: 136.493µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:56.543948Z","caller":"traceutil/trace.go:171","msg":"trace[1521230088] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"1.511020829s","start":"2026-05-07T03:20:55.032896Z","end":"2026-05-07T03:20:56.543917Z","steps":["trace[1521230088] 'process raft request' (duration: 1.510814065s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:56.544169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.429869884s","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":"warn","ts":"2026-05-07T03:20:56.544189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:55.032883Z","time spent":"1.511187354s","remote":"127.0.0.1:60936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:20:56.544298Z","caller":"traceutil/trace.go:171","msg":"trace[1978226659] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:822; }","duration":"1.430069578s","start":"2026-05-07T03:20:55.114206Z","end":"2026-05-07T03:20:56.544275Z","steps":["trace[1978226659] 'agreement among raft nodes before linearized reading' (duration: 1.429781032s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:56.544532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:55.114186Z","time spent":"1.430302093s","remote":"127.0.0.1:32772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-07T03:20:57.093469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.683465ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-07T03:20:57.093686Z","caller":"traceutil/trace.go:171","msg":"trace[213289989] linearizableReadLoop","detail":"{readStateIndex:856; appliedIndex:855; }","duration":"549.717973ms","start":"2026-05-07T03:20:56.543947Z","end":"2026-05-07T03:20:57.093665Z","steps":["trace[213289989] 'read index received' (duration: 296.841153ms)","trace[213289989] 'applied index is now lower than readState.Index' (duration: 252.87346ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:20:57.093868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.800936908s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-07T03:20:57.093915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.801851968s","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-05-07T03:20:57.093948Z","caller":"traceutil/trace.go:171","msg":"trace[1295945569] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:822; }","duration":"1.801914179s","start":"2026-05-07T03:20:55.292023Z","end":"2026-05-07T03:20:57.093938Z","steps":["trace[1295945569] 'agreement among raft nodes before linearized reading' (duration: 1.801738525s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:57.094005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:55.292014Z","time spent":"1.801982571s","remote":"127.0.0.1:32772","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-05-07T03:20:57.094036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.800822025s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-07T03:20:57.094011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.806318096s","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-05-07T03:20:57.094011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.317795286s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T03:20:57.094118Z","caller":"traceutil/trace.go:171","msg":"trace[1085339560] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:822; }","duration":"1.80647416s","start":"2026-05-07T03:20:55.287614Z","end":"2026-05-07T03:20:57.094088Z","steps":["trace[1085339560] 'agreement among raft nodes before linearized reading' (duration: 1.806208044s)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:57.094145Z","caller":"traceutil/trace.go:171","msg":"trace[998192314] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:822; }","duration":"1.31797818s","start":"2026-05-07T03:20:55.776144Z","end":"2026-05-07T03:20:57.094122Z","steps":["trace[998192314] 'agreement among raft nodes before linearized reading' (duration: 1.317766656s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:57.0942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:55.287595Z","time spent":"1.806588342s","remote":"127.0.0.1:32772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-07T03:20:57.094219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:55.776123Z","time spent":"1.318085162s","remote":"127.0.0.1:60708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-07T03:20:57.094835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.425093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-gswvm\" ","response":"range_response_count:1 size:5050"} {"level":"info","ts":"2026-05-07T03:20:57.094086Z","caller":"traceutil/trace.go:171","msg":"trace[1526454389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:822; }","duration":"1.800879547s","start":"2026-05-07T03:20:55.29319Z","end":"2026-05-07T03:20:57.09407Z","steps":["trace[1526454389] 'agreement among raft nodes before linearized reading' (duration: 1.800781055s)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:57.094885Z","caller":"traceutil/trace.go:171","msg":"trace[1706510558] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-gswvm; range_end:; response_count:1; response_revision:823; }","duration":"547.509145ms","start":"2026-05-07T03:20:56.547364Z","end":"2026-05-07T03:20:57.094873Z","steps":["trace[1706510558] 'agreement among raft nodes before linearized reading' (duration: 547.379282ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:57.094919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:56.547347Z","time spent":"547.564646ms","remote":"127.0.0.1:60936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":5072,"request content":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-gswvm\" "} {"level":"warn","ts":"2026-05-07T03:20:57.093926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.80467213s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-07T03:20:57.094909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:55.293184Z","time spent":"1.801707545s","remote":"127.0.0.1:32772","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-05-07T03:20:57.094962Z","caller":"traceutil/trace.go:171","msg":"trace[301118072] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:822; }","duration":"1.805753104s","start":"2026-05-07T03:20:55.289196Z","end":"2026-05-07T03:20:57.094949Z","steps":["trace[301118072] 'agreement among raft nodes before linearized reading' (duration: 1.804639589s)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:57.094952Z","caller":"traceutil/trace.go:171","msg":"trace[1121760686] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"544.893517ms","start":"2026-05-07T03:20:56.55004Z","end":"2026-05-07T03:20:57.094933Z","steps":["trace[1121760686] 'process raft request' (duration: 544.309524ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:57.094995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:55.289187Z","time spent":"1.805795474s","remote":"127.0.0.1:32934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-05-07T03:20:57.093944Z","caller":"traceutil/trace.go:171","msg":"trace[1674194681] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:822; }","duration":"1.801054241s","start":"2026-05-07T03:20:55.292871Z","end":"2026-05-07T03:20:57.093925Z","steps":["trace[1674194681] 'agreement among raft nodes before linearized reading' (duration: 1.800858017s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:57.095077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:56.550027Z","time spent":"544.968109ms","remote":"127.0.0.1:32772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T03:20:57.095089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:20:55.292852Z","time spent":"1.802227357s","remote":"127.0.0.1:32772","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":"info","ts":"2026-05-07T03:20:57.213792Z","caller":"traceutil/trace.go:171","msg":"trace[57924717] transaction","detail":"{read_only:false; response_revision:825; number_of_response:1; }","duration":"110.642934ms","start":"2026-05-07T03:20:57.103122Z","end":"2026-05-07T03:20:57.213765Z","steps":["trace[57924717] 'process raft request' (duration: 90.755221ms)","trace[57924717] 'compare' (duration: 19.73569ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:57.214018Z","caller":"traceutil/trace.go:171","msg":"trace[1519149985] transaction","detail":"{read_only:false; response_revision:826; number_of_response:1; }","duration":"110.85319ms","start":"2026-05-07T03:20:57.103154Z","end":"2026-05-07T03:20:57.214007Z","steps":["trace[1519149985] 'process raft request' (duration: 110.568213ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:57.214317Z","caller":"traceutil/trace.go:171","msg":"trace[308812752] linearizableReadLoop","detail":"{readStateIndex:862; appliedIndex:858; }","duration":"107.407132ms","start":"2026-05-07T03:20:57.106893Z","end":"2026-05-07T03:20:57.2143Z","steps":["trace[308812752] 'read index received' (duration: 24.583917ms)","trace[308812752] 'applied index is now lower than readState.Index' (duration: 82.822345ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:20:57.214361Z","caller":"traceutil/trace.go:171","msg":"trace[1636588299] transaction","detail":"{read_only:false; response_revision:827; number_of_response:1; }","duration":"111.145326ms","start":"2026-05-07T03:20:57.103204Z","end":"2026-05-07T03:20:57.214349Z","steps":["trace[1636588299] 'process raft request' (duration: 110.762168ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:20:57.214402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.493254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T03:20:57.21443Z","caller":"traceutil/trace.go:171","msg":"trace[654669906] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:828; }","duration":"107.549266ms","start":"2026-05-07T03:20:57.106872Z","end":"2026-05-07T03:20:57.214421Z","steps":["trace[654669906] 'agreement among raft nodes before linearized reading' (duration: 107.496755ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:20:57.214374Z","caller":"traceutil/trace.go:171","msg":"trace[327639178] transaction","detail":"{read_only:false; response_revision:828; number_of_response:1; }","duration":"108.885985ms","start":"2026-05-07T03:20:57.10546Z","end":"2026-05-07T03:20:57.214346Z","steps":["trace[327639178] 'process raft request' (duration: 108.701711ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:00.654206Z","caller":"traceutil/trace.go:171","msg":"trace[1756199798] transaction","detail":"{read_only:false; response_revision:842; number_of_response:1; }","duration":"186.588481ms","start":"2026-05-07T03:21:00.467598Z","end":"2026-05-07T03:21:00.654187Z","steps":["trace[1756199798] 'process raft request' (duration: 186.447678ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:02.781442Z","caller":"traceutil/trace.go:171","msg":"trace[1503100903] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"137.490909ms","start":"2026-05-07T03:21:02.643922Z","end":"2026-05-07T03:21:02.781413Z","steps":["trace[1503100903] 'process raft request' (duration: 137.310375ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:03.344855Z","caller":"traceutil/trace.go:171","msg":"trace[1908907731] linearizableReadLoop","detail":"{readStateIndex:927; appliedIndex:926; }","duration":"141.051788ms","start":"2026-05-07T03:21:03.203782Z","end":"2026-05-07T03:21:03.344833Z","steps":["trace[1908907731] 'read index received' (duration: 140.922955ms)","trace[1908907731] 'applied index is now lower than readState.Index' (duration: 127.963µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:21:03.344921Z","caller":"traceutil/trace.go:171","msg":"trace[1869020305] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"203.256012ms","start":"2026-05-07T03:21:03.141633Z","end":"2026-05-07T03:21:03.344889Z","steps":["trace[1869020305] 'process raft request' (duration: 203.042427ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:21:03.345102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.298384ms","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-05-07T03:21:03.345151Z","caller":"traceutil/trace.go:171","msg":"trace[819683914] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:892; }","duration":"141.390265ms","start":"2026-05-07T03:21:03.203751Z","end":"2026-05-07T03:21:03.345141Z","steps":["trace[819683914] 'agreement among raft nodes before linearized reading' (duration: 141.216801ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:03.47034Z","caller":"traceutil/trace.go:171","msg":"trace[2053711534] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"121.267206ms","start":"2026-05-07T03:21:03.349051Z","end":"2026-05-07T03:21:03.470318Z","steps":["trace[2053711534] 'process raft request' (duration: 79.675694ms)","trace[2053711534] 'compare' (duration: 41.417208ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:21:03.470531Z","caller":"traceutil/trace.go:171","msg":"trace[140563193] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"120.141789ms","start":"2026-05-07T03:21:03.350365Z","end":"2026-05-07T03:21:03.470507Z","steps":["trace[140563193] 'process raft request' (duration: 120.094038ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:03.470714Z","caller":"traceutil/trace.go:171","msg":"trace[1081590695] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"120.699372ms","start":"2026-05-07T03:21:03.350005Z","end":"2026-05-07T03:21:03.470704Z","steps":["trace[1081590695] 'process raft request' (duration: 120.412305ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:03.470722Z","caller":"traceutil/trace.go:171","msg":"trace[1721412756] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"121.399869ms","start":"2026-05-07T03:21:03.349301Z","end":"2026-05-07T03:21:03.470701Z","steps":["trace[1721412756] 'process raft request' (duration: 120.991829ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:05.327772Z","caller":"traceutil/trace.go:171","msg":"trace[986703283] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"177.076972ms","start":"2026-05-07T03:21:05.150668Z","end":"2026-05-07T03:21:05.327745Z","steps":["trace[986703283] 'process raft request' (duration: 176.794785ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:21:06.248525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.382824ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-07T03:21:11.003219Z","caller":"traceutil/trace.go:171","msg":"trace[1550417260] linearizableReadLoop","detail":"{readStateIndex:1021; appliedIndex:1020; }","duration":"167.293387ms","start":"2026-05-07T03:21:10.835903Z","end":"2026-05-07T03:21:11.003196Z","steps":["trace[1550417260] 'read index received' (duration: 167.095142ms)","trace[1550417260] 'applied index is now lower than readState.Index' (duration: 196.945µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:21:11.003347Z","caller":"traceutil/trace.go:171","msg":"trace[367414825] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"172.856073ms","start":"2026-05-07T03:21:10.830446Z","end":"2026-05-07T03:21:11.003302Z","steps":["trace[367414825] 'process raft request' (duration: 172.587807ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:21:11.003471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.554963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/kube-system/coredns-7c96b6546b-gswvm\" ","response":"range_response_count:1 size:2275"} {"level":"info","ts":"2026-05-07T03:21:11.00351Z","caller":"traceutil/trace.go:171","msg":"trace[740823735] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/kube-system/coredns-7c96b6546b-gswvm; range_end:; response_count:1; response_revision:985; }","duration":"167.653055ms","start":"2026-05-07T03:21:10.835846Z","end":"2026-05-07T03:21:11.003499Z","steps":["trace[740823735] 'agreement among raft nodes before linearized reading' (duration: 167.488951ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:21:11.249818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.936757ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-07T03:21:11.249986Z","caller":"traceutil/trace.go:171","msg":"trace[1081912442] transaction","detail":"{read_only:false; number_of_response:1; response_revision:986; }","duration":"243.674899ms","start":"2026-05-07T03:21:11.006285Z","end":"2026-05-07T03:21:11.24996Z","steps":["trace[1081912442] 'process raft request' (duration: 103.358623ms)","trace[1081912442] 'compare' (duration: 139.769823ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:21:11.476498Z","caller":"traceutil/trace.go:171","msg":"trace[34405007] linearizableReadLoop","detail":"{readStateIndex:1023; appliedIndex:1021; }","duration":"425.295665ms","start":"2026-05-07T03:21:11.051177Z","end":"2026-05-07T03:21:11.476472Z","steps":["trace[34405007] 'read index received' (duration: 58.412503ms)","trace[34405007] 'applied index is now lower than readState.Index' (duration: 366.882042ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:21:11.47667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.20418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-07T03:21:11.47671Z","caller":"traceutil/trace.go:171","msg":"trace[1642244433] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:987; }","duration":"403.270792ms","start":"2026-05-07T03:21:11.073428Z","end":"2026-05-07T03:21:11.476699Z","steps":["trace[1642244433] 'agreement among raft nodes before linearized reading' (duration: 403.179039ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:21:11.476755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:21:11.073375Z","time spent":"403.368694ms","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":29,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-05-07T03:21:11.476764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.572163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.162\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-07T03:21:11.476838Z","caller":"traceutil/trace.go:171","msg":"trace[1725560758] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:987; }","duration":"425.695876ms","start":"2026-05-07T03:21:11.051125Z","end":"2026-05-07T03:21:11.476821Z","steps":["trace[1725560758] 'agreement among raft nodes before linearized reading' (duration: 425.47893ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:21:11.476882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:21:11.051105Z","time spent":"425.768537ms","remote":"127.0.0.1:60756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.162\" "} {"level":"info","ts":"2026-05-07T03:21:11.477255Z","caller":"traceutil/trace.go:171","msg":"trace[1589767076] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"465.678673ms","start":"2026-05-07T03:21:11.010913Z","end":"2026-05-07T03:21:11.476592Z","steps":["trace[1589767076] 'process raft request' (duration: 452.930168ms)","trace[1589767076] 'compare' (duration: 12.53526ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:21:11.477397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T03:21:11.010893Z","time spent":"466.429861ms","remote":"127.0.0.1:60936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5057,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T03:21:11.714228Z","caller":"traceutil/trace.go:171","msg":"trace[42332338] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"232.404281ms","start":"2026-05-07T03:21:11.481797Z","end":"2026-05-07T03:21:11.714202Z","steps":["trace[42332338] 'process raft request' (duration: 232.129004ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:11.714255Z","caller":"traceutil/trace.go:171","msg":"trace[103476014] linearizableReadLoop","detail":"{readStateIndex:1027; appliedIndex:1026; }","duration":"164.051902ms","start":"2026-05-07T03:21:11.55018Z","end":"2026-05-07T03:21:11.714232Z","steps":["trace[103476014] 'read index received' (duration: 163.998131ms)","trace[103476014] 'applied index is now lower than readState.Index' (duration: 52.731µs)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:21:11.714562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.130367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-07T03:21:11.714598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.308569ms","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-05-07T03:21:11.714631Z","caller":"traceutil/trace.go:171","msg":"trace[1869392889] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:990; }","duration":"207.24961ms","start":"2026-05-07T03:21:11.507366Z","end":"2026-05-07T03:21:11.714616Z","steps":["trace[1869392889] 'agreement among raft nodes before linearized reading' (duration: 207.081426ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:21:11.714651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.866479ms","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-05-07T03:21:11.714677Z","caller":"traceutil/trace.go:171","msg":"trace[608345539] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"232.851572ms","start":"2026-05-07T03:21:11.481813Z","end":"2026-05-07T03:21:11.714664Z","steps":["trace[608345539] 'process raft request' (duration: 232.268668ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:11.7147Z","caller":"traceutil/trace.go:171","msg":"trace[1946392905] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"207.430374ms","start":"2026-05-07T03:21:11.507262Z","end":"2026-05-07T03:21:11.714692Z","steps":["trace[1946392905] 'process raft request' (duration: 206.894821ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:11.714704Z","caller":"traceutil/trace.go:171","msg":"trace[1464122885] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:990; }","duration":"212.963611ms","start":"2026-05-07T03:21:11.501726Z","end":"2026-05-07T03:21:11.71469Z","steps":["trace[1464122885] 'agreement among raft nodes before linearized reading' (duration: 212.795617ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:11.714664Z","caller":"traceutil/trace.go:171","msg":"trace[2146065209] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:990; }","duration":"183.447072ms","start":"2026-05-07T03:21:11.531201Z","end":"2026-05-07T03:21:11.714648Z","steps":["trace[2146065209] 'agreement among raft nodes before linearized reading' (duration: 183.214826ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:11.726747Z","caller":"traceutil/trace.go:171","msg":"trace[1563369237] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"175.724361ms","start":"2026-05-07T03:21:11.551009Z","end":"2026-05-07T03:21:11.726733Z","steps":["trace[1563369237] 'process raft request' (duration: 175.477695ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:21:11.72684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.191905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-07T03:21:11.726906Z","caller":"traceutil/trace.go:171","msg":"trace[1930593068] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"167.60041ms","start":"2026-05-07T03:21:11.559294Z","end":"2026-05-07T03:21:11.726894Z","steps":["trace[1930593068] 'process raft request' (duration: 167.325373ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:11.726912Z","caller":"traceutil/trace.go:171","msg":"trace[1741575260] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:992; }","duration":"168.300267ms","start":"2026-05-07T03:21:11.558597Z","end":"2026-05-07T03:21:11.726898Z","steps":["trace[1741575260] 'agreement among raft nodes before linearized reading' (duration: 168.071252ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:11.9442Z","caller":"traceutil/trace.go:171","msg":"trace[1276263092] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"214.201111ms","start":"2026-05-07T03:21:11.729976Z","end":"2026-05-07T03:21:11.944177Z","steps":["trace[1276263092] 'process raft request' (duration: 214.040607ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:11.944258Z","caller":"traceutil/trace.go:171","msg":"trace[987818974] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"213.004552ms","start":"2026-05-07T03:21:11.731225Z","end":"2026-05-07T03:21:11.94423Z","steps":["trace[987818974] 'process raft request' (duration: 212.93086ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:11.944624Z","caller":"traceutil/trace.go:171","msg":"trace[1714654856] linearizableReadLoop","detail":"{readStateIndex:1036; appliedIndex:1032; }","duration":"143.449454ms","start":"2026-05-07T03:21:11.801154Z","end":"2026-05-07T03:21:11.944603Z","steps":["trace[1714654856] 'read index received' (duration: 142.862139ms)","trace[1714654856] 'applied index is now lower than readState.Index' (duration: 586.385µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:21:11.944843Z","caller":"traceutil/trace.go:171","msg":"trace[35438872] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"212.322515ms","start":"2026-05-07T03:21:11.73251Z","end":"2026-05-07T03:21:11.944832Z","steps":["trace[35438872] 'process raft request' (duration: 211.674439ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:21:11.944848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.008813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-07T03:21:11.944884Z","caller":"traceutil/trace.go:171","msg":"trace[1345928698] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:999; }","duration":"141.059775ms","start":"2026-05-07T03:21:11.803815Z","end":"2026-05-07T03:21:11.944875Z","steps":["trace[1345928698] 'agreement among raft nodes before linearized reading' (duration: 140.923821ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:21:11.944928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.573335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-gswvm\" ","response":"range_response_count:1 size:5072"} {"level":"info","ts":"2026-05-07T03:21:11.944997Z","caller":"traceutil/trace.go:171","msg":"trace[209939353] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-gswvm; range_end:; response_count:1; response_revision:999; }","duration":"215.715798ms","start":"2026-05-07T03:21:11.729266Z","end":"2026-05-07T03:21:11.944982Z","steps":["trace[209939353] 'agreement among raft nodes before linearized reading' (duration: 215.464032ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:11.945081Z","caller":"traceutil/trace.go:171","msg":"trace[1635827162] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"213.999727ms","start":"2026-05-07T03:21:11.731071Z","end":"2026-05-07T03:21:11.945071Z","steps":["trace[1635827162] 'process raft request' (duration: 213.047453ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:12.112216Z","caller":"traceutil/trace.go:171","msg":"trace[573258246] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"159.813704ms","start":"2026-05-07T03:21:11.95238Z","end":"2026-05-07T03:21:12.112194Z","steps":["trace[573258246] 'process raft request' (duration: 159.673951ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:14.063085Z","caller":"traceutil/trace.go:171","msg":"trace[1608520209] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"253.259832ms","start":"2026-05-07T03:21:13.809791Z","end":"2026-05-07T03:21:14.063051Z","steps":["trace[1608520209] 'process raft request' (duration: 204.27475ms)","trace[1608520209] 'compare' (duration: 48.753836ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:21:14.063233Z","caller":"traceutil/trace.go:171","msg":"trace[141502731] linearizableReadLoop","detail":"{readStateIndex:1051; appliedIndex:1049; }","duration":"115.416576ms","start":"2026-05-07T03:21:13.947785Z","end":"2026-05-07T03:21:14.063201Z","steps":["trace[141502731] 'read index received' (duration: 66.2926ms)","trace[141502731] 'applied index is now lower than readState.Index' (duration: 49.122596ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:21:14.063474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.676312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-07T03:21:14.063513Z","caller":"traceutil/trace.go:171","msg":"trace[1765374560] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1013; }","duration":"115.767204ms","start":"2026-05-07T03:21:13.947736Z","end":"2026-05-07T03:21:14.063503Z","steps":["trace[1765374560] 'agreement among raft nodes before linearized reading' (duration: 115.575749ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:14.063637Z","caller":"traceutil/trace.go:171","msg":"trace[1254070429] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"253.617021ms","start":"2026-05-07T03:21:13.810008Z","end":"2026-05-07T03:21:14.063625Z","steps":["trace[1254070429] 'process raft request' (duration: 252.994916ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:17.870581Z","caller":"traceutil/trace.go:171","msg":"trace[1744023157] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"130.082938ms","start":"2026-05-07T03:21:17.740468Z","end":"2026-05-07T03:21:17.870551Z","steps":["trace[1744023157] 'process raft request' (duration: 129.925134ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:28.316981Z","caller":"traceutil/trace.go:171","msg":"trace[1854894315] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"114.621117ms","start":"2026-05-07T03:21:28.202328Z","end":"2026-05-07T03:21:28.316949Z","steps":["trace[1854894315] 'process raft request' (duration: 91.952984ms)","trace[1854894315] 'compare' (duration: 22.55715ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:21:28.331843Z","caller":"traceutil/trace.go:171","msg":"trace[911055377] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"126.747924ms","start":"2026-05-07T03:21:28.205064Z","end":"2026-05-07T03:21:28.331812Z","steps":["trace[911055377] 'process raft request' (duration: 126.59381ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:28.33234Z","caller":"traceutil/trace.go:171","msg":"trace[2139988224] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"126.332133ms","start":"2026-05-07T03:21:28.205847Z","end":"2026-05-07T03:21:28.332179Z","steps":["trace[2139988224] 'process raft request' (duration: 125.931303ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:32.141525Z","caller":"traceutil/trace.go:171","msg":"trace[1302266639] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"139.02133ms","start":"2026-05-07T03:21:32.002476Z","end":"2026-05-07T03:21:32.141497Z","steps":["trace[1302266639] 'process raft request' (duration: 138.731452ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:32.211579Z","caller":"traceutil/trace.go:171","msg":"trace[1565969494] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"160.501239ms","start":"2026-05-07T03:21:32.051052Z","end":"2026-05-07T03:21:32.211553Z","steps":["trace[1565969494] 'process raft request' (duration: 135.650427ms)","trace[1565969494] 'compare' (duration: 24.378959ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:21:32.579431Z","caller":"traceutil/trace.go:171","msg":"trace[1976237808] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"189.205218ms","start":"2026-05-07T03:21:32.39019Z","end":"2026-05-07T03:21:32.579395Z","steps":["trace[1976237808] 'process raft request' (duration: 189.059834ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:32.579625Z","caller":"traceutil/trace.go:171","msg":"trace[2079392296] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"189.463685ms","start":"2026-05-07T03:21:32.390148Z","end":"2026-05-07T03:21:32.579612Z","steps":["trace[2079392296] 'process raft request' (duration: 188.149619ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:34.769701Z","caller":"traceutil/trace.go:171","msg":"trace[1940405692] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"181.168957ms","start":"2026-05-07T03:21:34.588505Z","end":"2026-05-07T03:21:34.769674Z","steps":["trace[1940405692] 'process raft request' (duration: 177.096884ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:52.495576Z","caller":"traceutil/trace.go:171","msg":"trace[1442172819] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"163.945087ms","start":"2026-05-07T03:21:52.331606Z","end":"2026-05-07T03:21:52.495551Z","steps":["trace[1442172819] 'process raft request' (duration: 163.775082ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:21:52.496304Z","caller":"traceutil/trace.go:171","msg":"trace[41575097] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"160.936319ms","start":"2026-05-07T03:21:52.335348Z","end":"2026-05-07T03:21:52.496284Z","steps":["trace[41575097] 'process raft request' (duration: 160.816655ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:22:22.830759Z","caller":"traceutil/trace.go:171","msg":"trace[1926307080] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"108.600772ms","start":"2026-05-07T03:22:22.722128Z","end":"2026-05-07T03:22:22.830729Z","steps":["trace[1926307080] 'process raft request' (duration: 70.193499ms)","trace[1926307080] 'compare' (duration: 38.153835ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:22:26.882041Z","caller":"traceutil/trace.go:171","msg":"trace[1635115909] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"142.587085ms","start":"2026-05-07T03:22:26.739381Z","end":"2026-05-07T03:22:26.881968Z","steps":["trace[1635115909] 'process raft request' (duration: 142.315556ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:22:30.222045Z","caller":"traceutil/trace.go:171","msg":"trace[1163197417] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"163.207356ms","start":"2026-05-07T03:22:30.058814Z","end":"2026-05-07T03:22:30.222022Z","steps":["trace[1163197417] 'process raft request' (duration: 162.992049ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:22:45.325939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.924225ms","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-05-07T03:22:45.326019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.742757ms","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-05-07T03:22:45.326066Z","caller":"traceutil/trace.go:171","msg":"trace[1702644796] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1344; }","duration":"142.105251ms","start":"2026-05-07T03:22:45.183941Z","end":"2026-05-07T03:22:45.326046Z","steps":["trace[1702644796] 'range keys from in-memory index tree' (duration: 141.770121ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:22:45.326085Z","caller":"traceutil/trace.go:171","msg":"trace[371287509] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1344; }","duration":"218.84827ms","start":"2026-05-07T03:22:45.107221Z","end":"2026-05-07T03:22:45.326069Z","steps":["trace[371287509] 'range keys from in-memory index tree' (duration: 218.611332ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:22:45.326323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.453585ms","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-05-07T03:22:45.326393Z","caller":"traceutil/trace.go:171","msg":"trace[1608716886] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1344; }","duration":"217.551138ms","start":"2026-05-07T03:22:45.108832Z","end":"2026-05-07T03:22:45.326384Z","steps":["trace[1608716886] 'range keys from in-memory index tree' (duration: 217.321931ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:22:45.326472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.620308ms","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-05-07T03:22:45.326521Z","caller":"traceutil/trace.go:171","msg":"trace[1466170412] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1344; }","duration":"164.694701ms","start":"2026-05-07T03:22:45.161811Z","end":"2026-05-07T03:22:45.326506Z","steps":["trace[1466170412] 'range keys from in-memory index tree' (duration: 164.519555ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:22:47.092356Z","caller":"traceutil/trace.go:171","msg":"trace[692065664] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"107.060565ms","start":"2026-05-07T03:22:46.985259Z","end":"2026-05-07T03:22:47.092319Z","steps":["trace[692065664] 'process raft request' (duration: 106.934491ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:22:53.382865Z","caller":"traceutil/trace.go:171","msg":"trace[1337113566] transaction","detail":"{read_only:false; response_revision:1377; number_of_response:1; }","duration":"259.409129ms","start":"2026-05-07T03:22:53.12343Z","end":"2026-05-07T03:22:53.382839Z","steps":["trace[1337113566] 'process raft request' (duration: 259.192012ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:22:53.680684Z","caller":"traceutil/trace.go:171","msg":"trace[1387220258] transaction","detail":"{read_only:false; response_revision:1379; number_of_response:1; }","duration":"232.398838ms","start":"2026-05-07T03:22:53.448257Z","end":"2026-05-07T03:22:53.680656Z","steps":["trace[1387220258] 'process raft request' (duration: 173.914805ms)","trace[1387220258] 'compare' (duration: 58.250506ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T03:22:53.700022Z","caller":"traceutil/trace.go:171","msg":"trace[689977908] transaction","detail":"{read_only:false; response_revision:1381; number_of_response:1; }","duration":"247.258092ms","start":"2026-05-07T03:22:53.452741Z","end":"2026-05-07T03:22:53.7Z","steps":["trace[689977908] 'process raft request' (duration: 247.213341ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:22:53.700219Z","caller":"traceutil/trace.go:171","msg":"trace[916266861] transaction","detail":"{read_only:false; response_revision:1380; number_of_response:1; }","duration":"248.915026ms","start":"2026-05-07T03:22:53.451263Z","end":"2026-05-07T03:22:53.700178Z","steps":["trace[916266861] 'process raft request' (duration: 248.583325ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:22:53.758004Z","caller":"traceutil/trace.go:171","msg":"trace[117878263] transaction","detail":"{read_only:false; response_revision:1382; number_of_response:1; }","duration":"134.271332ms","start":"2026-05-07T03:22:53.623706Z","end":"2026-05-07T03:22:53.757977Z","steps":["trace[117878263] 'process raft request' (duration: 134.122767ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:23:04.5362Z","caller":"traceutil/trace.go:171","msg":"trace[598665871] linearizableReadLoop","detail":"{readStateIndex:1483; appliedIndex:1482; }","duration":"174.379914ms","start":"2026-05-07T03:23:04.361795Z","end":"2026-05-07T03:23:04.536175Z","steps":["trace[598665871] 'read index received' (duration: 174.151006ms)","trace[598665871] 'applied index is now lower than readState.Index' (duration: 227.918µs)"],"step_count":2} {"level":"warn","ts":"2026-05-07T03:23:04.536392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.57779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:daemon-set-controller\" ","response":"range_response_count:1 size:759"} {"level":"info","ts":"2026-05-07T03:23:04.53644Z","caller":"traceutil/trace.go:171","msg":"trace[1718343570] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:daemon-set-controller; range_end:; response_count:1; response_revision:1420; }","duration":"174.670633ms","start":"2026-05-07T03:23:04.361754Z","end":"2026-05-07T03:23:04.536425Z","steps":["trace[1718343570] 'agreement among raft nodes before linearized reading' (duration: 174.56276ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T03:23:04.536638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.963465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:pvc-protection-controller\" ","response":"range_response_count:1 size:728"} {"level":"info","ts":"2026-05-07T03:23:04.53682Z","caller":"traceutil/trace.go:171","msg":"trace[280639360] range","detail":"{range_begin:/registry/clusterroles/system:controller:pvc-protection-controller; range_end:; response_count:1; response_revision:1420; }","duration":"172.209653ms","start":"2026-05-07T03:23:04.364596Z","end":"2026-05-07T03:23:04.536806Z","steps":["trace[280639360] 'agreement among raft nodes before linearized reading' (duration: 171.800689ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T03:23:04.536752Z","caller":"traceutil/trace.go:171","msg":"trace[2084330048] transaction","detail":"{read_only:false; response_revision:1420; number_of_response:1; }","duration":"195.881411ms","start":"2026-05-07T03:23:04.340844Z","end":"2026-05-07T03:23:04.536725Z","steps":["trace[2084330048] 'process raft request' (duration: 195.189818ms)"],"step_count":1}