{"level":"warn","ts":"2026-05-12T11:24:27.144465Z","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-12T11:24:27.144564Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.121:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.121:2380","--initial-cluster=instance=https://199.19.213.121:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.121:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.121: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-12T11:24:27.144633Z","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-12T11:24:27.144644Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.121:2380"]} {"level":"info","ts":"2026-05-12T11:24:27.14466Z","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-12T11:24:27.145278Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.121:2379"]} {"level":"info","ts":"2026-05-12T11:24:27.145349Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.121:2380"],"listen-peer-urls":["https://199.19.213.121:2380"],"advertise-client-urls":["https://199.19.213.121:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.121:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.121: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-12T11:24:27.149888Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.279283ms"} {"level":"info","ts":"2026-05-12T11:24:27.156616Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"31541ae44470b70","cluster-id":"8ae2d89c48d1447d"} {"level":"info","ts":"2026-05-12T11:24:27.156702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 switched to configuration voters=()"} {"level":"info","ts":"2026-05-12T11:24:27.156722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 became follower at term 0"} {"level":"info","ts":"2026-05-12T11:24:27.156739Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 31541ae44470b70 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-12T11:24:27.156748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 became follower at term 1"} {"level":"info","ts":"2026-05-12T11:24:27.156785Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 switched to configuration voters=(222155973350329200)"} {"level":"warn","ts":"2026-05-12T11:24:27.163884Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-12T11:24:27.165318Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-12T11:24:27.166565Z","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-12T11:24:27.168772Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"31541ae44470b70","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-12T11:24:27.168943Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"31541ae44470b70","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-12T11:24:27.16903Z","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-12T11:24:27.16913Z","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-12T11:24:27.169147Z","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-12T11:24:27.172639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 switched to configuration voters=(222155973350329200)"} {"level":"info","ts":"2026-05-12T11:24:27.172979Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8ae2d89c48d1447d","local-member-id":"31541ae44470b70","added-peer-id":"31541ae44470b70","added-peer-peer-urls":["https://199.19.213.121:2380"]} {"level":"info","ts":"2026-05-12T11:24:27.174767Z","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-12T11:24:27.175155Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"31541ae44470b70","initial-advertise-peer-urls":["https://199.19.213.121:2380"],"listen-peer-urls":["https://199.19.213.121:2380"],"advertise-client-urls":["https://199.19.213.121:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.121:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-12T11:24:27.175246Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-12T11:24:27.176538Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.121:2380"} {"level":"info","ts":"2026-05-12T11:24:27.176688Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.121:2380"} {"level":"info","ts":"2026-05-12T11:24:27.957187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 is starting a new election at term 1"} {"level":"info","ts":"2026-05-12T11:24:27.957266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-12T11:24:27.95729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 received MsgPreVoteResp from 31541ae44470b70 at term 1"} {"level":"info","ts":"2026-05-12T11:24:27.957318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 became candidate at term 2"} {"level":"info","ts":"2026-05-12T11:24:27.957333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 received MsgVoteResp from 31541ae44470b70 at term 2"} {"level":"info","ts":"2026-05-12T11:24:27.957344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 became leader at term 2"} {"level":"info","ts":"2026-05-12T11:24:27.957357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 31541ae44470b70 elected leader 31541ae44470b70 at term 2"} {"level":"info","ts":"2026-05-12T11:24:27.958362Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"31541ae44470b70","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.121:2379]}","request-path":"/0/members/31541ae44470b70/attributes","cluster-id":"8ae2d89c48d1447d","publish-timeout":"7s"} {"level":"info","ts":"2026-05-12T11:24:27.958401Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-12T11:24:27.958738Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:24:27.959746Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-12T11:24:27.960156Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-12T11:24:27.960179Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-12T11:24:27.961776Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-12T11:24:27.963025Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.121:2379"} {"level":"info","ts":"2026-05-12T11:24:27.973269Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8ae2d89c48d1447d","local-member-id":"31541ae44470b70","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:24:27.974031Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:24:27.974103Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-05-12T11:24:31.849285Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824332574609282544,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-12T11:24:32.284341Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.013859939s","expected-duration":"1s"} {"level":"info","ts":"2026-05-12T11:24:32.284806Z","caller":"traceutil/trace.go:171","msg":"trace[112807610] linearizableReadLoop","detail":"{readStateIndex:208; appliedIndex:207; }","duration":"936.410183ms","start":"2026-05-12T11:24:31.348365Z","end":"2026-05-12T11:24:32.284775Z","steps":["trace[112807610] 'read index received' (duration: 936.177921ms)","trace[112807610] 'applied index is now lower than readState.Index' (duration: 230.992µs)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:24:32.284929Z","caller":"traceutil/trace.go:171","msg":"trace[1472139170] transaction","detail":"{read_only:false; response_revision:203; number_of_response:1; }","duration":"1.014550104s","start":"2026-05-12T11:24:31.270364Z","end":"2026-05-12T11:24:32.284915Z","steps":["trace[1472139170] 'process raft request' (duration: 1.014244922s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:24:32.285194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"936.811186ms","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-12T11:24:32.285286Z","caller":"traceutil/trace.go:171","msg":"trace[841138737] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:203; }","duration":"936.950036ms","start":"2026-05-12T11:24:31.348321Z","end":"2026-05-12T11:24:32.285271Z","steps":["trace[841138737] 'agreement among raft nodes before linearized reading' (duration: 936.702615ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:24:32.285321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:24:31.348301Z","time spent":"937.011767ms","remote":"127.0.0.1:35256","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-12T11:24:32.285367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"924.948927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-12T11:24:32.285546Z","caller":"traceutil/trace.go:171","msg":"trace[683664793] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:203; }","duration":"925.186228ms","start":"2026-05-12T11:24:31.360327Z","end":"2026-05-12T11:24:32.285513Z","steps":["trace[683664793] 'agreement among raft nodes before linearized reading' (duration: 924.647164ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:24:32.285559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:24:31.270343Z","time spent":"1.014633424s","remote":"127.0.0.1:35074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1069,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T11:24:32.285599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:24:31.360314Z","time spent":"925.273379ms","remote":"127.0.0.1:35256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-12T11:24:32.748264Z","caller":"traceutil/trace.go:171","msg":"trace[1926018784] transaction","detail":"{read_only:false; response_revision:205; number_of_response:1; }","duration":"457.788438ms","start":"2026-05-12T11:24:32.290402Z","end":"2026-05-12T11:24:32.748191Z","steps":["trace[1926018784] 'process raft request' (duration: 455.4435ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:24:32.748517Z","caller":"traceutil/trace.go:171","msg":"trace[511138333] transaction","detail":"{read_only:false; response_revision:207; number_of_response:1; }","duration":"425.958968ms","start":"2026-05-12T11:24:32.322513Z","end":"2026-05-12T11:24:32.748472Z","steps":["trace[511138333] 'process raft request' (duration: 425.840327ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:24:32.748709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:24:32.322491Z","time spent":"426.121939ms","remote":"127.0.0.1:35316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T11:24:32.748604Z","caller":"traceutil/trace.go:171","msg":"trace[136056247] transaction","detail":"{read_only:false; response_revision:206; number_of_response:1; }","duration":"457.908119ms","start":"2026-05-12T11:24:32.290584Z","end":"2026-05-12T11:24:32.748492Z","steps":["trace[136056247] 'process raft request' (duration: 457.531417ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:24:32.748945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:24:32.290375Z","time spent":"457.992279ms","remote":"127.0.0.1:35256","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-12T11:24:32.748983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:24:32.290577Z","time spent":"458.256392ms","remote":"127.0.0.1:35256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T11:25:01.067894Z","caller":"traceutil/trace.go:171","msg":"trace[802328343] linearizableReadLoop","detail":"{readStateIndex:535; appliedIndex:534; }","duration":"180.380265ms","start":"2026-05-12T11:25:00.887498Z","end":"2026-05-12T11:25:01.067878Z","steps":["trace[802328343] 'read index received' (duration: 180.283882ms)","trace[802328343] 'applied index is now lower than readState.Index' (duration: 95.823µs)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:25:01.067957Z","caller":"traceutil/trace.go:171","msg":"trace[1748441764] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"181.444546ms","start":"2026-05-12T11:25:00.88649Z","end":"2026-05-12T11:25:01.067935Z","steps":["trace[1748441764] 'process raft request' (duration: 181.28732ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:01.068164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.485221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.121\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-12T11:25:01.068207Z","caller":"traceutil/trace.go:171","msg":"trace[1494121803] range","detail":"{range_begin:/registry/masterleases/199.19.213.121; range_end:; response_count:1; response_revision:516; }","duration":"148.587165ms","start":"2026-05-12T11:25:00.919607Z","end":"2026-05-12T11:25:01.068194Z","steps":["trace[1494121803] 'agreement among raft nodes before linearized reading' (duration: 148.371987ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:01.068245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.743369ms","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-12T11:25:01.068271Z","caller":"traceutil/trace.go:171","msg":"trace[1355232020] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:516; }","duration":"180.780431ms","start":"2026-05-12T11:25:00.887483Z","end":"2026-05-12T11:25:01.068264Z","steps":["trace[1355232020] 'agreement among raft nodes before linearized reading' (duration: 180.47887ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:01.068268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.522616ms","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-12T11:25:01.068363Z","caller":"traceutil/trace.go:171","msg":"trace[1954110736] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:516; }","duration":"104.657141ms","start":"2026-05-12T11:25:00.963685Z","end":"2026-05-12T11:25:01.068343Z","steps":["trace[1954110736] 'agreement among raft nodes before linearized reading' (duration: 104.462304ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:01.711043Z","caller":"traceutil/trace.go:171","msg":"trace[1748175342] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"346.222276ms","start":"2026-05-12T11:25:01.364792Z","end":"2026-05-12T11:25:01.711014Z","steps":["trace[1748175342] 'process raft request' (duration: 346.010779ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:01.711259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:01.364771Z","time spent":"346.356221ms","remote":"127.0.0.1:35018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T11:25:01.720163Z","caller":"traceutil/trace.go:171","msg":"trace[763797310] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"195.954793ms","start":"2026-05-12T11:25:01.524186Z","end":"2026-05-12T11:25:01.720141Z","steps":["trace[763797310] 'process raft request' (duration: 195.900241ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:01.720544Z","caller":"traceutil/trace.go:171","msg":"trace[763445314] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"348.72868ms","start":"2026-05-12T11:25:01.371803Z","end":"2026-05-12T11:25:01.720531Z","steps":["trace[763445314] 'process raft request' (duration: 347.731773ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:01.720719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:01.371783Z","time spent":"348.796592ms","remote":"127.0.0.1:35018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T11:25:01.720853Z","caller":"traceutil/trace.go:171","msg":"trace[1978003391] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"330.892899ms","start":"2026-05-12T11:25:01.38993Z","end":"2026-05-12T11:25:01.720822Z","steps":["trace[1978003391] 'process raft request' (duration: 329.929682ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:01.720974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:01.389922Z","time spent":"330.994423ms","remote":"127.0.0.1:35018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T11:25:01.720999Z","caller":"traceutil/trace.go:171","msg":"trace[199668883] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"324.738292ms","start":"2026-05-12T11:25:01.396189Z","end":"2026-05-12T11:25:01.720927Z","steps":["trace[199668883] 'process raft request' (duration: 323.707713ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:01.721117Z","caller":"traceutil/trace.go:171","msg":"trace[2108041950] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"349.178146ms","start":"2026-05-12T11:25:01.371929Z","end":"2026-05-12T11:25:01.721107Z","steps":["trace[2108041950] 'process raft request' (duration: 347.751243ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:01.721119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:01.396177Z","time spent":"324.853515ms","remote":"127.0.0.1:35018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T11:25:01.721157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:01.371925Z","time spent":"349.215317ms","remote":"127.0.0.1:35018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T11:25:01.721235Z","caller":"traceutil/trace.go:171","msg":"trace[1684241835] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"339.702335ms","start":"2026-05-12T11:25:01.381527Z","end":"2026-05-12T11:25:01.721229Z","steps":["trace[1684241835] 'process raft request' (duration: 338.188918ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:01.721268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:01.381507Z","time spent":"339.746297ms","remote":"127.0.0.1:35018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T11:25:01.721341Z","caller":"traceutil/trace.go:171","msg":"trace[1377531450] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"333.757805ms","start":"2026-05-12T11:25:01.387577Z","end":"2026-05-12T11:25:01.721335Z","steps":["trace[1377531450] 'process raft request' (duration: 332.175456ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:01.72137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:01.387557Z","time spent":"333.801636ms","remote":"127.0.0.1:35018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T11:25:01.721419Z","caller":"traceutil/trace.go:171","msg":"trace[1647360122] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"332.577092ms","start":"2026-05-12T11:25:01.388837Z","end":"2026-05-12T11:25:01.721415Z","steps":["trace[1647360122] 'process raft request' (duration: 330.949641ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:01.721447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:01.388829Z","time spent":"332.605243ms","remote":"127.0.0.1:35018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T11:25:01.721492Z","caller":"traceutil/trace.go:171","msg":"trace[1162062399] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"331.630396ms","start":"2026-05-12T11:25:01.389857Z","end":"2026-05-12T11:25:01.721487Z","steps":["trace[1162062399] 'process raft request' (duration: 329.964914ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:01.721518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:01.389826Z","time spent":"331.681228ms","remote":"127.0.0.1:35018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T11:25:01.721604Z","caller":"traceutil/trace.go:171","msg":"trace[829126627] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"324.537704ms","start":"2026-05-12T11:25:01.397052Z","end":"2026-05-12T11:25:01.721589Z","steps":["trace[829126627] 'process raft request' (duration: 322.897473ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:01.721729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:01.397036Z","time spent":"324.606827ms","remote":"127.0.0.1:35018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T11:25:01.721877Z","caller":"traceutil/trace.go:171","msg":"trace[275954863] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"309.83908ms","start":"2026-05-12T11:25:01.412024Z","end":"2026-05-12T11:25:01.721863Z","steps":["trace[275954863] 'process raft request' (duration: 307.976281ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:01.721932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:01.411999Z","time spent":"309.909263ms","remote":"127.0.0.1:35018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T11:25:06.382141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.908655ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-12T11:25:06.382308Z","caller":"traceutil/trace.go:171","msg":"trace[667237168] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:636; }","duration":"128.091572ms","start":"2026-05-12T11:25:06.254204Z","end":"2026-05-12T11:25:06.382295Z","steps":["trace[667237168] 'read index received' (duration: 11.882617ms)","trace[667237168] 'applied index is now lower than readState.Index' (duration: 116.208165ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:25:06.382371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.164334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:25:06.382389Z","caller":"traceutil/trace.go:171","msg":"trace[374472903] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:614; }","duration":"128.208516ms","start":"2026-05-12T11:25:06.254175Z","end":"2026-05-12T11:25:06.382383Z","steps":["trace[374472903] 'agreement among raft nodes before linearized reading' (duration: 128.161414ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:06.382453Z","caller":"traceutil/trace.go:171","msg":"trace[1528623864] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"140.478975ms","start":"2026-05-12T11:25:06.24194Z","end":"2026-05-12T11:25:06.382419Z","steps":["trace[1528623864] 'process raft request' (duration: 140.276808ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:07.606668Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824332574609283349,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-12T11:25:07.683048Z","caller":"traceutil/trace.go:171","msg":"trace[50387091] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"576.901612ms","start":"2026-05-12T11:25:07.106129Z","end":"2026-05-12T11:25:07.68303Z","steps":["trace[50387091] 'read index received' (duration: 575.577977ms)","trace[50387091] 'applied index is now lower than readState.Index' (duration: 1.322995ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:25:07.683119Z","caller":"traceutil/trace.go:171","msg":"trace[1319949705] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"884.431617ms","start":"2026-05-12T11:25:06.798681Z","end":"2026-05-12T11:25:07.683113Z","steps":["trace[1319949705] 'process raft request' (duration: 883.494575ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:07.683185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:06.798656Z","time spent":"884.477709ms","remote":"127.0.0.1:35060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T11:25:07.683355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.226614ms","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-12T11:25:07.683375Z","caller":"traceutil/trace.go:171","msg":"trace[1987674383] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:615; }","duration":"577.247345ms","start":"2026-05-12T11:25:07.106122Z","end":"2026-05-12T11:25:07.68337Z","steps":["trace[1987674383] 'agreement among raft nodes before linearized reading' (duration: 577.169982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:07.683389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:07.106066Z","time spent":"577.320377ms","remote":"127.0.0.1:35256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-12T11:25:07.683487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.291686ms","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-12T11:25:07.683506Z","caller":"traceutil/trace.go:171","msg":"trace[1499136198] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:615; }","duration":"577.349698ms","start":"2026-05-12T11:25:07.106152Z","end":"2026-05-12T11:25:07.683502Z","steps":["trace[1499136198] 'agreement among raft nodes before linearized reading' (duration: 577.320847ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:07.683517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:07.10613Z","time spent":"577.385189ms","remote":"127.0.0.1:35256","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-12T11:25:07.683786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.13351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:25:07.68381Z","caller":"traceutil/trace.go:171","msg":"trace[1271082311] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:615; }","duration":"125.191272ms","start":"2026-05-12T11:25:07.558613Z","end":"2026-05-12T11:25:07.683805Z","steps":["trace[1271082311] 'agreement among raft nodes before linearized reading' (duration: 125.158921ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:07.683873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.289365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:25:07.68389Z","caller":"traceutil/trace.go:171","msg":"trace[9741250] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:615; }","duration":"125.308226ms","start":"2026-05-12T11:25:07.558578Z","end":"2026-05-12T11:25:07.683886Z","steps":["trace[9741250] 'agreement among raft nodes before linearized reading' (duration: 125.281345ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:07.683947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.618782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:25:07.683963Z","caller":"traceutil/trace.go:171","msg":"trace[285070009] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:615; }","duration":"256.651482ms","start":"2026-05-12T11:25:07.427308Z","end":"2026-05-12T11:25:07.683959Z","steps":["trace[285070009] 'agreement among raft nodes before linearized reading' (duration: 256.626611ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:07.684049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.215532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:25:07.684109Z","caller":"traceutil/trace.go:171","msg":"trace[1948518292] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:615; }","duration":"257.304315ms","start":"2026-05-12T11:25:07.4268Z","end":"2026-05-12T11:25:07.684104Z","steps":["trace[1948518292] 'agreement among raft nodes before linearized reading' (duration: 257.235283ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:07.684163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.956215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:25:07.684213Z","caller":"traceutil/trace.go:171","msg":"trace[2042562923] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"428.036788ms","start":"2026-05-12T11:25:07.256166Z","end":"2026-05-12T11:25:07.684203Z","steps":["trace[2042562923] 'agreement among raft nodes before linearized reading' (duration: 427.964625ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:07.68424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:07.256152Z","time spent":"428.082879ms","remote":"127.0.0.1:34960","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-12T11:25:07.684326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.228054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-05-12T11:25:07.684365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.896921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:25:07.684391Z","caller":"traceutil/trace.go:171","msg":"trace[453898175] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:615; }","duration":"305.953833ms","start":"2026-05-12T11:25:07.37843Z","end":"2026-05-12T11:25:07.684384Z","steps":["trace[453898175] 'agreement among raft nodes before linearized reading' (duration: 305.917111ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:07.684397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.646947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T11:25:07.684436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.683689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T11:25:07.684447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.86679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:25:07.684457Z","caller":"traceutil/trace.go:171","msg":"trace[423493455] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:615; }","duration":"257.70339ms","start":"2026-05-12T11:25:07.426749Z","end":"2026-05-12T11:25:07.684452Z","steps":["trace[423493455] 'agreement among raft nodes before linearized reading' (duration: 257.677158ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:07.684463Z","caller":"traceutil/trace.go:171","msg":"trace[266312838] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:615; }","duration":"306.69649ms","start":"2026-05-12T11:25:07.37774Z","end":"2026-05-12T11:25:07.684436Z","steps":["trace[266312838] 'agreement among raft nodes before linearized reading' (duration: 306.635396ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:07.68448Z","caller":"traceutil/trace.go:171","msg":"trace[329503168] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:615; }","duration":"324.921572ms","start":"2026-05-12T11:25:07.359545Z","end":"2026-05-12T11:25:07.684467Z","steps":["trace[329503168] 'agreement among raft nodes before linearized reading' (duration: 324.881469ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:07.684505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:07.359534Z","time spent":"324.964063ms","remote":"127.0.0.1:41990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-12T11:25:07.684511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:07.377695Z","time spent":"306.806844ms","remote":"127.0.0.1:41994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-12T11:25:07.685239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.655503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:25:07.685299Z","caller":"traceutil/trace.go:171","msg":"trace[26162047] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:615; }","duration":"307.718454ms","start":"2026-05-12T11:25:07.377558Z","end":"2026-05-12T11:25:07.685276Z","steps":["trace[26162047] 'agreement among raft nodes before linearized reading' (duration: 307.649192ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:07.685326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:07.377549Z","time spent":"307.769947ms","remote":"127.0.0.1:41994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"info","ts":"2026-05-12T11:25:07.684396Z","caller":"traceutil/trace.go:171","msg":"trace[1338431448] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:615; }","duration":"577.334097ms","start":"2026-05-12T11:25:07.107042Z","end":"2026-05-12T11:25:07.684376Z","steps":["trace[1338431448] 'agreement among raft nodes before linearized reading' (duration: 577.195133ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:07.685447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:07.107022Z","time spent":"578.417926ms","remote":"127.0.0.1:35256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-12T11:25:07.685792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.630777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:25:07.685834Z","caller":"traceutil/trace.go:171","msg":"trace[1409248440] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:615; }","duration":"357.699939ms","start":"2026-05-12T11:25:07.328122Z","end":"2026-05-12T11:25:07.685822Z","steps":["trace[1409248440] 'agreement among raft nodes before linearized reading' (duration: 357.631077ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:07.684325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.942697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T11:25:07.685871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:07.328049Z","time spent":"357.815373ms","remote":"127.0.0.1:41980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"info","ts":"2026-05-12T11:25:07.685902Z","caller":"traceutil/trace.go:171","msg":"trace[525911761] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:615; }","duration":"325.562813ms","start":"2026-05-12T11:25:07.360317Z","end":"2026-05-12T11:25:07.68588Z","steps":["trace[525911761] 'agreement among raft nodes before linearized reading' (duration: 323.892765ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:07.685934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:07.360301Z","time spent":"325.623046ms","remote":"127.0.0.1:41990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-05-12T11:25:07.685977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.816382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:25:07.686009Z","caller":"traceutil/trace.go:171","msg":"trace[1820773904] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:615; }","duration":"357.874475ms","start":"2026-05-12T11:25:07.328121Z","end":"2026-05-12T11:25:07.685996Z","steps":["trace[1820773904] 'agreement among raft nodes before linearized reading' (duration: 357.837964ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:07.686029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:07.328099Z","time spent":"357.925426ms","remote":"127.0.0.1:41980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-12T11:25:07.684411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:07.378413Z","time spent":"305.992915ms","remote":"127.0.0.1:41994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-12T11:25:07.684402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.740564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:25:07.686538Z","caller":"traceutil/trace.go:171","msg":"trace[1416932644] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:615; }","duration":"326.91861ms","start":"2026-05-12T11:25:07.359608Z","end":"2026-05-12T11:25:07.686527Z","steps":["trace[1416932644] 'agreement among raft nodes before linearized reading' (duration: 324.770086ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:07.686578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:07.359586Z","time spent":"326.981642ms","remote":"127.0.0.1:41990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"info","ts":"2026-05-12T11:25:09.373213Z","caller":"traceutil/trace.go:171","msg":"trace[1272887209] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"117.109136ms","start":"2026-05-12T11:25:09.25605Z","end":"2026-05-12T11:25:09.373159Z","steps":["trace[1272887209] 'read index received' (duration: 109.53609ms)","trace[1272887209] 'applied index is now lower than readState.Index' (duration: 7.572186ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:25:09.373291Z","caller":"traceutil/trace.go:171","msg":"trace[986003653] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"645.934415ms","start":"2026-05-12T11:25:08.727323Z","end":"2026-05-12T11:25:09.373257Z","steps":["trace[986003653] 'process raft request' (duration: 639.537129ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:09.373333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.272992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:25:09.373369Z","caller":"traceutil/trace.go:171","msg":"trace[868928284] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"117.322843ms","start":"2026-05-12T11:25:09.256034Z","end":"2026-05-12T11:25:09.373357Z","steps":["trace[868928284] 'agreement among raft nodes before linearized reading' (duration: 117.246721ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:09.373436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:08.727289Z","time spent":"646.071051ms","remote":"127.0.0.1:35060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036297,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T11:25:09.674385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.492886ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-12T11:25:09.674495Z","caller":"traceutil/trace.go:171","msg":"trace[646072291] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"233.006403ms","start":"2026-05-12T11:25:09.441469Z","end":"2026-05-12T11:25:09.674475Z","steps":["trace[646072291] 'process raft request' (duration: 111.33331ms)","trace[646072291] 'compare' (duration: 121.29058ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:25:10.520691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.491999ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-12T11:25:10.520784Z","caller":"traceutil/trace.go:171","msg":"trace[1630997954] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"644.319708ms","start":"2026-05-12T11:25:09.876447Z","end":"2026-05-12T11:25:10.520767Z","steps":["trace[1630997954] 'process raft request' (duration: 43.672534ms)","trace[1630997954] 'compare' (duration: 600.173058ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:25:10.520841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:09.876427Z","time spent":"644.387329ms","remote":"127.0.0.1:35256","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-12T11:25:10.577464Z","caller":"traceutil/trace.go:171","msg":"trace[1108631772] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"462.14906ms","start":"2026-05-12T11:25:10.115286Z","end":"2026-05-12T11:25:10.577435Z","steps":["trace[1108631772] 'process raft request' (duration: 461.679515ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:10.577736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:10.115262Z","time spent":"462.383528ms","remote":"127.0.0.1:35060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T11:25:10.808568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.287223ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-12T11:25:10.808697Z","caller":"traceutil/trace.go:171","msg":"trace[1843013276] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:655; }","duration":"396.173403ms","start":"2026-05-12T11:25:10.412503Z","end":"2026-05-12T11:25:10.808676Z","steps":["trace[1843013276] 'read index received' (duration: 164.217718ms)","trace[1843013276] 'applied index is now lower than readState.Index' (duration: 231.954225ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:25:10.808877Z","caller":"traceutil/trace.go:171","msg":"trace[1884356563] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"656.037305ms","start":"2026-05-12T11:25:10.152819Z","end":"2026-05-12T11:25:10.808857Z","steps":["trace[1884356563] 'process raft request' (duration: 518.355689ms)","trace[1884356563] 'compare' (duration: 137.163799ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:25:10.808943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.402101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8sl2d\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-12T11:25:10.809015Z","caller":"traceutil/trace.go:171","msg":"trace[62903392] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8sl2d; range_end:; response_count:1; response_revision:633; }","duration":"396.476704ms","start":"2026-05-12T11:25:10.412497Z","end":"2026-05-12T11:25:10.808974Z","steps":["trace[62903392] 'agreement among raft nodes before linearized reading' (duration: 396.244607ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:10.808999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:10.152795Z","time spent":"656.130239ms","remote":"127.0.0.1:35256","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-12T11:25:10.80909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:10.412445Z","time spent":"396.606368ms","remote":"127.0.0.1:35168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-8sl2d\" "} {"level":"warn","ts":"2026-05-12T11:25:11.42021Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824332574609283435,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-12T11:25:11.862537Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.17278248s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-12T11:25:12.959056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096262146s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-12T11:25:12.959369Z","caller":"traceutil/trace.go:171","msg":"trace[809373133] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:657; }","duration":"2.039607376s","start":"2026-05-12T11:25:10.919741Z","end":"2026-05-12T11:25:12.959348Z","steps":["trace[809373133] 'read index received' (duration: 942.981628ms)","trace[809373133] 'applied index is now lower than readState.Index' (duration: 1.096624668s)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:25:12.959481Z","caller":"traceutil/trace.go:171","msg":"trace[906131450] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"2.135438795s","start":"2026-05-12T11:25:10.824025Z","end":"2026-05-12T11:25:12.959463Z","steps":["trace[906131450] 'process raft request' (duration: 2.135159146s)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:12.959484Z","caller":"traceutil/trace.go:171","msg":"trace[847278264] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"2.319810642s","start":"2026-05-12T11:25:10.639634Z","end":"2026-05-12T11:25:12.959445Z","steps":["trace[847278264] 'process raft request' (duration: 1.22307707s)","trace[847278264] 'compare' (duration: 1.095347947s)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:25:12.959575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:10.824Z","time spent":"2.135517829s","remote":"127.0.0.1:35168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T11:25:12.959611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.705414173s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:25:12.959665Z","caller":"traceutil/trace.go:171","msg":"trace[1925727791] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"1.705511196s","start":"2026-05-12T11:25:11.254136Z","end":"2026-05-12T11:25:12.959648Z","steps":["trace[1925727791] 'agreement among raft nodes before linearized reading' (duration: 1.705424294s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:12.95967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:10.639609Z","time spent":"2.319953088s","remote":"127.0.0.1:35220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T11:25:12.959704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:11.254114Z","time spent":"1.705580848s","remote":"127.0.0.1:34960","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-12T11:25:12.95974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.214617533s","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-12T11:25:12.959791Z","caller":"traceutil/trace.go:171","msg":"trace[1811172323] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:635; }","duration":"1.214691425s","start":"2026-05-12T11:25:11.745087Z","end":"2026-05-12T11:25:12.959778Z","steps":["trace[1811172323] 'agreement among raft nodes before linearized reading' (duration: 1.21454646s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:12.959829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:11.74508Z","time spent":"1.214735006s","remote":"127.0.0.1:35256","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-12T11:25:12.959961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.040221376s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.121\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-12T11:25:12.95998Z","caller":"traceutil/trace.go:171","msg":"trace[303836189] range","detail":"{range_begin:/registry/masterleases/199.19.213.121; range_end:; response_count:1; response_revision:635; }","duration":"2.040266488s","start":"2026-05-12T11:25:10.919708Z","end":"2026-05-12T11:25:12.959974Z","steps":["trace[303836189] 'agreement among raft nodes before linearized reading' (duration: 2.040230307s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:12.959995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:10.919689Z","time spent":"2.04030249s","remote":"127.0.0.1:34998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.121\" "} {"level":"warn","ts":"2026-05-12T11:25:12.960043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.216422193s","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-12T11:25:12.96013Z","caller":"traceutil/trace.go:171","msg":"trace[51596366] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:635; }","duration":"1.216543437s","start":"2026-05-12T11:25:11.74357Z","end":"2026-05-12T11:25:12.960114Z","steps":["trace[51596366] 'agreement among raft nodes before linearized reading' (duration: 1.216324119s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:12.960175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:11.743551Z","time spent":"1.216611519s","remote":"127.0.0.1:35256","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":"warn","ts":"2026-05-12T11:25:12.960085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.215531562s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-12T11:25:12.960219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.989596ms","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-12T11:25:12.960236Z","caller":"traceutil/trace.go:171","msg":"trace[1247971015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:635; }","duration":"1.21575523s","start":"2026-05-12T11:25:11.744461Z","end":"2026-05-12T11:25:12.960216Z","steps":["trace[1247971015] 'agreement among raft nodes before linearized reading' (duration: 1.215371837s)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:12.960291Z","caller":"traceutil/trace.go:171","msg":"trace[931245264] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:635; }","duration":"421.174431ms","start":"2026-05-12T11:25:12.539085Z","end":"2026-05-12T11:25:12.96026Z","steps":["trace[931245264] 'agreement among raft nodes before linearized reading' (duration: 420.910123ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:12.960295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:11.744454Z","time spent":"1.215830712s","remote":"127.0.0.1:35256","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-12T11:25:12.960335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:12.539064Z","time spent":"421.261584ms","remote":"127.0.0.1:35256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-12T11:25:13.153266Z","caller":"traceutil/trace.go:171","msg":"trace[851832997] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"189.071832ms","start":"2026-05-12T11:25:12.964164Z","end":"2026-05-12T11:25:13.153235Z","steps":["trace[851832997] 'process raft request' (duration: 130.96764ms)","trace[851832997] 'compare' (duration: 57.477991ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:25:13.153554Z","caller":"traceutil/trace.go:171","msg":"trace[940386319] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"187.627584ms","start":"2026-05-12T11:25:12.965904Z","end":"2026-05-12T11:25:13.153531Z","steps":["trace[940386319] 'process raft request' (duration: 187.479889ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:13.15358Z","caller":"traceutil/trace.go:171","msg":"trace[187578501] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:660; }","duration":"152.693615ms","start":"2026-05-12T11:25:13.000867Z","end":"2026-05-12T11:25:13.153561Z","steps":["trace[187578501] 'read index received' (duration: 94.279392ms)","trace[187578501] 'applied index is now lower than readState.Index' (duration: 58.413243ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:25:13.153497Z","caller":"traceutil/trace.go:171","msg":"trace[53009800] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"187.999696ms","start":"2026-05-12T11:25:12.965469Z","end":"2026-05-12T11:25:13.153469Z","steps":["trace[53009800] 'process raft request' (duration: 187.732257ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:13.153693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.202341ms","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-12T11:25:13.153735Z","caller":"traceutil/trace.go:171","msg":"trace[641873188] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:639; }","duration":"191.276194ms","start":"2026-05-12T11:25:12.962446Z","end":"2026-05-12T11:25:13.153723Z","steps":["trace[641873188] 'agreement among raft nodes before linearized reading' (duration: 191.194041ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:13.153646Z","caller":"traceutil/trace.go:171","msg":"trace[746197184] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"187.595363ms","start":"2026-05-12T11:25:12.966025Z","end":"2026-05-12T11:25:13.15362Z","steps":["trace[746197184] 'process raft request' (duration: 187.445988ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:13.159893Z","caller":"traceutil/trace.go:171","msg":"trace[350470350] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"158.171331ms","start":"2026-05-12T11:25:13.001707Z","end":"2026-05-12T11:25:13.159878Z","steps":["trace[350470350] 'process raft request' (duration: 158.017647ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:13.15994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.950177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:25:13.16011Z","caller":"traceutil/trace.go:171","msg":"trace[2125283209] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:640; }","duration":"151.136063ms","start":"2026-05-12T11:25:13.008946Z","end":"2026-05-12T11:25:13.160083Z","steps":["trace[2125283209] 'agreement among raft nodes before linearized reading' (duration: 150.934527ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:14.87815Z","caller":"traceutil/trace.go:171","msg":"trace[1405377869] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"305.27854ms","start":"2026-05-12T11:25:14.572847Z","end":"2026-05-12T11:25:14.878126Z","steps":["trace[1405377869] 'process raft request' (duration: 305.157797ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:14.878269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:14.572832Z","time spent":"305.379564ms","remote":"127.0.0.1:35018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T11:25:14.882766Z","caller":"traceutil/trace.go:171","msg":"trace[688980934] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"119.4196ms","start":"2026-05-12T11:25:14.763324Z","end":"2026-05-12T11:25:14.882744Z","steps":["trace[688980934] 'process raft request' (duration: 119.305276ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:27.813289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.755259ms","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-12T11:25:27.813389Z","caller":"traceutil/trace.go:171","msg":"trace[554519906] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:791; }","duration":"597.904144ms","start":"2026-05-12T11:25:27.215467Z","end":"2026-05-12T11:25:27.813371Z","steps":["trace[554519906] 'range keys from in-memory index tree' (duration: 597.625916ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:27.813516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:27.215446Z","time spent":"598.056597ms","remote":"127.0.0.1:35256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-12T11:25:27.813497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.498406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T11:25:27.813441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.769725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-jzmbf\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-05-12T11:25:27.81366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.450329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-12T11:25:27.813572Z","caller":"traceutil/trace.go:171","msg":"trace[181384781] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:791; }","duration":"558.60571ms","start":"2026-05-12T11:25:27.254948Z","end":"2026-05-12T11:25:27.813553Z","steps":["trace[181384781] 'range keys from in-memory index tree' (duration: 558.379442ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:27.813676Z","caller":"traceutil/trace.go:171","msg":"trace[860202829] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-jzmbf; range_end:; response_count:1; response_revision:791; }","duration":"300.033372ms","start":"2026-05-12T11:25:27.513595Z","end":"2026-05-12T11:25:27.813628Z","steps":["trace[860202829] 'range keys from in-memory index tree' (duration: 299.565858ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:27.813773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:27.25493Z","time spent":"558.828266ms","remote":"127.0.0.1:34960","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-12T11:25:27.813723Z","caller":"traceutil/trace.go:171","msg":"trace[549237548] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:791; }","duration":"585.542562ms","start":"2026-05-12T11:25:27.228168Z","end":"2026-05-12T11:25:27.813711Z","steps":["trace[549237548] 'range keys from in-memory index tree' (duration: 585.291695ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:27.813875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:27.228152Z","time spent":"585.712737ms","remote":"127.0.0.1:35256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-12T11:25:27.813942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:27.513574Z","time spent":"300.271558ms","remote":"127.0.0.1:35168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-jzmbf\" "} {"level":"warn","ts":"2026-05-12T11:25:27.813801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.71015ms","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-12T11:25:27.814188Z","caller":"traceutil/trace.go:171","msg":"trace[1737316622] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:791; }","duration":"590.141803ms","start":"2026-05-12T11:25:27.22403Z","end":"2026-05-12T11:25:27.814172Z","steps":["trace[1737316622] 'range keys from in-memory index tree' (duration: 589.543405ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:27.814223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:27.224015Z","time spent":"590.199344ms","remote":"127.0.0.1:35256","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-12T11:25:27.817294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.897287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-12T11:25:27.817416Z","caller":"traceutil/trace.go:171","msg":"trace[1100359319] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:791; }","duration":"589.052742ms","start":"2026-05-12T11:25:27.228348Z","end":"2026-05-12T11:25:27.817401Z","steps":["trace[1100359319] 'range keys from in-memory index tree' (duration: 584.667308ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:25:27.817567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:25:27.228336Z","time spent":"589.218106ms","remote":"127.0.0.1:35256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-12T11:25:27.971577Z","caller":"traceutil/trace.go:171","msg":"trace[1718700517] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"153.928082ms","start":"2026-05-12T11:25:27.817626Z","end":"2026-05-12T11:25:27.971554Z","steps":["trace[1718700517] 'process raft request' (duration: 153.744646ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:27.979756Z","caller":"traceutil/trace.go:171","msg":"trace[1205126496] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"157.372739ms","start":"2026-05-12T11:25:27.822372Z","end":"2026-05-12T11:25:27.979745Z","steps":["trace[1205126496] 'process raft request' (duration: 157.339148ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:27.979834Z","caller":"traceutil/trace.go:171","msg":"trace[974516309] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"159.936372ms","start":"2026-05-12T11:25:27.819861Z","end":"2026-05-12T11:25:27.979798Z","steps":["trace[974516309] 'process raft request' (duration: 159.802778ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:27.979896Z","caller":"traceutil/trace.go:171","msg":"trace[1703739318] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"159.764017ms","start":"2026-05-12T11:25:27.820095Z","end":"2026-05-12T11:25:27.979859Z","steps":["trace[1703739318] 'process raft request' (duration: 159.591292ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:27.980326Z","caller":"traceutil/trace.go:171","msg":"trace[1541121011] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"161.804444ms","start":"2026-05-12T11:25:27.818498Z","end":"2026-05-12T11:25:27.980302Z","steps":["trace[1541121011] 'process raft request' (duration: 161.103005ms)"],"step_count":1}