{"level":"warn","ts":"2026-05-14T03:20:01.306415Z","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-14T03:20:01.306504Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.240: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.240:2380","--initial-cluster=instance=https://199.204.45.240:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.240:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.240: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-14T03:20:01.306582Z","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-14T03:20:01.306593Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-05-14T03:20:01.306623Z","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-14T03:20:01.307234Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"]} {"level":"info","ts":"2026-05-14T03:20:01.307307Z","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.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.240: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-14T03:20:01.311516Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.943602ms"} {"level":"info","ts":"2026-05-14T03:20:01.318729Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e46287fb5aa4785","cluster-id":"cae704afa9813e87"} {"level":"info","ts":"2026-05-14T03:20:01.318905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=()"} {"level":"info","ts":"2026-05-14T03:20:01.31895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 0"} {"level":"info","ts":"2026-05-14T03:20:01.318975Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e46287fb5aa4785 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-14T03:20:01.318989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 1"} {"level":"info","ts":"2026-05-14T03:20:01.319068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"warn","ts":"2026-05-14T03:20:01.327878Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-14T03:20:01.331979Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-14T03:20:01.333393Z","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-14T03:20:01.342653Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e46287fb5aa4785","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-14T03:20:01.343286Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e46287fb5aa4785","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-14T03:20:01.34323Z","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-14T03:20:01.343906Z","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-14T03:20:01.343923Z","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-14T03:20:01.344757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"info","ts":"2026-05-14T03:20:01.344906Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","added-peer-id":"4e46287fb5aa4785","added-peer-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-05-14T03:20:01.34832Z","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-14T03:20:01.348829Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e46287fb5aa4785","initial-advertise-peer-urls":["https://199.204.45.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-14T03:20:01.34886Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-14T03:20:01.348883Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-05-14T03:20:01.349529Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-05-14T03:20:01.420119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 is starting a new election at term 1"} {"level":"info","ts":"2026-05-14T03:20:01.420255Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-14T03:20:01.420297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgPreVoteResp from 4e46287fb5aa4785 at term 1"} {"level":"info","ts":"2026-05-14T03:20:01.420372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became candidate at term 2"} {"level":"info","ts":"2026-05-14T03:20:01.420444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgVoteResp from 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-05-14T03:20:01.420479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became leader at term 2"} {"level":"info","ts":"2026-05-14T03:20:01.420491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e46287fb5aa4785 elected leader 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-05-14T03:20:01.421903Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e46287fb5aa4785","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.240:2379]}","request-path":"/0/members/4e46287fb5aa4785/attributes","cluster-id":"cae704afa9813e87","publish-timeout":"7s"} {"level":"info","ts":"2026-05-14T03:20:01.421901Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-14T03:20:01.422219Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-14T03:20:01.422535Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T03:20:01.422566Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-14T03:20:01.422786Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-14T03:20:01.423562Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T03:20:01.423651Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T03:20:01.423679Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T03:20:01.426288Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.240:2379"} {"level":"info","ts":"2026-05-14T03:20:01.426629Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-14T03:20:24.15002Z","caller":"traceutil/trace.go:171","msg":"trace[1270832011] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"131.442059ms","start":"2026-05-14T03:20:24.018552Z","end":"2026-05-14T03:20:24.149994Z","steps":["trace[1270832011] 'process raft request' (duration: 126.440571ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:26.309456Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153699228191828669,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-14T03:20:26.581121Z","caller":"traceutil/trace.go:171","msg":"trace[367102854] linearizableReadLoop","detail":"{readStateIndex:435; appliedIndex:434; }","duration":"771.787623ms","start":"2026-05-14T03:20:25.809313Z","end":"2026-05-14T03:20:26.581101Z","steps":["trace[367102854] 'read index received' (duration: 771.641245ms)","trace[367102854] 'applied index is now lower than readState.Index' (duration: 145.718µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T03:20:26.581204Z","caller":"traceutil/trace.go:171","msg":"trace[324883710] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"815.86186ms","start":"2026-05-14T03:20:25.765327Z","end":"2026-05-14T03:20:26.581189Z","steps":["trace[324883710] 'process raft request' (duration: 815.654539ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:26.581305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.577334ms","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-14T03:20:26.581374Z","caller":"traceutil/trace.go:171","msg":"trace[1858552291] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:421; }","duration":"559.715032ms","start":"2026-05-14T03:20:26.021644Z","end":"2026-05-14T03:20:26.581359Z","steps":["trace[1858552291] 'agreement among raft nodes before linearized reading' (duration: 559.568724ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:26.581309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.979144ms","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-14T03:20:26.581413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:26.021623Z","time spent":"559.780536ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-14T03:20:26.581472Z","caller":"traceutil/trace.go:171","msg":"trace[1377243908] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:421; }","duration":"772.141763ms","start":"2026-05-14T03:20:25.809285Z","end":"2026-05-14T03:20:26.581427Z","steps":["trace[1377243908] 'agreement among raft nodes before linearized reading' (duration: 771.923431ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:26.581501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:25.809277Z","time spent":"772.218507ms","remote":"127.0.0.1:48316","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-14T03:20:26.582025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:25.765302Z","time spent":"815.935943ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T03:20:26.939746Z","caller":"traceutil/trace.go:171","msg":"trace[562207622] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"352.16874ms","start":"2026-05-14T03:20:26.587535Z","end":"2026-05-14T03:20:26.939704Z","steps":["trace[562207622] 'process raft request' (duration: 340.292312ms)","trace[562207622] 'compare' (duration: 11.588983ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T03:20:26.939929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:26.587515Z","time spent":"352.323699ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T03:20:26.939929Z","caller":"traceutil/trace.go:171","msg":"trace[2062280268] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"352.376522ms","start":"2026-05-14T03:20:26.587535Z","end":"2026-05-14T03:20:26.939911Z","steps":["trace[2062280268] 'process raft request' (duration: 352.016992ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:26.940035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:26.587516Z","time spent":"352.460816ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T03:20:26.94022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.496452ms","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-14T03:20:26.940267Z","caller":"traceutil/trace.go:171","msg":"trace[1420165063] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:423; }","duration":"287.582617ms","start":"2026-05-14T03:20:26.652674Z","end":"2026-05-14T03:20:26.940256Z","steps":["trace[1420165063] 'agreement among raft nodes before linearized reading' (duration: 287.496403ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:20:26.939862Z","caller":"traceutil/trace.go:171","msg":"trace[931348897] linearizableReadLoop","detail":"{readStateIndex:437; appliedIndex:435; }","duration":"287.135513ms","start":"2026-05-14T03:20:26.652707Z","end":"2026-05-14T03:20:26.939842Z","steps":["trace[931348897] 'read index received' (duration: 275.158649ms)","trace[931348897] 'applied index is now lower than readState.Index' (duration: 11.975914ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T03:20:32.869256Z","caller":"traceutil/trace.go:171","msg":"trace[881763853] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"152.542925ms","start":"2026-05-14T03:20:32.716678Z","end":"2026-05-14T03:20:32.86922Z","steps":["trace[881763853] 'process raft request' (duration: 152.428539ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:20:33.631255Z","caller":"traceutil/trace.go:171","msg":"trace[182987135] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"868.880563ms","start":"2026-05-14T03:20:32.762342Z","end":"2026-05-14T03:20:33.631223Z","steps":["trace[182987135] 'process raft request' (duration: 868.547535ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:20:33.631404Z","caller":"traceutil/trace.go:171","msg":"trace[161398157] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"786.887231ms","start":"2026-05-14T03:20:32.844491Z","end":"2026-05-14T03:20:33.631378Z","steps":["trace[161398157] 'process raft request' (duration: 786.594494ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:33.631482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:32.762314Z","time spent":"869.028732ms","remote":"127.0.0.1:48086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T03:20:33.631613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:32.844422Z","time spent":"787.098483ms","remote":"127.0.0.1:48086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T03:20:33.632461Z","caller":"traceutil/trace.go:171","msg":"trace[653129367] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"771.531019ms","start":"2026-05-14T03:20:32.860915Z","end":"2026-05-14T03:20:33.632446Z","steps":["trace[653129367] 'process raft request' (duration: 770.97956ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:33.632557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:32.860897Z","time spent":"771.608313ms","remote":"127.0.0.1:48086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T03:20:33.632966Z","caller":"traceutil/trace.go:171","msg":"trace[2130726576] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:566; }","duration":"782.99792ms","start":"2026-05-14T03:20:32.849249Z","end":"2026-05-14T03:20:33.632247Z","steps":["trace[2130726576] 'read index received' (duration: 19.970462ms)","trace[2130726576] 'applied index is now lower than readState.Index' (duration: 763.026678ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T03:20:33.633297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"784.030827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570105"} {"level":"info","ts":"2026-05-14T03:20:33.633355Z","caller":"traceutil/trace.go:171","msg":"trace[442185520] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:551; }","duration":"784.140872ms","start":"2026-05-14T03:20:32.849199Z","end":"2026-05-14T03:20:33.63334Z","steps":["trace[442185520] 'agreement among raft nodes before linearized reading' (duration: 783.817665ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:33.633396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:32.849188Z","time spent":"784.199116ms","remote":"127.0.0.1:48086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":570128,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" "} {"level":"info","ts":"2026-05-14T03:20:33.641932Z","caller":"traceutil/trace.go:171","msg":"trace[1031433209] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"401.843396ms","start":"2026-05-14T03:20:33.240076Z","end":"2026-05-14T03:20:33.641919Z","steps":["trace[1031433209] 'process raft request' (duration: 401.633035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:33.642027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:33.240052Z","time spent":"401.91584ms","remote":"127.0.0.1:48086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T03:20:33.642151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.81507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-4pqsk\" ","response":"range_response_count:1 size:4683"} {"level":"info","ts":"2026-05-14T03:20:33.642172Z","caller":"traceutil/trace.go:171","msg":"trace[42004173] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-4pqsk; range_end:; response_count:1; response_revision:553; }","duration":"438.880384ms","start":"2026-05-14T03:20:33.203286Z","end":"2026-05-14T03:20:33.642167Z","steps":["trace[42004173] 'agreement among raft nodes before linearized reading' (duration: 438.812281ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:33.642238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:33.203056Z","time spent":"439.17775ms","remote":"127.0.0.1:48216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4706,"request content":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-4pqsk\" "} {"level":"info","ts":"2026-05-14T03:20:33.642351Z","caller":"traceutil/trace.go:171","msg":"trace[567928484] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"200.511316ms","start":"2026-05-14T03:20:33.441834Z","end":"2026-05-14T03:20:33.642345Z","steps":["trace[567928484] 'process raft request' (duration: 200.040591ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:33.6425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.913562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-14T03:20:33.642539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.470102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-14T03:20:33.642476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.764217ms","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-14T03:20:33.642567Z","caller":"traceutil/trace.go:171","msg":"trace[515803378] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:553; }","duration":"675.210522ms","start":"2026-05-14T03:20:32.967352Z","end":"2026-05-14T03:20:33.642563Z","steps":["trace[515803378] 'agreement among raft nodes before linearized reading' (duration: 674.581977ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:20:33.642578Z","caller":"traceutil/trace.go:171","msg":"trace[1812292000] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:553; }","duration":"603.539976ms","start":"2026-05-14T03:20:33.039021Z","end":"2026-05-14T03:20:33.642561Z","steps":["trace[1812292000] 'agreement among raft nodes before linearized reading' (duration: 603.496623ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:33.642587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:32.967329Z","time spent":"675.253135ms","remote":"127.0.0.1:48316","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-14T03:20:33.642607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:33.039002Z","time spent":"603.59951ms","remote":"127.0.0.1:48086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"warn","ts":"2026-05-14T03:20:33.642771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.595862ms","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-14T03:20:33.642793Z","caller":"traceutil/trace.go:171","msg":"trace[1744880706] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:553; }","duration":"663.630264ms","start":"2026-05-14T03:20:32.979157Z","end":"2026-05-14T03:20:33.642787Z","steps":["trace[1744880706] 'agreement among raft nodes before linearized reading' (duration: 663.590681ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:33.642809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:32.979149Z","time spent":"663.656325ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-14T03:20:33.642869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.460132ms","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-14T03:20:33.642887Z","caller":"traceutil/trace.go:171","msg":"trace[1567169050] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:553; }","duration":"672.518156ms","start":"2026-05-14T03:20:32.970364Z","end":"2026-05-14T03:20:33.642882Z","steps":["trace[1567169050] 'agreement among raft nodes before linearized reading' (duration: 672.488474ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:33.642902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:32.970341Z","time spent":"672.557559ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-14T03:20:33.642547Z","caller":"traceutil/trace.go:171","msg":"trace[1677752704] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:553; }","duration":"156.973175ms","start":"2026-05-14T03:20:33.485545Z","end":"2026-05-14T03:20:33.642518Z","steps":["trace[1677752704] 'agreement among raft nodes before linearized reading' (duration: 156.938902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:33.964603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.737837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:23081"} {"level":"info","ts":"2026-05-14T03:20:33.964664Z","caller":"traceutil/trace.go:171","msg":"trace[1999880389] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:562; }","duration":"124.829761ms","start":"2026-05-14T03:20:33.839819Z","end":"2026-05-14T03:20:33.964649Z","steps":["trace[1999880389] 'range keys from in-memory index tree' (duration: 124.601589ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:20:33.965889Z","caller":"traceutil/trace.go:171","msg":"trace[557705919] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"125.526588ms","start":"2026-05-14T03:20:33.840347Z","end":"2026-05-14T03:20:33.965874Z","steps":["trace[557705919] 'process raft request' (duration: 125.446734ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:20:33.97366Z","caller":"traceutil/trace.go:171","msg":"trace[1813449955] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"132.700108ms","start":"2026-05-14T03:20:33.840945Z","end":"2026-05-14T03:20:33.973645Z","steps":["trace[1813449955] 'process raft request' (duration: 132.510988ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:34.591853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.220003ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T03:20:34.591979Z","caller":"traceutil/trace.go:171","msg":"trace[1515768183] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"418.475129ms","start":"2026-05-14T03:20:34.173467Z","end":"2026-05-14T03:20:34.591942Z","steps":["trace[1515768183] 'process raft request' (duration: 223.969312ms)","trace[1515768183] 'compare' (duration: 194.097167ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T03:20:34.592047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:34.173451Z","time spent":"418.566283ms","remote":"127.0.0.1:48086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4156,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T03:20:34.602216Z","caller":"traceutil/trace.go:171","msg":"trace[229084959] linearizableReadLoop","detail":"{readStateIndex:594; appliedIndex:592; }","duration":"363.251383ms","start":"2026-05-14T03:20:34.238942Z","end":"2026-05-14T03:20:34.602193Z","steps":["trace[229084959] 'read index received' (duration: 158.458826ms)","trace[229084959] 'applied index is now lower than readState.Index' (duration: 204.791747ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T03:20:34.602437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.475563ms","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-14T03:20:34.602451Z","caller":"traceutil/trace.go:171","msg":"trace[127705477] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"272.084171ms","start":"2026-05-14T03:20:34.330334Z","end":"2026-05-14T03:20:34.602418Z","steps":["trace[127705477] 'process raft request' (duration: 271.731955ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:20:34.602533Z","caller":"traceutil/trace.go:171","msg":"trace[261669381] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"411.33145ms","start":"2026-05-14T03:20:34.191169Z","end":"2026-05-14T03:20:34.602501Z","steps":["trace[261669381] 'process raft request' (duration: 410.766955ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:20:34.602551Z","caller":"traceutil/trace.go:171","msg":"trace[1779399694] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:577; }","duration":"363.603909ms","start":"2026-05-14T03:20:34.2389Z","end":"2026-05-14T03:20:34.602504Z","steps":["trace[1779399694] 'agreement among raft nodes before linearized reading' (duration: 363.483493ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:34.602661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:34.238882Z","time spent":"363.767586ms","remote":"127.0.0.1:48086","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-14T03:20:34.602685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:34.191139Z","time spent":"411.455677ms","remote":"127.0.0.1:48086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13214,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T03:20:34.61161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.680322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-14T03:20:34.611631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.759988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:15688"} {"level":"info","ts":"2026-05-14T03:20:34.611679Z","caller":"traceutil/trace.go:171","msg":"trace[263599146] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:578; }","duration":"125.789917ms","start":"2026-05-14T03:20:34.48587Z","end":"2026-05-14T03:20:34.61166Z","steps":["trace[263599146] 'agreement among raft nodes before linearized reading' (duration: 125.670112ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:20:34.611698Z","caller":"traceutil/trace.go:171","msg":"trace[125947975] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:578; }","duration":"337.887094ms","start":"2026-05-14T03:20:34.273792Z","end":"2026-05-14T03:20:34.611679Z","steps":["trace[125947975] 'agreement among raft nodes before linearized reading' (duration: 337.713797ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:34.611667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.538394ms","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":"warn","ts":"2026-05-14T03:20:34.611756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:34.273775Z","time spent":"337.971988ms","remote":"127.0.0.1:48086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":15711,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io\" "} {"level":"info","ts":"2026-05-14T03:20:34.611755Z","caller":"traceutil/trace.go:171","msg":"trace[997188974] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:578; }","duration":"172.678761ms","start":"2026-05-14T03:20:34.439058Z","end":"2026-05-14T03:20:34.611736Z","steps":["trace[997188974] 'agreement among raft nodes before linearized reading' (duration: 172.537735ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:20:37.032687Z","caller":"traceutil/trace.go:171","msg":"trace[822774167] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"182.379283ms","start":"2026-05-14T03:20:36.850284Z","end":"2026-05-14T03:20:37.032664Z","steps":["trace[822774167] 'process raft request' (duration: 181.380322ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:39.869799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.881195ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T03:20:39.869983Z","caller":"traceutil/trace.go:171","msg":"trace[377165010] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"185.852175ms","start":"2026-05-14T03:20:39.684113Z","end":"2026-05-14T03:20:39.869965Z","steps":["trace[377165010] 'process raft request' (duration: 185.792306ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:20:39.869989Z","caller":"traceutil/trace.go:171","msg":"trace[1526591413] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"187.166623ms","start":"2026-05-14T03:20:39.682794Z","end":"2026-05-14T03:20:39.86996Z","steps":["trace[1526591413] 'process raft request' (duration: 40.029972ms)","trace[1526591413] 'compare' (duration: 146.730148ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T03:20:39.870071Z","caller":"traceutil/trace.go:171","msg":"trace[849979997] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"186.17448ms","start":"2026-05-14T03:20:39.683858Z","end":"2026-05-14T03:20:39.870032Z","steps":["trace[849979997] 'read index received' (duration: 39.01833ms)","trace[849979997] 'applied index is now lower than readState.Index' (duration: 147.1537ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T03:20:39.870293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.409597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-14T03:20:39.870334Z","caller":"traceutil/trace.go:171","msg":"trace[351550801] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:628; }","duration":"186.488165ms","start":"2026-05-14T03:20:39.683835Z","end":"2026-05-14T03:20:39.870323Z","steps":["trace[351550801] 'agreement among raft nodes before linearized reading' (duration: 186.344558ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:39.870508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.39455ms","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-14T03:20:39.870554Z","caller":"traceutil/trace.go:171","msg":"trace[1795306312] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:628; }","duration":"180.467288ms","start":"2026-05-14T03:20:39.690075Z","end":"2026-05-14T03:20:39.870542Z","steps":["trace[1795306312] 'agreement among raft nodes before linearized reading' (duration: 180.297171ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:42.419469Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153699228191829143,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-14T03:20:42.902845Z","caller":"traceutil/trace.go:171","msg":"trace[436012589] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"985.119983ms","start":"2026-05-14T03:20:41.917698Z","end":"2026-05-14T03:20:42.902818Z","steps":["trace[436012589] 'read index received' (duration: 886.143428ms)","trace[436012589] 'applied index is now lower than readState.Index' (duration: 98.975475ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T03:20:42.902943Z","caller":"traceutil/trace.go:171","msg":"trace[891160089] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"1.023007998s","start":"2026-05-14T03:20:41.879901Z","end":"2026-05-14T03:20:42.902909Z","steps":["trace[891160089] 'process raft request' (duration: 924.022224ms)","trace[891160089] 'compare' (duration: 98.701028ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T03:20:42.903074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"985.378079ms","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-14T03:20:42.903163Z","caller":"traceutil/trace.go:171","msg":"trace[256445868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:642; }","duration":"985.502997ms","start":"2026-05-14T03:20:41.917643Z","end":"2026-05-14T03:20:42.903146Z","steps":["trace[256445868] 'agreement among raft nodes before linearized reading' (duration: 985.26485ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:42.903131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:41.879893Z","time spent":"1.023123036s","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T03:20:42.903211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:41.91762Z","time spent":"985.581386ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-14T03:20:42.90338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.870708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-14T03:20:42.903517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.465362ms","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-14T03:20:42.90356Z","caller":"traceutil/trace.go:171","msg":"trace[2066433444] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:642; }","duration":"198.557411ms","start":"2026-05-14T03:20:42.704992Z","end":"2026-05-14T03:20:42.903549Z","steps":["trace[2066433444] 'agreement among raft nodes before linearized reading' (duration: 198.360674ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:20:42.903436Z","caller":"traceutil/trace.go:171","msg":"trace[1790297148] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"414.964827ms","start":"2026-05-14T03:20:42.488459Z","end":"2026-05-14T03:20:42.903423Z","steps":["trace[1790297148] 'agreement among raft nodes before linearized reading' (duration: 414.871088ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:42.903594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.626867ms","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-14T03:20:42.903636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:42.488438Z","time spent":"415.183683ms","remote":"127.0.0.1:48040","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-14T03:20:42.903662Z","caller":"traceutil/trace.go:171","msg":"trace[1115918879] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:642; }","duration":"163.752864ms","start":"2026-05-14T03:20:42.739884Z","end":"2026-05-14T03:20:42.903637Z","steps":["trace[1115918879] 'agreement among raft nodes before linearized reading' (duration: 163.457369ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:20:43.244697Z","caller":"traceutil/trace.go:171","msg":"trace[1392234786] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"334.121955ms","start":"2026-05-14T03:20:42.910538Z","end":"2026-05-14T03:20:43.24466Z","steps":["trace[1392234786] 'process raft request' (duration: 296.842698ms)","trace[1392234786] 'compare' (duration: 37.122599ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T03:20:43.244923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:42.910519Z","time spent":"334.281033ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T03:20:43.276504Z","caller":"traceutil/trace.go:171","msg":"trace[735262193] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"365.558509ms","start":"2026-05-14T03:20:42.910913Z","end":"2026-05-14T03:20:43.276471Z","steps":["trace[735262193] 'process raft request' (duration: 365.349012ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:43.276682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:42.910896Z","time spent":"365.693588ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T03:20:43.276731Z","caller":"traceutil/trace.go:171","msg":"trace[1227801021] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"365.634949ms","start":"2026-05-14T03:20:42.911068Z","end":"2026-05-14T03:20:43.276703Z","steps":["trace[1227801021] 'process raft request' (duration: 365.356092ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:43.276887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:42.911028Z","time spent":"365.773407ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T03:20:44.215887Z","caller":"traceutil/trace.go:171","msg":"trace[2086958694] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"319.988383ms","start":"2026-05-14T03:20:43.895874Z","end":"2026-05-14T03:20:44.215862Z","steps":["trace[2086958694] 'process raft request' (duration: 319.807065ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:44.216056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:43.895857Z","time spent":"320.10972ms","remote":"127.0.0.1:48316","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-14T03:20:44.855252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.627789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T03:20:44.855365Z","caller":"traceutil/trace.go:171","msg":"trace[433633950] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"368.797537ms","start":"2026-05-14T03:20:44.486547Z","end":"2026-05-14T03:20:44.855345Z","steps":["trace[433633950] 'range keys from in-memory index tree' (duration: 368.55075ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:20:44.855411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:20:44.486526Z","time spent":"368.876177ms","remote":"127.0.0.1:48040","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-14T03:21:00.569617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.370214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-cmstg\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-14T03:21:00.569705Z","caller":"traceutil/trace.go:171","msg":"trace[1843582977] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-cmstg; range_end:; response_count:1; response_revision:760; }","duration":"229.509414ms","start":"2026-05-14T03:21:00.340175Z","end":"2026-05-14T03:21:00.569684Z","steps":["trace[1843582977] 'range keys from in-memory index tree' (duration: 229.179504ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:21:00.569818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.975881ms","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-14T03:21:00.569878Z","caller":"traceutil/trace.go:171","msg":"trace[1423585856] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:760; }","duration":"285.035711ms","start":"2026-05-14T03:21:00.284829Z","end":"2026-05-14T03:21:00.569865Z","steps":["trace[1423585856] 'range keys from in-memory index tree' (duration: 284.849351ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:21:07.589722Z","caller":"traceutil/trace.go:171","msg":"trace[1305821867] linearizableReadLoop","detail":"{readStateIndex:856; appliedIndex:855; }","duration":"103.85304ms","start":"2026-05-14T03:21:07.485836Z","end":"2026-05-14T03:21:07.589689Z","steps":["trace[1305821867] 'read index received' (duration: 48.596715ms)","trace[1305821867] 'applied index is now lower than readState.Index' (duration: 55.254985ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T03:21:07.589777Z","caller":"traceutil/trace.go:171","msg":"trace[1434048435] transaction","detail":"{read_only:false; response_revision:830; number_of_response:1; }","duration":"174.065953ms","start":"2026-05-14T03:21:07.41567Z","end":"2026-05-14T03:21:07.589736Z","steps":["trace[1434048435] 'process raft request' (duration: 118.844608ms)","trace[1434048435] 'compare' (duration: 54.822673ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T03:21:07.589925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.066071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T03:21:07.590001Z","caller":"traceutil/trace.go:171","msg":"trace[1565991691] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:830; }","duration":"104.205881ms","start":"2026-05-14T03:21:07.485782Z","end":"2026-05-14T03:21:07.589987Z","steps":["trace[1565991691] 'agreement among raft nodes before linearized reading' (duration: 104.02697ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:21:07.894168Z","caller":"traceutil/trace.go:171","msg":"trace[1204754659] transaction","detail":"{read_only:false; response_revision:833; number_of_response:1; }","duration":"159.488946ms","start":"2026-05-14T03:21:07.734643Z","end":"2026-05-14T03:21:07.894132Z","steps":["trace[1204754659] 'process raft request' (duration: 127.271457ms)","trace[1204754659] 'compare' (duration: 31.866678ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T03:21:07.894217Z","caller":"traceutil/trace.go:171","msg":"trace[2036764317] linearizableReadLoop","detail":"{readStateIndex:859; appliedIndex:857; }","duration":"154.630158ms","start":"2026-05-14T03:21:07.739556Z","end":"2026-05-14T03:21:07.894187Z","steps":["trace[2036764317] 'read index received' (duration: 60.946098ms)","trace[2036764317] 'applied index is now lower than readState.Index' (duration: 93.68272ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T03:21:07.894409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.824759ms","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":"info","ts":"2026-05-14T03:21:07.894452Z","caller":"traceutil/trace.go:171","msg":"trace[1746512582] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:834; }","duration":"154.914489ms","start":"2026-05-14T03:21:07.739527Z","end":"2026-05-14T03:21:07.894441Z","steps":["trace[1746512582] 'agreement among raft nodes before linearized reading' (duration: 154.813008ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:21:07.894203Z","caller":"traceutil/trace.go:171","msg":"trace[1058086202] transaction","detail":"{read_only:false; response_revision:834; number_of_response:1; }","duration":"154.437597ms","start":"2026-05-14T03:21:07.739724Z","end":"2026-05-14T03:21:07.894161Z","steps":["trace[1058086202] 'process raft request' (duration: 154.251616ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:21:08.278966Z","caller":"traceutil/trace.go:171","msg":"trace[655121231] transaction","detail":"{read_only:false; response_revision:839; number_of_response:1; }","duration":"156.908513ms","start":"2026-05-14T03:21:08.122027Z","end":"2026-05-14T03:21:08.278936Z","steps":["trace[655121231] 'process raft request' (duration: 156.751072ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:21:11.823341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.087882ms","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-14T03:21:11.823442Z","caller":"traceutil/trace.go:171","msg":"trace[795972939] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:882; }","duration":"220.216383ms","start":"2026-05-14T03:21:11.603192Z","end":"2026-05-14T03:21:11.823408Z","steps":["trace[795972939] 'range keys from in-memory index tree' (duration: 219.841339ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:21:31.772365Z","caller":"traceutil/trace.go:171","msg":"trace[1129054473] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"392.672576ms","start":"2026-05-14T03:21:31.37967Z","end":"2026-05-14T03:21:31.772343Z","steps":["trace[1129054473] 'process raft request' (duration: 392.561913ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:21:31.772528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:21:31.379653Z","time spent":"392.806518ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T03:21:31.772718Z","caller":"traceutil/trace.go:171","msg":"trace[646237165] linearizableReadLoop","detail":"{readStateIndex:1019; appliedIndex:1018; }","duration":"394.46783ms","start":"2026-05-14T03:21:31.378238Z","end":"2026-05-14T03:21:31.772706Z","steps":["trace[646237165] 'read index received' (duration: 392.134485ms)","trace[646237165] 'applied index is now lower than readState.Index' (duration: 2.332245ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T03:21:31.772974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.729635ms","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-14T03:21:31.773016Z","caller":"traceutil/trace.go:171","msg":"trace[1233472005] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:987; }","duration":"394.779695ms","start":"2026-05-14T03:21:31.378225Z","end":"2026-05-14T03:21:31.773005Z","steps":["trace[1233472005] 'agreement among raft nodes before linearized reading' (duration: 394.670063ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:21:31.77305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:21:31.37822Z","time spent":"394.823106ms","remote":"127.0.0.1:48316","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-14T03:21:32.490146Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153699228191829829,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T03:21:32.990454Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153699228191829829,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T03:21:33.103828Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.32125554s","expected-duration":"1s"} {"level":"info","ts":"2026-05-14T03:21:33.106596Z","caller":"traceutil/trace.go:171","msg":"trace[1041338491] linearizableReadLoop","detail":"{readStateIndex:1023; appliedIndex:1022; }","duration":"1.117363866s","start":"2026-05-14T03:21:31.989207Z","end":"2026-05-14T03:21:33.106571Z","steps":["trace[1041338491] 'read index received' (duration: 1.114748154s)","trace[1041338491] 'applied index is now lower than readState.Index' (duration: 2.614932ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T03:21:33.106615Z","caller":"traceutil/trace.go:171","msg":"trace[1044031303] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"1.324129936s","start":"2026-05-14T03:21:31.782458Z","end":"2026-05-14T03:21:33.106588Z","steps":["trace[1044031303] 'process raft request' (duration: 1.321549845s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:21:33.106758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:21:31.782379Z","time spent":"1.324295621s","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T03:21:33.10678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.771113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-14T03:21:33.106809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.117603771s","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-14T03:21:33.106836Z","caller":"traceutil/trace.go:171","msg":"trace[410390560] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:990; }","duration":"623.871504ms","start":"2026-05-14T03:21:32.482947Z","end":"2026-05-14T03:21:33.106818Z","steps":["trace[410390560] 'agreement among raft nodes before linearized reading' (duration: 623.769562ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:21:33.106863Z","caller":"traceutil/trace.go:171","msg":"trace[1227661954] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:990; }","duration":"1.117690823s","start":"2026-05-14T03:21:31.989156Z","end":"2026-05-14T03:21:33.106847Z","steps":["trace[1227661954] 'agreement among raft nodes before linearized reading' (duration: 1.11753024s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:21:33.10687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:21:32.482928Z","time spent":"623.934366ms","remote":"127.0.0.1:48040","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-14T03:21:33.106997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:21:31.989143Z","time spent":"1.117735673s","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-14T03:22:47.822528Z","caller":"traceutil/trace.go:171","msg":"trace[62645169] linearizableReadLoop","detail":"{readStateIndex:1322; appliedIndex:1321; }","duration":"103.181459ms","start":"2026-05-14T03:22:47.719331Z","end":"2026-05-14T03:22:47.822512Z","steps":["trace[62645169] 'read index received' (duration: 103.117256ms)","trace[62645169] 'applied index is now lower than readState.Index' (duration: 63.303µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T03:22:47.822673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.330514ms","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-14T03:22:47.822713Z","caller":"traceutil/trace.go:171","msg":"trace[1625986418] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1273; }","duration":"103.379026ms","start":"2026-05-14T03:22:47.719322Z","end":"2026-05-14T03:22:47.822701Z","steps":["trace[1625986418] 'agreement among raft nodes before linearized reading' (duration: 103.262062ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:22:47.822711Z","caller":"traceutil/trace.go:171","msg":"trace[1154743121] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"161.782417ms","start":"2026-05-14T03:22:47.660907Z","end":"2026-05-14T03:22:47.82269Z","steps":["trace[1154743121] 'process raft request' (duration: 161.508166ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:22:48.538075Z","caller":"traceutil/trace.go:171","msg":"trace[404192615] linearizableReadLoop","detail":"{readStateIndex:1324; appliedIndex:1323; }","duration":"230.270939ms","start":"2026-05-14T03:22:48.307781Z","end":"2026-05-14T03:22:48.538052Z","steps":["trace[404192615] 'read index received' (duration: 230.04606ms)","trace[404192615] 'applied index is now lower than readState.Index' (duration: 223.339µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T03:22:48.53829Z","caller":"traceutil/trace.go:171","msg":"trace[1626445870] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"234.1515ms","start":"2026-05-14T03:22:48.304104Z","end":"2026-05-14T03:22:48.538256Z","steps":["trace[1626445870] 'process raft request' (duration: 233.800566ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:22:48.538348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.55202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-14T03:22:48.538433Z","caller":"traceutil/trace.go:171","msg":"trace[614813835] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1275; }","duration":"230.689706ms","start":"2026-05-14T03:22:48.307724Z","end":"2026-05-14T03:22:48.538414Z","steps":["trace[614813835] 'agreement among raft nodes before linearized reading' (duration: 230.455576ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:22:50.182606Z","caller":"traceutil/trace.go:171","msg":"trace[1351128455] linearizableReadLoop","detail":"{readStateIndex:1328; appliedIndex:1327; }","duration":"337.996079ms","start":"2026-05-14T03:22:49.844588Z","end":"2026-05-14T03:22:50.182584Z","steps":["trace[1351128455] 'read index received' (duration: 337.777471ms)","trace[1351128455] 'applied index is now lower than readState.Index' (duration: 217.548µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T03:22:50.182679Z","caller":"traceutil/trace.go:171","msg":"trace[1761665177] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"346.610926ms","start":"2026-05-14T03:22:49.836034Z","end":"2026-05-14T03:22:50.182645Z","steps":["trace[1761665177] 'process raft request' (duration: 346.416428ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:22:50.182818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:22:49.836014Z","time spent":"346.73012ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T03:22:50.18286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.235428ms","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-14T03:22:50.182928Z","caller":"traceutil/trace.go:171","msg":"trace[1379961913] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1279; }","duration":"338.336043ms","start":"2026-05-14T03:22:49.844571Z","end":"2026-05-14T03:22:50.182907Z","steps":["trace[1379961913] 'agreement among raft nodes before linearized reading' (duration: 338.141855ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:22:50.182983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T03:22:49.844565Z","time spent":"338.404435ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-14T03:22:51.649036Z","caller":"traceutil/trace.go:171","msg":"trace[1027495064] linearizableReadLoop","detail":"{readStateIndex:1334; appliedIndex:1333; }","duration":"161.188299ms","start":"2026-05-14T03:22:51.487828Z","end":"2026-05-14T03:22:51.649016Z","steps":["trace[1027495064] 'read index received' (duration: 161.020882ms)","trace[1027495064] 'applied index is now lower than readState.Index' (duration: 166.817µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T03:22:51.649148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.301783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T03:22:51.649133Z","caller":"traceutil/trace.go:171","msg":"trace[2121571183] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"161.379275ms","start":"2026-05-14T03:22:51.487707Z","end":"2026-05-14T03:22:51.649086Z","steps":["trace[2121571183] 'process raft request' (duration: 161.204259ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:22:51.649171Z","caller":"traceutil/trace.go:171","msg":"trace[1635663145] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1284; }","duration":"161.341284ms","start":"2026-05-14T03:22:51.487821Z","end":"2026-05-14T03:22:51.649163Z","steps":["trace[1635663145] 'agreement among raft nodes before linearized reading' (duration: 161.266322ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T03:22:51.870307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.785907ms","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-14T03:22:51.870391Z","caller":"traceutil/trace.go:171","msg":"trace[570085919] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1284; }","duration":"170.926242ms","start":"2026-05-14T03:22:51.699444Z","end":"2026-05-14T03:22:51.870371Z","steps":["trace[570085919] 'range keys from in-memory index tree' (duration: 170.440013ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T03:22:56.454367Z","caller":"traceutil/trace.go:171","msg":"trace[1822928026] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"126.756009ms","start":"2026-05-14T03:22:56.327582Z","end":"2026-05-14T03:22:56.454338Z","steps":["trace[1822928026] 'process raft request' (duration: 103.823263ms)","trace[1822928026] 'compare' (duration: 22.77345ms)"],"step_count":2}