{"level":"warn","ts":"2026-05-08T19:21:25.170225Z","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-08T19:21:25.170317Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.140: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.140:2380","--initial-cluster=instance=https://199.204.45.140:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.140:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.140: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-08T19:21:25.170387Z","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-08T19:21:25.170395Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.140:2380"]} {"level":"info","ts":"2026-05-08T19:21:25.170415Z","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-08T19:21:25.171009Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"]} {"level":"info","ts":"2026-05-08T19:21:25.171095Z","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.140:2380"],"listen-peer-urls":["https://199.204.45.140:2380"],"advertise-client-urls":["https://199.204.45.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.140: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-08T19:21:25.17598Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.673802ms"} {"level":"info","ts":"2026-05-08T19:21:25.184443Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"35b2766da46a76bb","cluster-id":"f5fd3aeb8d9f53dc"} {"level":"info","ts":"2026-05-08T19:21:25.184556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=()"} {"level":"info","ts":"2026-05-08T19:21:25.184576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became follower at term 0"} {"level":"info","ts":"2026-05-08T19:21:25.18459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 35b2766da46a76bb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-08T19:21:25.1846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became follower at term 1"} {"level":"info","ts":"2026-05-08T19:21:25.184637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=(3869285243146630843)"} {"level":"warn","ts":"2026-05-08T19:21:25.190879Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-08T19:21:25.193253Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-08T19:21:25.194364Z","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-08T19:21:25.197367Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"35b2766da46a76bb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-08T19:21:25.198248Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"35b2766da46a76bb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-08T19:21:25.198498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=(3869285243146630843)"} {"level":"info","ts":"2026-05-08T19:21:25.198587Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f5fd3aeb8d9f53dc","local-member-id":"35b2766da46a76bb","added-peer-id":"35b2766da46a76bb","added-peer-peer-urls":["https://199.204.45.140:2380"]} {"level":"info","ts":"2026-05-08T19:21:25.198676Z","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-08T19:21:25.198762Z","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-08T19:21:25.198776Z","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-08T19:21:25.205104Z","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-08T19:21:25.205337Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"35b2766da46a76bb","initial-advertise-peer-urls":["https://199.204.45.140:2380"],"listen-peer-urls":["https://199.204.45.140:2380"],"advertise-client-urls":["https://199.204.45.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-08T19:21:25.205403Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-08T19:21:25.206039Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.140:2380"} {"level":"info","ts":"2026-05-08T19:21:25.206054Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.140:2380"} {"level":"info","ts":"2026-05-08T19:21:25.285554Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb is starting a new election at term 1"} {"level":"info","ts":"2026-05-08T19:21:25.285606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became pre-candidate at term 1"} {"level":"info","ts":"2026-05-08T19:21:25.285624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb received MsgPreVoteResp from 35b2766da46a76bb at term 1"} {"level":"info","ts":"2026-05-08T19:21:25.285637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became candidate at term 2"} {"level":"info","ts":"2026-05-08T19:21:25.285645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb received MsgVoteResp from 35b2766da46a76bb at term 2"} {"level":"info","ts":"2026-05-08T19:21:25.285656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became leader at term 2"} {"level":"info","ts":"2026-05-08T19:21:25.285666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 35b2766da46a76bb elected leader 35b2766da46a76bb at term 2"} {"level":"info","ts":"2026-05-08T19:21:25.286416Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T19:21:25.287252Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"35b2766da46a76bb","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.140:2379]}","request-path":"/0/members/35b2766da46a76bb/attributes","cluster-id":"f5fd3aeb8d9f53dc","publish-timeout":"7s"} {"level":"info","ts":"2026-05-08T19:21:25.287483Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T19:21:25.28754Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f5fd3aeb8d9f53dc","local-member-id":"35b2766da46a76bb","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T19:21:25.28754Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T19:21:25.287623Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T19:21:25.287654Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T19:21:25.287937Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-08T19:21:25.287988Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-08T19:21:25.289334Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.140:2379"} {"level":"info","ts":"2026-05-08T19:21:25.289938Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-08T19:21:31.488912Z","caller":"traceutil/trace.go:171","msg":"trace[1552742859] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"112.51096ms","start":"2026-05-08T19:21:31.376371Z","end":"2026-05-08T19:21:31.488882Z","steps":["trace[1552742859] 'process raft request' (duration: 75.171466ms)","trace[1552742859] 'compare' (duration: 37.0691ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T19:21:35.756398Z","caller":"traceutil/trace.go:171","msg":"trace[1225147956] linearizableReadLoop","detail":"{readStateIndex:370; appliedIndex:367; }","duration":"104.449321ms","start":"2026-05-08T19:21:35.651922Z","end":"2026-05-08T19:21:35.756372Z","steps":["trace[1225147956] 'read index received' (duration: 12.477027ms)","trace[1225147956] 'applied index is now lower than readState.Index' (duration: 91.971374ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T19:21:35.756495Z","caller":"traceutil/trace.go:171","msg":"trace[23175185] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"118.087126ms","start":"2026-05-08T19:21:35.638378Z","end":"2026-05-08T19:21:35.756465Z","steps":["trace[23175185] 'process raft request' (duration: 102.284109ms)","trace[23175185] 'compare' (duration: 15.528822ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T19:21:35.756537Z","caller":"traceutil/trace.go:171","msg":"trace[197261391] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"117.02111ms","start":"2026-05-08T19:21:35.639469Z","end":"2026-05-08T19:21:35.75649Z","steps":["trace[197261391] 'process raft request' (duration: 116.846587ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:21:35.756661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.687154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-08T19:21:35.756738Z","caller":"traceutil/trace.go:171","msg":"trace[363398233] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:358; }","duration":"104.817136ms","start":"2026-05-08T19:21:35.651906Z","end":"2026-05-08T19:21:35.756723Z","steps":["trace[363398233] 'agreement among raft nodes before linearized reading' (duration: 104.650374ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:21:35.930134Z","caller":"traceutil/trace.go:171","msg":"trace[2108345154] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"163.870649ms","start":"2026-05-08T19:21:35.766222Z","end":"2026-05-08T19:21:35.930093Z","steps":["trace[2108345154] 'process raft request' (duration: 161.707937ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:21:35.930396Z","caller":"traceutil/trace.go:171","msg":"trace[866026245] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"163.163728ms","start":"2026-05-08T19:21:35.767209Z","end":"2026-05-08T19:21:35.930372Z","steps":["trace[866026245] 'process raft request' (duration: 162.754362ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:21:35.930508Z","caller":"traceutil/trace.go:171","msg":"trace[1286537697] linearizableReadLoop","detail":"{readStateIndex:375; appliedIndex:370; }","duration":"128.965198ms","start":"2026-05-08T19:21:35.801428Z","end":"2026-05-08T19:21:35.930393Z","steps":["trace[1286537697] 'read index received' (duration: 27.733705ms)","trace[1286537697] 'applied index is now lower than readState.Index' (duration: 101.230363ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T19:21:35.930573Z","caller":"traceutil/trace.go:171","msg":"trace[1963067882] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"162.124613ms","start":"2026-05-08T19:21:35.768424Z","end":"2026-05-08T19:21:35.930549Z","steps":["trace[1963067882] 'process raft request' (duration: 161.88944ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:21:35.930584Z","caller":"traceutil/trace.go:171","msg":"trace[1988299630] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"163.143137ms","start":"2026-05-08T19:21:35.767411Z","end":"2026-05-08T19:21:35.930554Z","steps":["trace[1988299630] 'process raft request' (duration: 162.848853ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:21:35.932344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.892377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-08T19:21:35.932485Z","caller":"traceutil/trace.go:171","msg":"trace[2102271077] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:363; }","duration":"131.079789ms","start":"2026-05-08T19:21:35.801388Z","end":"2026-05-08T19:21:35.932468Z","steps":["trace[2102271077] 'agreement among raft nodes before linearized reading' (duration: 129.254972ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:21:35.933037Z","caller":"traceutil/trace.go:171","msg":"trace[1066749461] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"100.661224ms","start":"2026-05-08T19:21:35.83236Z","end":"2026-05-08T19:21:35.933021Z","steps":["trace[1066749461] 'process raft request' (duration: 100.270369ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:21:36.295946Z","caller":"traceutil/trace.go:171","msg":"trace[337723802] linearizableReadLoop","detail":"{readStateIndex:381; appliedIndex:377; }","duration":"321.86922ms","start":"2026-05-08T19:21:35.974014Z","end":"2026-05-08T19:21:36.295883Z","steps":["trace[337723802] 'read index received' (duration: 317.300242ms)","trace[337723802] 'applied index is now lower than readState.Index' (duration: 4.567878ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T19:21:36.296281Z","caller":"traceutil/trace.go:171","msg":"trace[1284362643] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"354.884573ms","start":"2026-05-08T19:21:35.941365Z","end":"2026-05-08T19:21:36.296249Z","steps":["trace[1284362643] 'process raft request' (duration: 354.434617ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:21:36.296333Z","caller":"traceutil/trace.go:171","msg":"trace[835859490] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"357.998359ms","start":"2026-05-08T19:21:35.938078Z","end":"2026-05-08T19:21:36.296076Z","steps":["trace[835859490] 'process raft request' (duration: 353.30207ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:21:36.296477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.443628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-08T19:21:36.296593Z","caller":"traceutil/trace.go:171","msg":"trace[1450904270] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"358.475387ms","start":"2026-05-08T19:21:35.938091Z","end":"2026-05-08T19:21:36.296567Z","steps":["trace[1450904270] 'process raft request' (duration: 357.639714ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:21:36.296984Z","caller":"traceutil/trace.go:171","msg":"trace[290117335] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"355.296659ms","start":"2026-05-08T19:21:35.941675Z","end":"2026-05-08T19:21:36.296971Z","steps":["trace[290117335] 'process raft request' (duration: 354.161882ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:21:36.296998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:21:35.941348Z","time spent":"355.005955ms","remote":"127.0.0.1:38198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4355,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T19:21:36.297099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:21:35.941662Z","time spent":"355.36632ms","remote":"127.0.0.1:38522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2150,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T19:21:36.297023Z","caller":"traceutil/trace.go:171","msg":"trace[1990038918] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:369; }","duration":"322.5451ms","start":"2026-05-08T19:21:35.973976Z","end":"2026-05-08T19:21:36.296521Z","steps":["trace[1990038918] 'agreement among raft nodes before linearized reading' (duration: 322.186304ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:21:36.297244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:21:35.973959Z","time spent":"323.268421ms","remote":"127.0.0.1:38218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"warn","ts":"2026-05-08T19:21:36.297359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:21:35.938057Z","time spent":"358.328494ms","remote":"127.0.0.1:38218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":164,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T19:21:36.297384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:21:35.938068Z","time spent":"358.69178ms","remote":"127.0.0.1:38490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3691,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T19:21:36.676742Z","caller":"traceutil/trace.go:171","msg":"trace[768134256] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"371.326916ms","start":"2026-05-08T19:21:36.305364Z","end":"2026-05-08T19:21:36.676691Z","steps":["trace[768134256] 'process raft request' (duration: 274.734796ms)","trace[768134256] 'compare' (duration: 96.461148ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T19:21:36.676882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:21:36.305354Z","time spent":"371.468858ms","remote":"127.0.0.1:38206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3378,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T19:21:36.743149Z","caller":"traceutil/trace.go:171","msg":"trace[1235037989] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"438.285125ms","start":"2026-05-08T19:21:36.304844Z","end":"2026-05-08T19:21:36.743129Z","steps":["trace[1235037989] 'process raft request' (duration: 438.136622ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:21:36.743292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:21:36.304817Z","time spent":"438.392545ms","remote":"127.0.0.1:38206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4311,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T19:21:36.743438Z","caller":"traceutil/trace.go:171","msg":"trace[1739743327] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"437.151767ms","start":"2026-05-08T19:21:36.306262Z","end":"2026-05-08T19:21:36.743414Z","steps":["trace[1739743327] 'process raft request' (duration: 436.829552ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:21:36.743541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:21:36.306246Z","time spent":"437.233769ms","remote":"127.0.0.1:38206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T19:21:36.74366Z","caller":"traceutil/trace.go:171","msg":"trace[76084479] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"433.33678ms","start":"2026-05-08T19:21:36.310271Z","end":"2026-05-08T19:21:36.743607Z","steps":["trace[76084479] 'process raft request' (duration: 433.059927ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:21:36.743851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:21:36.31026Z","time spent":"433.505363ms","remote":"127.0.0.1:38490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4002,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T19:21:37.145968Z","caller":"traceutil/trace.go:171","msg":"trace[989543067] linearizableReadLoop","detail":"{readStateIndex:402; appliedIndex:401; }","duration":"105.282016ms","start":"2026-05-08T19:21:37.040662Z","end":"2026-05-08T19:21:37.145944Z","steps":["trace[989543067] 'read index received' (duration: 70.085352ms)","trace[989543067] 'applied index is now lower than readState.Index' (duration: 35.195754ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T19:21:37.146127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.449999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-05-08T19:21:37.146232Z","caller":"traceutil/trace.go:171","msg":"trace[153343998] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:390; }","duration":"105.59815ms","start":"2026-05-08T19:21:37.040615Z","end":"2026-05-08T19:21:37.146213Z","steps":["trace[153343998] 'agreement among raft nodes before linearized reading' (duration: 105.444047ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:21:37.146739Z","caller":"traceutil/trace.go:171","msg":"trace[1192485458] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"220.602473ms","start":"2026-05-08T19:21:36.925417Z","end":"2026-05-08T19:21:37.146019Z","steps":["trace[1192485458] 'process raft request' (duration: 185.342398ms)","trace[1192485458] 'compare' (duration: 35.055772ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T19:21:37.504068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.147704ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T19:21:37.504308Z","caller":"traceutil/trace.go:171","msg":"trace[178955996] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"354.076275ms","start":"2026-05-08T19:21:37.150191Z","end":"2026-05-08T19:21:37.504267Z","steps":["trace[178955996] 'process raft request' (duration: 213.478045ms)","trace[178955996] 'compare' (duration: 140.010872ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T19:21:37.504499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:21:37.150171Z","time spent":"354.245278ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T19:21:37.504662Z","caller":"traceutil/trace.go:171","msg":"trace[1502298639] linearizableReadLoop","detail":"{readStateIndex:403; appliedIndex:402; }","duration":"350.030965ms","start":"2026-05-08T19:21:37.154619Z","end":"2026-05-08T19:21:37.50465Z","steps":["trace[1502298639] 'read index received' (duration: 209.047169ms)","trace[1502298639] 'applied index is now lower than readState.Index' (duration: 140.982406ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T19:21:37.504782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.162658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-08T19:21:37.504845Z","caller":"traceutil/trace.go:171","msg":"trace[1187968320] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:392; }","duration":"350.257629ms","start":"2026-05-08T19:21:37.154577Z","end":"2026-05-08T19:21:37.504835Z","steps":["trace[1187968320] 'agreement among raft nodes before linearized reading' (duration: 350.123537ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:21:37.504888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:21:37.154565Z","time spent":"350.31187ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-08T19:21:37.504617Z","caller":"traceutil/trace.go:171","msg":"trace[181451009] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"301.244079ms","start":"2026-05-08T19:21:37.203353Z","end":"2026-05-08T19:21:37.504597Z","steps":["trace[181451009] 'process raft request' (duration: 300.805813ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:21:37.505514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:21:37.203338Z","time spent":"302.123333ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T19:21:40.807452Z","caller":"traceutil/trace.go:171","msg":"trace[201749897] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"130.03238ms","start":"2026-05-08T19:21:40.677392Z","end":"2026-05-08T19:21:40.807425Z","steps":["trace[201749897] 'process raft request' (duration: 122.212736ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:21:43.257346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.815254ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T19:21:43.257458Z","caller":"traceutil/trace.go:171","msg":"trace[384055482] linearizableReadLoop","detail":"{readStateIndex:428; appliedIndex:427; }","duration":"392.868969ms","start":"2026-05-08T19:21:42.864573Z","end":"2026-05-08T19:21:43.257442Z","steps":["trace[384055482] 'read index received' (duration: 142.77829ms)","trace[384055482] 'applied index is now lower than readState.Index' (duration: 250.089509ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T19:21:43.257543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.96879ms","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-08T19:21:43.257576Z","caller":"traceutil/trace.go:171","msg":"trace[2016097910] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:414; }","duration":"393.04179ms","start":"2026-05-08T19:21:42.864524Z","end":"2026-05-08T19:21:43.257566Z","steps":["trace[2016097910] 'agreement among raft nodes before linearized reading' (duration: 392.962239ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:21:43.257616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:21:42.864504Z","time spent":"393.104202ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-08T19:21:43.257876Z","caller":"traceutil/trace.go:171","msg":"trace[2022478165] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"466.139806ms","start":"2026-05-08T19:21:42.791695Z","end":"2026-05-08T19:21:43.257835Z","steps":["trace[2022478165] 'process raft request' (duration: 215.751412ms)","trace[2022478165] 'compare' (duration: 249.673713ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T19:21:43.258151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:21:42.791676Z","time spent":"466.382059ms","remote":"127.0.0.1:38206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7096,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T19:21:43.485142Z","caller":"traceutil/trace.go:171","msg":"trace[1108595819] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"127.556861ms","start":"2026-05-08T19:21:43.357559Z","end":"2026-05-08T19:21:43.485116Z","steps":["trace[1108595819] 'process raft request' (duration: 127.351368ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:21:43.721817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.890482ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T19:21:43.722159Z","caller":"traceutil/trace.go:171","msg":"trace[1644660364] linearizableReadLoop","detail":"{readStateIndex:431; appliedIndex:430; }","duration":"110.210947ms","start":"2026-05-08T19:21:43.611926Z","end":"2026-05-08T19:21:43.722137Z","steps":["trace[1644660364] 'read index received' (duration: 59.861µs)","trace[1644660364] 'applied index is now lower than readState.Index' (duration: 110.149346ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T19:21:43.722197Z","caller":"traceutil/trace.go:171","msg":"trace[1810615982] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"164.9618ms","start":"2026-05-08T19:21:43.5572Z","end":"2026-05-08T19:21:43.722162Z","steps":["trace[1810615982] 'process raft request' (duration: 24.636972ms)","trace[1810615982] 'compare' (duration: 139.74261ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T19:21:43.722322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.38601ms","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-08T19:21:43.722732Z","caller":"traceutil/trace.go:171","msg":"trace[1199710441] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:417; }","duration":"110.836676ms","start":"2026-05-08T19:21:43.611874Z","end":"2026-05-08T19:21:43.72271Z","steps":["trace[1199710441] 'agreement among raft nodes before linearized reading' (duration: 110.38846ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:21:43.741322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.555888ms","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-08T19:21:43.741399Z","caller":"traceutil/trace.go:171","msg":"trace[2100278558] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:417; }","duration":"107.71287ms","start":"2026-05-08T19:21:43.633671Z","end":"2026-05-08T19:21:43.741384Z","steps":["trace[2100278558] 'agreement among raft nodes before linearized reading' (duration: 107.550757ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:21:45.140539Z","caller":"traceutil/trace.go:171","msg":"trace[2124582516] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"114.180819ms","start":"2026-05-08T19:21:45.026334Z","end":"2026-05-08T19:21:45.140515Z","steps":["trace[2124582516] 'process raft request' (duration: 114.100958ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:21:45.140552Z","caller":"traceutil/trace.go:171","msg":"trace[265806608] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"114.262769ms","start":"2026-05-08T19:21:45.026256Z","end":"2026-05-08T19:21:45.140519Z","steps":["trace[265806608] 'process raft request' (duration: 66.117606ms)","trace[265806608] 'compare' (duration: 47.93318ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T19:21:45.141298Z","caller":"traceutil/trace.go:171","msg":"trace[530172484] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"114.908279ms","start":"2026-05-08T19:21:45.026378Z","end":"2026-05-08T19:21:45.141286Z","steps":["trace[530172484] 'process raft request' (duration: 114.101827ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:21:45.141263Z","caller":"traceutil/trace.go:171","msg":"trace[1272740963] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"112.21895ms","start":"2026-05-08T19:21:45.029022Z","end":"2026-05-08T19:21:45.14124Z","steps":["trace[1272740963] 'process raft request' (duration: 112.112898ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:21:45.152833Z","caller":"traceutil/trace.go:171","msg":"trace[144220832] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"106.72266ms","start":"2026-05-08T19:21:45.046093Z","end":"2026-05-08T19:21:45.152816Z","steps":["trace[144220832] 'process raft request' (duration: 106.640388ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:21:45.466433Z","caller":"traceutil/trace.go:171","msg":"trace[1800389432] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"107.082075ms","start":"2026-05-08T19:21:45.359326Z","end":"2026-05-08T19:21:45.466408Z","steps":["trace[1800389432] 'process raft request' (duration: 106.934633ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:21:54.095603Z","caller":"traceutil/trace.go:171","msg":"trace[195939955] linearizableReadLoop","detail":"{readStateIndex:490; appliedIndex:489; }","duration":"221.4766ms","start":"2026-05-08T19:21:53.874094Z","end":"2026-05-08T19:21:54.095571Z","steps":["trace[195939955] 'read index received' (duration: 221.195206ms)","trace[195939955] 'applied index is now lower than readState.Index' (duration: 280.094µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T19:21:54.095629Z","caller":"traceutil/trace.go:171","msg":"trace[1347062883] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"311.419116ms","start":"2026-05-08T19:21:53.784189Z","end":"2026-05-08T19:21:54.095608Z","steps":["trace[1347062883] 'process raft request' (duration: 311.196373ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:21:54.095751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.641042ms","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-08T19:21:54.095818Z","caller":"traceutil/trace.go:171","msg":"trace[1734695273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:472; }","duration":"221.757213ms","start":"2026-05-08T19:21:53.874043Z","end":"2026-05-08T19:21:54.095801Z","steps":["trace[1734695273] 'agreement among raft nodes before linearized reading' (duration: 221.634192ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:21:54.095895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:21:53.784177Z","time spent":"311.581588ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T19:21:54.095984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.15921ms","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-08T19:21:54.096092Z","caller":"traceutil/trace.go:171","msg":"trace[86478847] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:472; }","duration":"195.315613ms","start":"2026-05-08T19:21:53.900757Z","end":"2026-05-08T19:21:54.096073Z","steps":["trace[86478847] 'agreement among raft nodes before linearized reading' (duration: 195.1072ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:21:59.290618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.795729ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T19:21:59.290898Z","caller":"traceutil/trace.go:171","msg":"trace[636688245] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"933.962559ms","start":"2026-05-08T19:21:58.356889Z","end":"2026-05-08T19:21:59.290852Z","steps":["trace[636688245] 'process raft request' (duration: 400.831765ms)","trace[636688245] 'compare' (duration: 531.703003ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T19:21:59.29114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:21:58.356867Z","time spent":"934.166137ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65199,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T19:21:59.291221Z","caller":"traceutil/trace.go:171","msg":"trace[1274196652] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"913.943228ms","start":"2026-05-08T19:21:58.37725Z","end":"2026-05-08T19:21:59.291193Z","steps":["trace[1274196652] 'process raft request' (duration: 913.564412ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:21:59.29136Z","caller":"traceutil/trace.go:171","msg":"trace[636939228] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:576; }","duration":"768.523247ms","start":"2026-05-08T19:21:58.522789Z","end":"2026-05-08T19:21:59.291313Z","steps":["trace[636939228] 'read index received' (duration: 234.83518ms)","trace[636939228] 'applied index is now lower than readState.Index' (duration: 533.687127ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T19:21:59.291481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:21:58.377232Z","time spent":"914.114225ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T19:21:59.291583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"768.580759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.140\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-08T19:21:59.291803Z","caller":"traceutil/trace.go:171","msg":"trace[1256328496] range","detail":"{range_begin:/registry/masterleases/199.204.45.140; range_end:; response_count:1; response_revision:558; }","duration":"768.755208ms","start":"2026-05-08T19:21:58.522965Z","end":"2026-05-08T19:21:59.29172Z","steps":["trace[1256328496] 'agreement among raft nodes before linearized reading' (duration: 768.541999ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:21:59.291588Z","caller":"traceutil/trace.go:171","msg":"trace[266234527] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"828.926734ms","start":"2026-05-08T19:21:58.462647Z","end":"2026-05-08T19:21:59.291573Z","steps":["trace[266234527] 'process raft request' (duration: 828.547668ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:21:59.29185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:21:58.522955Z","time spent":"768.881263ms","remote":"127.0.0.1:38040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.140\" "} {"level":"warn","ts":"2026-05-08T19:21:59.291901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:21:58.462594Z","time spent":"829.254718ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59607,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T19:21:59.29154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"768.742776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T19:21:59.291984Z","caller":"traceutil/trace.go:171","msg":"trace[1846112550] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:558; }","duration":"769.227568ms","start":"2026-05-08T19:21:58.522739Z","end":"2026-05-08T19:21:59.291967Z","steps":["trace[1846112550] 'agreement among raft nodes before linearized reading' (duration: 768.756228ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:21:59.292034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:21:58.522715Z","time spent":"769.30495ms","remote":"127.0.0.1:38020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-08T19:22:00.126693Z","caller":"traceutil/trace.go:171","msg":"trace[2119561979] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"287.62909ms","start":"2026-05-08T19:21:59.839033Z","end":"2026-05-08T19:22:00.126662Z","steps":["trace[2119561979] 'process raft request' (duration: 271.514848ms)","trace[2119561979] 'compare' (duration: 15.989907ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T19:22:00.139466Z","caller":"traceutil/trace.go:171","msg":"trace[2133805294] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"142.693994ms","start":"2026-05-08T19:21:59.996749Z","end":"2026-05-08T19:22:00.139443Z","steps":["trace[2133805294] 'process raft request' (duration: 142.662603ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:22:00.139536Z","caller":"traceutil/trace.go:171","msg":"trace[1893740638] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"174.708943ms","start":"2026-05-08T19:21:59.964804Z","end":"2026-05-08T19:22:00.139513Z","steps":["trace[1893740638] 'process raft request' (duration: 173.948741ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:00.696298Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8555605678773486806,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T19:22:01.194614Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.009169577s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-08T19:22:01.421981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.092223ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T19:22:01.422082Z","caller":"traceutil/trace.go:171","msg":"trace[1038603812] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"1.236684817s","start":"2026-05-08T19:22:00.185375Z","end":"2026-05-08T19:22:01.42206Z","steps":["trace[1038603812] 'process raft request' (duration: 1.009444237s)","trace[1038603812] 'compare' (duration: 226.728389ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T19:22:01.422132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:00.185357Z","time spent":"1.236754311s","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T19:22:01.424324Z","caller":"traceutil/trace.go:171","msg":"trace[309549398] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"1.217050499s","start":"2026-05-08T19:22:00.207228Z","end":"2026-05-08T19:22:01.424278Z","steps":["trace[309549398] 'process raft request' (duration: 1.216440364s)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:22:01.424393Z","caller":"traceutil/trace.go:171","msg":"trace[57346533] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"1.197983292s","start":"2026-05-08T19:22:00.22632Z","end":"2026-05-08T19:22:01.424303Z","steps":["trace[57346533] 'process raft request' (duration: 1.197399419s)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:22:01.424489Z","caller":"traceutil/trace.go:171","msg":"trace[474819820] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"1.232135008s","start":"2026-05-08T19:22:00.192307Z","end":"2026-05-08T19:22:01.424442Z","steps":["trace[474819820] 'process raft request' (duration: 1.231219929s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:01.424842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:00.207211Z","time spent":"1.217404272s","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T19:22:01.424963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:00.226299Z","time spent":"1.198356388s","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T19:22:01.425549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:00.192288Z","time spent":"1.232522223s","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10362,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T19:22:01.430632Z","caller":"traceutil/trace.go:171","msg":"trace[440312191] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:631; }","duration":"1.234621349s","start":"2026-05-08T19:22:00.195977Z","end":"2026-05-08T19:22:01.430599Z","steps":["trace[440312191] 'read index received' (duration: 998.970391ms)","trace[440312191] 'applied index is now lower than readState.Index' (duration: 235.650358ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T19:22:01.430791Z","caller":"traceutil/trace.go:171","msg":"trace[1203859389] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"1.110936961s","start":"2026-05-08T19:22:00.319844Z","end":"2026-05-08T19:22:01.430781Z","steps":["trace[1203859389] 'process raft request' (duration: 1.105585239s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:01.430846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:00.319814Z","time spent":"1.110996813s","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T19:22:01.430963Z","caller":"traceutil/trace.go:171","msg":"trace[544326288] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"634.403534ms","start":"2026-05-08T19:22:00.796553Z","end":"2026-05-08T19:22:01.430957Z","steps":["trace[544326288] 'process raft request' (duration: 633.952756ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:01.430996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:00.796527Z","time spent":"634.450356ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T19:22:01.431131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.235109049s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-05-08T19:22:01.431151Z","caller":"traceutil/trace.go:171","msg":"trace[1682452135] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:616; }","duration":"1.23513556s","start":"2026-05-08T19:22:00.196009Z","end":"2026-05-08T19:22:01.431145Z","steps":["trace[1682452135] 'agreement among raft nodes before linearized reading' (duration: 1.235061017s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:01.43117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:00.196005Z","time spent":"1.235161501s","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-08T19:22:01.431214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.235218073s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-08T19:22:01.43129Z","caller":"traceutil/trace.go:171","msg":"trace[1339962370] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:616; }","duration":"1.235312247s","start":"2026-05-08T19:22:00.195949Z","end":"2026-05-08T19:22:01.431261Z","steps":["trace[1339962370] 'agreement among raft nodes before linearized reading' (duration: 1.235054797s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:01.43133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:00.195938Z","time spent":"1.23538294s","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-08T19:22:01.431331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.363735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T19:22:01.431369Z","caller":"traceutil/trace.go:171","msg":"trace[1896479595] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:616; }","duration":"436.445858ms","start":"2026-05-08T19:22:00.994913Z","end":"2026-05-08T19:22:01.431359Z","steps":["trace[1896479595] 'agreement among raft nodes before linearized reading' (duration: 436.381465ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:01.431421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:00.994891Z","time spent":"436.49667ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-05-08T19:22:01.431603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.139779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T19:22:01.431635Z","caller":"traceutil/trace.go:171","msg":"trace[1454846521] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"530.808242ms","start":"2026-05-08T19:22:00.900811Z","end":"2026-05-08T19:22:01.43162Z","steps":["trace[1454846521] 'process raft request' (duration: 529.723048ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:22:01.431632Z","caller":"traceutil/trace.go:171","msg":"trace[1508605956] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:616; }","duration":"237.204692ms","start":"2026-05-08T19:22:01.194418Z","end":"2026-05-08T19:22:01.431623Z","steps":["trace[1508605956] 'agreement among raft nodes before linearized reading' (duration: 237.1666ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:01.431728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:00.900787Z","time spent":"530.878677ms","remote":"127.0.0.1:38198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4559,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T19:22:01.431808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.037202404s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T19:22:01.431871Z","caller":"traceutil/trace.go:171","msg":"trace[1614343920] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:616; }","duration":"1.037266526s","start":"2026-05-08T19:22:00.394562Z","end":"2026-05-08T19:22:01.431829Z","steps":["trace[1614343920] 'agreement among raft nodes before linearized reading' (duration: 1.037223585s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:01.431898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:00.394544Z","time spent":"1.03734725s","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"warn","ts":"2026-05-08T19:22:01.431969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.549296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T19:22:01.431992Z","caller":"traceutil/trace.go:171","msg":"trace[1029766631] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:616; }","duration":"837.597779ms","start":"2026-05-08T19:22:00.594387Z","end":"2026-05-08T19:22:01.431984Z","steps":["trace[1029766631] 'agreement among raft nodes before linearized reading' (duration: 837.562237ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:01.432014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:00.594375Z","time spent":"837.633381ms","remote":"127.0.0.1:38050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "} {"level":"warn","ts":"2026-05-08T19:22:01.432078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"909.166464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T19:22:01.432099Z","caller":"traceutil/trace.go:171","msg":"trace[412514636] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"909.226257ms","start":"2026-05-08T19:22:00.522866Z","end":"2026-05-08T19:22:01.432092Z","steps":["trace[412514636] 'agreement among raft nodes before linearized reading' (duration: 909.193555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:01.432118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:00.522847Z","time spent":"909.266348ms","remote":"127.0.0.1:38032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-08T19:22:01.432114Z","caller":"traceutil/trace.go:171","msg":"trace[376175270] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"322.610811ms","start":"2026-05-08T19:22:01.109485Z","end":"2026-05-08T19:22:01.432096Z","steps":["trace[376175270] 'process raft request' (duration: 321.086188ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:01.432187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:01.109458Z","time spent":"322.688843ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T19:22:07.861483Z","caller":"traceutil/trace.go:171","msg":"trace[1863274451] linearizableReadLoop","detail":"{readStateIndex:710; appliedIndex:709; }","duration":"215.45125ms","start":"2026-05-08T19:22:07.646004Z","end":"2026-05-08T19:22:07.861455Z","steps":["trace[1863274451] 'read index received' (duration: 215.224661ms)","trace[1863274451] 'applied index is now lower than readState.Index' (duration: 225.459µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T19:22:07.861617Z","caller":"traceutil/trace.go:171","msg":"trace[1908394028] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"304.092998ms","start":"2026-05-08T19:22:07.557488Z","end":"2026-05-08T19:22:07.861581Z","steps":["trace[1908394028] 'process raft request' (duration: 303.817737ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:07.861724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.694739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-08T19:22:07.861774Z","caller":"traceutil/trace.go:171","msg":"trace[1548368313] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:686; }","duration":"215.815514ms","start":"2026-05-08T19:22:07.645943Z","end":"2026-05-08T19:22:07.861759Z","steps":["trace[1548368313] 'agreement among raft nodes before linearized reading' (duration: 215.648917ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:07.861796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:07.557444Z","time spent":"304.274364ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T19:22:07.861969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.810571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-lstr5\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-08T19:22:07.862044Z","caller":"traceutil/trace.go:171","msg":"trace[1149986692] range","detail":"{range_begin:/registry/pods/kube-system/cilium-lstr5; range_end:; response_count:1; response_revision:686; }","duration":"126.925696ms","start":"2026-05-08T19:22:07.735099Z","end":"2026-05-08T19:22:07.862024Z","steps":["trace[1149986692] 'agreement among raft nodes before linearized reading' (duration: 126.721757ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:22:08.079923Z","caller":"traceutil/trace.go:171","msg":"trace[1766903862] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"203.12364ms","start":"2026-05-08T19:22:07.876773Z","end":"2026-05-08T19:22:08.079897Z","steps":["trace[1766903862] 'process raft request' (duration: 203.000556ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:22:08.607825Z","caller":"traceutil/trace.go:171","msg":"trace[1907002942] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"494.524907ms","start":"2026-05-08T19:22:08.113267Z","end":"2026-05-08T19:22:08.607792Z","steps":["trace[1907002942] 'process raft request' (duration: 460.736326ms)","trace[1907002942] 'compare' (duration: 33.600103ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T19:22:08.608015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:08.113242Z","time spent":"494.689673ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T19:22:10.54387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"968.289737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T19:22:10.543968Z","caller":"traceutil/trace.go:171","msg":"trace[1885460576] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:690; }","duration":"968.428832ms","start":"2026-05-08T19:22:09.575518Z","end":"2026-05-08T19:22:10.543946Z","steps":["trace[1885460576] 'range keys from in-memory index tree' (duration: 968.138052ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:10.544022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:09.575472Z","time spent":"968.537107ms","remote":"127.0.0.1:38020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-08T19:22:10.54453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.057211006s","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-08T19:22:10.544598Z","caller":"traceutil/trace.go:171","msg":"trace[1618694057] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:690; }","duration":"1.05731737s","start":"2026-05-08T19:22:09.487264Z","end":"2026-05-08T19:22:10.544582Z","steps":["trace[1618694057] 'range keys from in-memory index tree' (duration: 1.057006408s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:10.544644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:09.487245Z","time spent":"1.057387162s","remote":"127.0.0.1:38276","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-08T19:22:10.544662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.390834ms","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-08T19:22:10.544734Z","caller":"traceutil/trace.go:171","msg":"trace[296050976] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:690; }","duration":"678.485428ms","start":"2026-05-08T19:22:09.866234Z","end":"2026-05-08T19:22:10.544719Z","steps":["trace[296050976] 'range keys from in-memory index tree' (duration: 678.140395ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:10.544761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:09.866172Z","time spent":"678.582542ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-08T19:22:10.544831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.550609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-08T19:22:10.544885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.090539666s","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-08T19:22:10.544895Z","caller":"traceutil/trace.go:171","msg":"trace[713159140] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:690; }","duration":"615.650042ms","start":"2026-05-08T19:22:09.929229Z","end":"2026-05-08T19:22:10.544879Z","steps":["trace[713159140] 'range keys from in-memory index tree' (duration: 615.390442ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:22:10.544927Z","caller":"traceutil/trace.go:171","msg":"trace[778883931] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:690; }","duration":"1.090581068s","start":"2026-05-08T19:22:09.454336Z","end":"2026-05-08T19:22:10.544917Z","steps":["trace[778883931] 'range keys from in-memory index tree' (duration: 1.090375961s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:10.544947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:09.9292Z","time spent":"615.733146ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-08T19:22:10.544962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:09.454283Z","time spent":"1.090671701s","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-08T19:22:10.545031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.059382299s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-08T19:22:10.545099Z","caller":"traceutil/trace.go:171","msg":"trace[362249431] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:690; }","duration":"1.059483532s","start":"2026-05-08T19:22:09.485598Z","end":"2026-05-08T19:22:10.545082Z","steps":["trace[362249431] 'range keys from in-memory index tree' (duration: 1.059224682s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:10.545153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:09.485579Z","time spent":"1.059557526s","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-08T19:22:10.667144Z","caller":"traceutil/trace.go:171","msg":"trace[624529694] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"118.860548ms","start":"2026-05-08T19:22:10.548255Z","end":"2026-05-08T19:22:10.667116Z","steps":["trace[624529694] 'process raft request' (duration: 118.677841ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:22:10.707915Z","caller":"traceutil/trace.go:171","msg":"trace[1373933951] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"159.56367ms","start":"2026-05-08T19:22:10.548324Z","end":"2026-05-08T19:22:10.707888Z","steps":["trace[1373933951] 'process raft request' (duration: 159.345282ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:22:10.708288Z","caller":"traceutil/trace.go:171","msg":"trace[688625508] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"158.015472ms","start":"2026-05-08T19:22:10.550255Z","end":"2026-05-08T19:22:10.70827Z","steps":["trace[688625508] 'process raft request' (duration: 157.959249ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:22:10.708317Z","caller":"traceutil/trace.go:171","msg":"trace[1771803061] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"159.154775ms","start":"2026-05-08T19:22:10.549139Z","end":"2026-05-08T19:22:10.708294Z","steps":["trace[1771803061] 'process raft request' (duration: 158.643055ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:22:10.708542Z","caller":"traceutil/trace.go:171","msg":"trace[221071912] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"159.131184ms","start":"2026-05-08T19:22:10.549387Z","end":"2026-05-08T19:22:10.708518Z","steps":["trace[221071912] 'process raft request' (duration: 158.758899ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:26.147118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.373483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T19:22:26.147222Z","caller":"traceutil/trace.go:171","msg":"trace[1817033639] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:803; }","duration":"623.512358ms","start":"2026-05-08T19:22:25.523687Z","end":"2026-05-08T19:22:26.147199Z","steps":["trace[1817033639] 'range keys from in-memory index tree' (duration: 623.263349ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:26.147263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T19:22:25.523672Z","time spent":"623.581959ms","remote":"127.0.0.1:38020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-08T19:22:26.149998Z","caller":"traceutil/trace.go:171","msg":"trace[1829411439] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"296.589364ms","start":"2026-05-08T19:22:25.853389Z","end":"2026-05-08T19:22:26.149979Z","steps":["trace[1829411439] 'process raft request' (duration: 296.219852ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:22:30.464875Z","caller":"traceutil/trace.go:171","msg":"trace[1666650182] transaction","detail":"{read_only:false; response_revision:850; number_of_response:1; }","duration":"125.982441ms","start":"2026-05-08T19:22:30.338869Z","end":"2026-05-08T19:22:30.464851Z","steps":["trace[1666650182] 'process raft request' (duration: 125.521536ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:22:30.786025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.210871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050264"} {"level":"info","ts":"2026-05-08T19:22:30.78612Z","caller":"traceutil/trace.go:171","msg":"trace[1156938369] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:850; }","duration":"198.359925ms","start":"2026-05-08T19:22:30.587739Z","end":"2026-05-08T19:22:30.786099Z","steps":["trace[1156938369] 'range keys from in-memory index tree' (duration: 197.775936ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:22:30.814153Z","caller":"traceutil/trace.go:171","msg":"trace[1508332777] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"185.319823ms","start":"2026-05-08T19:22:30.628796Z","end":"2026-05-08T19:22:30.814116Z","steps":["trace[1508332777] 'process raft request' (duration: 185.039353ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:23:13.343541Z","caller":"traceutil/trace.go:171","msg":"trace[379953596] linearizableReadLoop","detail":"{readStateIndex:1131; appliedIndex:1130; }","duration":"194.887393ms","start":"2026-05-08T19:23:13.148625Z","end":"2026-05-08T19:23:13.343512Z","steps":["trace[379953596] 'read index received' (duration: 194.619517ms)","trace[379953596] 'applied index is now lower than readState.Index' (duration: 266.666µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T19:23:13.343601Z","caller":"traceutil/trace.go:171","msg":"trace[1318280008] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"236.488425ms","start":"2026-05-08T19:23:13.107082Z","end":"2026-05-08T19:23:13.34357Z","steps":["trace[1318280008] 'process raft request' (duration: 236.26485ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:23:13.343724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.062338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T19:23:13.34377Z","caller":"traceutil/trace.go:171","msg":"trace[646440062] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1090; }","duration":"195.161211ms","start":"2026-05-08T19:23:13.148594Z","end":"2026-05-08T19:23:13.343755Z","steps":["trace[646440062] 'agreement among raft nodes before linearized reading' (duration: 195.058718ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:23:13.344121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.454541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T19:23:13.344233Z","caller":"traceutil/trace.go:171","msg":"trace[743882807] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1090; }","duration":"125.627456ms","start":"2026-05-08T19:23:13.21858Z","end":"2026-05-08T19:23:13.344207Z","steps":["trace[743882807] 'agreement among raft nodes before linearized reading' (duration: 125.387969ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:23:13.34418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.544346ms","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-08T19:23:13.344495Z","caller":"traceutil/trace.go:171","msg":"trace[1216048291] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1090; }","duration":"165.917796ms","start":"2026-05-08T19:23:13.17855Z","end":"2026-05-08T19:23:13.344468Z","steps":["trace[1216048291] 'agreement among raft nodes before linearized reading' (duration: 165.346772ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:23:13.34415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.750203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-08T19:23:13.345796Z","caller":"traceutil/trace.go:171","msg":"trace[503905436] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1090; }","duration":"159.432463ms","start":"2026-05-08T19:23:13.186341Z","end":"2026-05-08T19:23:13.345774Z","steps":["trace[503905436] 'agreement among raft nodes before linearized reading' (duration: 157.648549ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:24:10.731205Z","caller":"traceutil/trace.go:171","msg":"trace[20111156] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"104.515897ms","start":"2026-05-08T19:24:10.626665Z","end":"2026-05-08T19:24:10.731181Z","steps":["trace[20111156] 'process raft request' (duration: 104.348234ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:24:11.157465Z","caller":"traceutil/trace.go:171","msg":"trace[731040664] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"102.904478ms","start":"2026-05-08T19:24:11.054533Z","end":"2026-05-08T19:24:11.157438Z","steps":["trace[731040664] 'process raft request' (duration: 102.755296ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:24:14.118479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.324683ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-08T19:24:14.118833Z","caller":"traceutil/trace.go:171","msg":"trace[1239780530] linearizableReadLoop","detail":"{readStateIndex:1375; appliedIndex:1374; }","duration":"206.713541ms","start":"2026-05-08T19:24:13.91208Z","end":"2026-05-08T19:24:14.118794Z","steps":["trace[1239780530] 'read index received' (duration: 48.965419ms)","trace[1239780530] 'applied index is now lower than readState.Index' (duration: 157.745262ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T19:24:14.119185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.084358ms","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-08T19:24:14.119249Z","caller":"traceutil/trace.go:171","msg":"trace[95390256] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1321; }","duration":"207.1934ms","start":"2026-05-08T19:24:13.912039Z","end":"2026-05-08T19:24:14.119233Z","steps":["trace[95390256] 'agreement among raft nodes before linearized reading' (duration: 206.924475ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T19:24:14.119475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.886434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-08T19:24:14.119562Z","caller":"traceutil/trace.go:171","msg":"trace[312862833] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1321; }","duration":"161.018697ms","start":"2026-05-08T19:24:13.958515Z","end":"2026-05-08T19:24:14.119534Z","steps":["trace[312862833] 'agreement among raft nodes before linearized reading' (duration: 160.71163ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T19:24:58.153202Z","caller":"traceutil/trace.go:171","msg":"trace[632397034] transaction","detail":"{read_only:false; response_revision:1475; number_of_response:1; }","duration":"104.01497ms","start":"2026-05-08T19:24:58.049155Z","end":"2026-05-08T19:24:58.15317Z","steps":["trace[632397034] 'process raft request' (duration: 103.745795ms)"],"step_count":1}