{"level":"warn","ts":"2026-05-06T00:43:03.316102Z","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-06T00:43:03.316265Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.137: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.137:2380","--initial-cluster=instance=https://199.19.213.137:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.137:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.137: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-06T00:43:03.316421Z","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-06T00:43:03.316454Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.137:2380"]} {"level":"info","ts":"2026-05-06T00:43:03.31651Z","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-06T00:43:03.317366Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.137:2379"]} {"level":"info","ts":"2026-05-06T00:43:03.317515Z","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.137:2380"],"listen-peer-urls":["https://199.19.213.137:2380"],"advertise-client-urls":["https://199.19.213.137:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.137:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.137: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-06T00:43:03.323381Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.612886ms"} {"level":"info","ts":"2026-05-06T00:43:03.329121Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2ba8e3c2b0588654","cluster-id":"97694c3f9947e4ca"} {"level":"info","ts":"2026-05-06T00:43:03.329223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 switched to configuration voters=()"} {"level":"info","ts":"2026-05-06T00:43:03.329285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 became follower at term 0"} {"level":"info","ts":"2026-05-06T00:43:03.32931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2ba8e3c2b0588654 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-06T00:43:03.32933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 became follower at term 1"} {"level":"info","ts":"2026-05-06T00:43:03.329393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 switched to configuration voters=(3146014765040043604)"} {"level":"warn","ts":"2026-05-06T00:43:03.335739Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-06T00:43:03.337593Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-06T00:43:03.338676Z","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-06T00:43:03.342452Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2ba8e3c2b0588654","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-06T00:43:03.345827Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2ba8e3c2b0588654","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-06T00:43:03.34591Z","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-06T00:43:03.34596Z","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-06T00:43:03.345971Z","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-06T00:43:03.346257Z","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-06T00:43:03.346369Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.137:2380"} {"level":"info","ts":"2026-05-06T00:43:03.346422Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.137:2380"} {"level":"info","ts":"2026-05-06T00:43:03.346508Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2ba8e3c2b0588654","initial-advertise-peer-urls":["https://199.19.213.137:2380"],"listen-peer-urls":["https://199.19.213.137:2380"],"advertise-client-urls":["https://199.19.213.137:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.137:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-06T00:43:03.346551Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-06T00:43:03.346772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 switched to configuration voters=(3146014765040043604)"} {"level":"info","ts":"2026-05-06T00:43:03.346892Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"97694c3f9947e4ca","local-member-id":"2ba8e3c2b0588654","added-peer-id":"2ba8e3c2b0588654","added-peer-peer-urls":["https://199.19.213.137:2380"]} {"level":"info","ts":"2026-05-06T00:43:03.730441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 is starting a new election at term 1"} {"level":"info","ts":"2026-05-06T00:43:03.730506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-06T00:43:03.730533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 received MsgPreVoteResp from 2ba8e3c2b0588654 at term 1"} {"level":"info","ts":"2026-05-06T00:43:03.730557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 became candidate at term 2"} {"level":"info","ts":"2026-05-06T00:43:03.730584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 received MsgVoteResp from 2ba8e3c2b0588654 at term 2"} {"level":"info","ts":"2026-05-06T00:43:03.7306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 became leader at term 2"} {"level":"info","ts":"2026-05-06T00:43:03.73062Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2ba8e3c2b0588654 elected leader 2ba8e3c2b0588654 at term 2"} {"level":"info","ts":"2026-05-06T00:43:03.731356Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T00:43:03.732997Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T00:43:03.73299Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2ba8e3c2b0588654","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.137:2379]}","request-path":"/0/members/2ba8e3c2b0588654/attributes","cluster-id":"97694c3f9947e4ca","publish-timeout":"7s"} {"level":"info","ts":"2026-05-06T00:43:03.733145Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T00:43:03.733596Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-06T00:43:03.733624Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-06T00:43:03.736635Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.137:2379"} {"level":"info","ts":"2026-05-06T00:43:03.737632Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"97694c3f9947e4ca","local-member-id":"2ba8e3c2b0588654","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T00:43:03.737712Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T00:43:03.737737Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T00:43:03.73845Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-06T00:43:10.036504Z","caller":"traceutil/trace.go:171","msg":"trace[771301660] transaction","detail":"{read_only:false; number_of_response:0; response_revision:263; }","duration":"380.272097ms","start":"2026-05-06T00:43:09.656176Z","end":"2026-05-06T00:43:10.036448Z","steps":["trace[771301660] 'process raft request' (duration: 379.032938ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:10.037787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:09.656155Z","time spent":"381.129104ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-06T00:43:10.036513Z","caller":"traceutil/trace.go:171","msg":"trace[1509927375] transaction","detail":"{read_only:false; response_revision:263; number_of_response:1; }","duration":"402.744787ms","start":"2026-05-06T00:43:09.63371Z","end":"2026-05-06T00:43:10.036455Z","steps":["trace[1509927375] 'process raft request' (duration: 401.278655ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:10.038123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:09.63369Z","time spent":"404.369268ms","remote":"127.0.0.1:49906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-06T00:43:10.036549Z","caller":"traceutil/trace.go:171","msg":"trace[1906311648] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"380.350411ms","start":"2026-05-06T00:43:09.656188Z","end":"2026-05-06T00:43:10.036539Z","steps":["trace[1906311648] 'process raft request' (duration: 379.058919ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:10.038331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:09.656168Z","time spent":"382.117948ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-06T00:43:10.036611Z","caller":"traceutil/trace.go:171","msg":"trace[2086814047] linearizableReadLoop","detail":"{readStateIndex:275; appliedIndex:268; }","duration":"380.185221ms","start":"2026-05-06T00:43:09.656397Z","end":"2026-05-06T00:43:10.036582Z","steps":["trace[2086814047] 'read index received' (duration: 55.186211ms)","trace[2086814047] 'applied index is now lower than readState.Index' (duration: 324.99769ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T00:43:10.036835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.297698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslicemirroring-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T00:43:10.038536Z","caller":"traceutil/trace.go:171","msg":"trace[1794538134] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslicemirroring-controller; range_end:; response_count:0; response_revision:267; }","duration":"382.14663ms","start":"2026-05-06T00:43:09.656373Z","end":"2026-05-06T00:43:10.03852Z","steps":["trace[1794538134] 'agreement among raft nodes before linearized reading' (duration: 380.244835ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:10.038576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:09.656362Z","time spent":"382.194242ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslicemirroring-controller\" "} {"level":"warn","ts":"2026-05-06T00:43:10.038653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.473521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-05-06T00:43:10.036881Z","caller":"traceutil/trace.go:171","msg":"trace[450463626] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"380.678409ms","start":"2026-05-06T00:43:09.656188Z","end":"2026-05-06T00:43:10.036867Z","steps":["trace[450463626] 'process raft request' (duration: 379.121682ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:10.038706Z","caller":"traceutil/trace.go:171","msg":"trace[209689390] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:267; }","duration":"320.543556ms","start":"2026-05-06T00:43:09.718145Z","end":"2026-05-06T00:43:10.038688Z","steps":["trace[209689390] 'agreement among raft nodes before linearized reading' (duration: 320.463041ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:10.038729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:09.65617Z","time spent":"382.537602ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T00:43:10.038746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:09.718132Z","time spent":"320.606298ms","remote":"127.0.0.1:50012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4040,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-05-06T00:43:10.036899Z","caller":"traceutil/trace.go:171","msg":"trace[1173521397] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"380.615715ms","start":"2026-05-06T00:43:09.656272Z","end":"2026-05-06T00:43:10.036888Z","steps":["trace[1173521397] 'process raft request' (duration: 380.183741ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:10.03886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:09.65625Z","time spent":"382.592715ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-06T00:43:10.036922Z","caller":"traceutil/trace.go:171","msg":"trace[1041607688] transaction","detail":"{read_only:false; number_of_response:0; response_revision:263; }","duration":"383.105756ms","start":"2026-05-06T00:43:09.653776Z","end":"2026-05-06T00:43:10.036882Z","steps":["trace[1041607688] 'process raft request' (duration: 381.362519ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:10.038995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:09.653753Z","time spent":"385.228454ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-06T00:43:10.036983Z","caller":"traceutil/trace.go:171","msg":"trace[1929874038] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"373.030826ms","start":"2026-05-06T00:43:09.663939Z","end":"2026-05-06T00:43:10.03697Z","steps":["trace[1929874038] 'process raft request' (duration: 372.591251ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:10.039092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:09.663924Z","time spent":"375.151724ms","remote":"127.0.0.1:49934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1934,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T00:43:10.706028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.410878ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-06T00:43:10.706531Z","caller":"traceutil/trace.go:171","msg":"trace[1831582892] transaction","detail":"{read_only:false; response_revision:271; number_of_response:1; }","duration":"657.380926ms","start":"2026-05-06T00:43:10.049109Z","end":"2026-05-06T00:43:10.70649Z","steps":["trace[1831582892] 'process raft request' (duration: 657.151664ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:10.706863Z","caller":"traceutil/trace.go:171","msg":"trace[1555817618] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"661.165206ms","start":"2026-05-06T00:43:10.045497Z","end":"2026-05-06T00:43:10.706662Z","steps":["trace[1555817618] 'process raft request' (duration: 517.821316ms)","trace[1555817618] 'compare' (duration: 141.7286ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T00:43:10.707229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:10.04548Z","time spent":"661.497384ms","remote":"127.0.0.1:50278","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2651,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-06T00:43:10.707472Z","caller":"traceutil/trace.go:171","msg":"trace[1233329361] transaction","detail":"{read_only:false; response_revision:270; number_of_response:1; }","duration":"661.157856ms","start":"2026-05-06T00:43:10.045834Z","end":"2026-05-06T00:43:10.706991Z","steps":["trace[1233329361] 'process raft request' (duration: 660.32655ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:10.707649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:10.045827Z","time spent":"661.711396ms","remote":"127.0.0.1:50024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":217,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T00:43:10.710206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:10.049098Z","time spent":"657.495672ms","remote":"127.0.0.1:50012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4183,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T00:43:10.722581Z","caller":"traceutil/trace.go:171","msg":"trace[2050506365] linearizableReadLoop","detail":"{readStateIndex:281; appliedIndex:280; }","duration":"156.256576ms","start":"2026-05-06T00:43:10.566309Z","end":"2026-05-06T00:43:10.722566Z","steps":["trace[2050506365] 'read index received' (duration: 156.221094ms)","trace[2050506365] 'applied index is now lower than readState.Index' (duration: 34.682µs)"],"step_count":2} {"level":"warn","ts":"2026-05-06T00:43:10.722694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.373494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"} {"level":"info","ts":"2026-05-06T00:43:10.72272Z","caller":"traceutil/trace.go:171","msg":"trace[1593969360] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:272; }","duration":"156.451758ms","start":"2026-05-06T00:43:10.566262Z","end":"2026-05-06T00:43:10.722714Z","steps":["trace[1593969360] 'agreement among raft nodes before linearized reading' (duration: 156.376674ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:10.722671Z","caller":"traceutil/trace.go:171","msg":"trace[230776914] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"639.402088ms","start":"2026-05-06T00:43:10.083184Z","end":"2026-05-06T00:43:10.722586Z","steps":["trace[230776914] 'process raft request' (duration: 639.298232ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:10.722879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:10.083167Z","time spent":"639.633551ms","remote":"127.0.0.1:49906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":636,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T00:43:10.72755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.709617ms","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-06T00:43:10.727594Z","caller":"traceutil/trace.go:171","msg":"trace[566163095] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:273; }","duration":"117.790141ms","start":"2026-05-06T00:43:10.609794Z","end":"2026-05-06T00:43:10.727584Z","steps":["trace[566163095] 'agreement among raft nodes before linearized reading' (duration: 117.714727ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:10.727814Z","caller":"traceutil/trace.go:171","msg":"trace[935022358] transaction","detail":"{read_only:false; number_of_response:0; response_revision:272; }","duration":"159.306846ms","start":"2026-05-06T00:43:10.568497Z","end":"2026-05-06T00:43:10.727804Z","steps":["trace[935022358] 'process raft request' (duration: 158.931075ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:10.728015Z","caller":"traceutil/trace.go:171","msg":"trace[1881050188] transaction","detail":"{read_only:false; number_of_response:0; response_revision:272; }","duration":"159.968533ms","start":"2026-05-06T00:43:10.568038Z","end":"2026-05-06T00:43:10.728006Z","steps":["trace[1881050188] 'process raft request' (duration: 159.35957ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:10.728022Z","caller":"traceutil/trace.go:171","msg":"trace[268201384] transaction","detail":"{read_only:false; number_of_response:0; response_revision:272; }","duration":"159.320576ms","start":"2026-05-06T00:43:10.568687Z","end":"2026-05-06T00:43:10.728008Z","steps":["trace[268201384] 'process raft request' (duration: 158.761196ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:35.634183Z","caller":"traceutil/trace.go:171","msg":"trace[1528692667] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"131.617367ms","start":"2026-05-06T00:43:35.502541Z","end":"2026-05-06T00:43:35.634159Z","steps":["trace[1528692667] 'process raft request' (duration: 131.401279ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:35.634244Z","caller":"traceutil/trace.go:171","msg":"trace[922217459] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"131.330396ms","start":"2026-05-06T00:43:35.502905Z","end":"2026-05-06T00:43:35.634235Z","steps":["trace[922217459] 'process raft request' (duration: 131.155249ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:35.634181Z","caller":"traceutil/trace.go:171","msg":"trace[1731254819] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"129.124552ms","start":"2026-05-06T00:43:35.505031Z","end":"2026-05-06T00:43:35.634155Z","steps":["trace[1731254819] 'process raft request' (duration: 129.08375ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:35.642454Z","caller":"traceutil/trace.go:171","msg":"trace[514047666] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"131.648018ms","start":"2026-05-06T00:43:35.510789Z","end":"2026-05-06T00:43:35.642437Z","steps":["trace[514047666] 'process raft request' (duration: 131.18728ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:35.642634Z","caller":"traceutil/trace.go:171","msg":"trace[658605230] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"131.826265ms","start":"2026-05-06T00:43:35.510802Z","end":"2026-05-06T00:43:35.642629Z","steps":["trace[658605230] 'process raft request' (duration: 131.345937ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:35.64269Z","caller":"traceutil/trace.go:171","msg":"trace[1789763353] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"121.270073ms","start":"2026-05-06T00:43:35.521414Z","end":"2026-05-06T00:43:35.642684Z","steps":["trace[1789763353] 'process raft request' (duration: 120.769784ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:35.852695Z","caller":"traceutil/trace.go:171","msg":"trace[2003578580] linearizableReadLoop","detail":"{readStateIndex:526; appliedIndex:524; }","duration":"127.013151ms","start":"2026-05-06T00:43:35.725649Z","end":"2026-05-06T00:43:35.852662Z","steps":["trace[2003578580] 'read index received' (duration: 20.771469ms)","trace[2003578580] 'applied index is now lower than readState.Index' (duration: 106.237512ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T00:43:35.852772Z","caller":"traceutil/trace.go:171","msg":"trace[2035897485] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"138.678637ms","start":"2026-05-06T00:43:35.714049Z","end":"2026-05-06T00:43:35.852728Z","steps":["trace[2035897485] 'process raft request' (duration: 135.684223ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:35.852804Z","caller":"traceutil/trace.go:171","msg":"trace[696999071] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"115.250844ms","start":"2026-05-06T00:43:35.737524Z","end":"2026-05-06T00:43:35.852775Z","steps":["trace[696999071] 'process raft request' (duration: 115.036656ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:35.852772Z","caller":"traceutil/trace.go:171","msg":"trace[1438723992] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"133.27768ms","start":"2026-05-06T00:43:35.719448Z","end":"2026-05-06T00:43:35.852725Z","steps":["trace[1438723992] 'process raft request' (duration: 132.99036ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:35.85294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.24462ms","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-06T00:43:35.853028Z","caller":"traceutil/trace.go:171","msg":"trace[864558524] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:507; }","duration":"127.389885ms","start":"2026-05-06T00:43:35.725624Z","end":"2026-05-06T00:43:35.853014Z","steps":["trace[864558524] 'agreement among raft nodes before linearized reading' (duration: 127.212869ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:35.856599Z","caller":"traceutil/trace.go:171","msg":"trace[1244348040] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"104.717113ms","start":"2026-05-06T00:43:35.751803Z","end":"2026-05-06T00:43:35.856521Z","steps":["trace[1244348040] 'process raft request' (duration: 103.30288ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:41.79335Z","caller":"traceutil/trace.go:171","msg":"trace[1740068490] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"132.891883ms","start":"2026-05-06T00:43:41.660408Z","end":"2026-05-06T00:43:41.7933Z","steps":["trace[1740068490] 'process raft request' (duration: 132.720446ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:42.076435Z","caller":"traceutil/trace.go:171","msg":"trace[736621520] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:604; }","duration":"188.136687ms","start":"2026-05-06T00:43:41.888278Z","end":"2026-05-06T00:43:42.076415Z","steps":["trace[736621520] 'read index received' (duration: 187.431432ms)","trace[736621520] 'applied index is now lower than readState.Index' (duration: 704.325µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T00:43:42.077128Z","caller":"traceutil/trace.go:171","msg":"trace[119809880] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"294.384932ms","start":"2026-05-06T00:43:41.782689Z","end":"2026-05-06T00:43:42.077074Z","steps":["trace[119809880] 'process raft request' (duration: 293.274843ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:42.077169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.889674ms","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-06T00:43:42.077202Z","caller":"traceutil/trace.go:171","msg":"trace[325454622] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:584; }","duration":"188.977957ms","start":"2026-05-06T00:43:41.888214Z","end":"2026-05-06T00:43:42.077192Z","steps":["trace[325454622] 'agreement among raft nodes before linearized reading' (duration: 188.862513ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:42.750652Z","caller":"traceutil/trace.go:171","msg":"trace[824437312] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"536.93486ms","start":"2026-05-06T00:43:42.21369Z","end":"2026-05-06T00:43:42.750625Z","steps":["trace[824437312] 'process raft request' (duration: 536.06792ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:42.750806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:42.21368Z","time spent":"537.044174ms","remote":"127.0.0.1:50014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T00:43:42.750905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.74416ms","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-06T00:43:42.750973Z","caller":"traceutil/trace.go:171","msg":"trace[1717871932] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:587; }","duration":"489.861565ms","start":"2026-05-06T00:43:42.261098Z","end":"2026-05-06T00:43:42.75096Z","steps":["trace[1717871932] 'agreement among raft nodes before linearized reading' (duration: 489.691109ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:42.750662Z","caller":"traceutil/trace.go:171","msg":"trace[1759656263] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:607; }","duration":"489.475861ms","start":"2026-05-06T00:43:42.261128Z","end":"2026-05-06T00:43:42.750604Z","steps":["trace[1759656263] 'read index received' (duration: 488.568919ms)","trace[1759656263] 'applied index is now lower than readState.Index' (duration: 905.812µs)"],"step_count":2} {"level":"warn","ts":"2026-05-06T00:43:42.751019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:42.261083Z","time spent":"489.926298ms","remote":"127.0.0.1:52364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-06T00:43:42.751121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.941307ms","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-06T00:43:42.751168Z","caller":"traceutil/trace.go:171","msg":"trace[1870979952] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:587; }","duration":"490.01012ms","start":"2026-05-06T00:43:42.261145Z","end":"2026-05-06T00:43:42.751155Z","steps":["trace[1870979952] 'agreement among raft nodes before linearized reading' (duration: 489.934828ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:42.751206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:42.261133Z","time spent":"490.064482ms","remote":"127.0.0.1:52364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-06T00:43:42.751211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.652528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T00:43:42.751255Z","caller":"traceutil/trace.go:171","msg":"trace[2100636087] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:587; }","duration":"282.71503ms","start":"2026-05-06T00:43:42.468528Z","end":"2026-05-06T00:43:42.751243Z","steps":["trace[2100636087] 'agreement among raft nodes before linearized reading' (duration: 282.637758ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:42.751299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.689475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T00:43:42.751332Z","caller":"traceutil/trace.go:171","msg":"trace[1418120258] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:587; }","duration":"283.766148ms","start":"2026-05-06T00:43:42.467557Z","end":"2026-05-06T00:43:42.751323Z","steps":["trace[1418120258] 'agreement among raft nodes before linearized reading' (duration: 283.718206ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:42.75141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.80473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T00:43:42.751441Z","caller":"traceutil/trace.go:171","msg":"trace[119414754] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:587; }","duration":"283.855182ms","start":"2026-05-06T00:43:42.467578Z","end":"2026-05-06T00:43:42.751433Z","steps":["trace[119414754] 'agreement among raft nodes before linearized reading' (duration: 283.81359ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:42.75152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.612281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-06T00:43:42.751528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.839394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T00:43:42.751554Z","caller":"traceutil/trace.go:171","msg":"trace[569933956] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:587; }","duration":"302.643402ms","start":"2026-05-06T00:43:42.448899Z","end":"2026-05-06T00:43:42.751543Z","steps":["trace[569933956] 'agreement among raft nodes before linearized reading' (duration: 302.60159ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:42.751583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:42.44887Z","time spent":"302.705534ms","remote":"127.0.0.1:52398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-05-06T00:43:42.75162Z","caller":"traceutil/trace.go:171","msg":"trace[1888879234] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:587; }","duration":"113.935917ms","start":"2026-05-06T00:43:42.637634Z","end":"2026-05-06T00:43:42.75157Z","steps":["trace[1888879234] 'agreement among raft nodes before linearized reading' (duration: 113.665546ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:42.751666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.233777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-06T00:43:42.751731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.664799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T00:43:42.751746Z","caller":"traceutil/trace.go:171","msg":"trace[1968029111] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:587; }","duration":"114.349611ms","start":"2026-05-06T00:43:42.637386Z","end":"2026-05-06T00:43:42.751735Z","steps":["trace[1968029111] 'agreement among raft nodes before linearized reading' (duration: 114.191756ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:42.75176Z","caller":"traceutil/trace.go:171","msg":"trace[569953925] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:587; }","duration":"303.71042ms","start":"2026-05-06T00:43:42.448041Z","end":"2026-05-06T00:43:42.751752Z","steps":["trace[569953925] 'agreement among raft nodes before linearized reading' (duration: 303.665758ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:42.751796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:42.448033Z","time spent":"303.755741ms","remote":"127.0.0.1:52398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-06T00:43:42.751845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.449205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T00:43:42.751877Z","caller":"traceutil/trace.go:171","msg":"trace[1195832978] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:587; }","duration":"114.525157ms","start":"2026-05-06T00:43:42.637345Z","end":"2026-05-06T00:43:42.75187Z","steps":["trace[1195832978] 'agreement among raft nodes before linearized reading' (duration: 114.476375ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:42.751914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.887746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T00:43:42.751948Z","caller":"traceutil/trace.go:171","msg":"trace[1028697080] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:587; }","duration":"303.923028ms","start":"2026-05-06T00:43:42.448017Z","end":"2026-05-06T00:43:42.75194Z","steps":["trace[1028697080] 'agreement among raft nodes before linearized reading' (duration: 303.875776ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:42.751953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.633174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T00:43:42.751987Z","caller":"traceutil/trace.go:171","msg":"trace[1247611539] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:587; }","duration":"254.691636ms","start":"2026-05-06T00:43:42.497284Z","end":"2026-05-06T00:43:42.751976Z","steps":["trace[1247611539] 'agreement among raft nodes before linearized reading' (duration: 254.650824ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:42.752023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:42.447975Z","time spent":"304.039091ms","remote":"127.0.0.1:52398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-06T00:43:42.752143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.737243ms","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":"warn","ts":"2026-05-06T00:43:42.752173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.23235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T00:43:42.752191Z","caller":"traceutil/trace.go:171","msg":"trace[8892764] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:587; }","duration":"352.801966ms","start":"2026-05-06T00:43:42.399382Z","end":"2026-05-06T00:43:42.752184Z","steps":["trace[8892764] 'agreement among raft nodes before linearized reading' (duration: 352.740344ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:42.752203Z","caller":"traceutil/trace.go:171","msg":"trace[377872028] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:587; }","duration":"258.272041ms","start":"2026-05-06T00:43:42.493923Z","end":"2026-05-06T00:43:42.752195Z","steps":["trace[377872028] 'agreement among raft nodes before linearized reading' (duration: 258.217349ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:42.752229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:42.399371Z","time spent":"352.846207ms","remote":"127.0.0.1:52390","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-06T00:43:42.752375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.343434ms","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":"info","ts":"2026-05-06T00:43:42.752408Z","caller":"traceutil/trace.go:171","msg":"trace[450191545] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:587; }","duration":"353.406797ms","start":"2026-05-06T00:43:42.398993Z","end":"2026-05-06T00:43:42.7524Z","steps":["trace[450191545] 'agreement among raft nodes before linearized reading' (duration: 353.357655ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:42.75191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.045574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-06T00:43:42.752441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:42.39898Z","time spent":"353.453119ms","remote":"127.0.0.1:52390","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":"info","ts":"2026-05-06T00:43:42.752464Z","caller":"traceutil/trace.go:171","msg":"trace[525100274] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:587; }","duration":"258.617583ms","start":"2026-05-06T00:43:42.493837Z","end":"2026-05-06T00:43:42.752454Z","steps":["trace[525100274] 'agreement among raft nodes before linearized reading' (duration: 258.043343ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:42.752512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.7922ms","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-06T00:43:42.752588Z","caller":"traceutil/trace.go:171","msg":"trace[2071367259] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:587; }","duration":"353.902275ms","start":"2026-05-06T00:43:42.39867Z","end":"2026-05-06T00:43:42.752572Z","steps":["trace[2071367259] 'agreement among raft nodes before linearized reading' (duration: 353.77334ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:42.752636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:42.398655Z","time spent":"353.971026ms","remote":"127.0.0.1:52390","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":"warn","ts":"2026-05-06T00:43:42.752748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.242654ms","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":"warn","ts":"2026-05-06T00:43:42.75277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.324817ms","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-06T00:43:42.752802Z","caller":"traceutil/trace.go:171","msg":"trace[773896662] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:587; }","duration":"373.398049ms","start":"2026-05-06T00:43:42.379395Z","end":"2026-05-06T00:43:42.752793Z","steps":["trace[773896662] 'agreement among raft nodes before linearized reading' (duration: 373.349698ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:42.752839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:42.379364Z","time spent":"373.467263ms","remote":"127.0.0.1:52378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-05-06T00:43:42.752893Z","caller":"traceutil/trace.go:171","msg":"trace[753002868] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:587; }","duration":"373.336437ms","start":"2026-05-06T00:43:42.379454Z","end":"2026-05-06T00:43:42.75279Z","steps":["trace[753002868] 'agreement among raft nodes before linearized reading' (duration: 373.258594ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:42.752906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.022577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T00:43:42.752939Z","caller":"traceutil/trace.go:171","msg":"trace[1042426020] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:587; }","duration":"373.083399ms","start":"2026-05-06T00:43:42.379847Z","end":"2026-05-06T00:43:42.75293Z","steps":["trace[1042426020] 'agreement among raft nodes before linearized reading' (duration: 373.030927ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:42.753012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:42.37983Z","time spent":"373.173042ms","remote":"127.0.0.1:52364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"warn","ts":"2026-05-06T00:43:42.753085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:42.37943Z","time spent":"373.637048ms","remote":"127.0.0.1:52378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-06T00:43:59.805815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.693258ms","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-06T00:43:59.805893Z","caller":"traceutil/trace.go:171","msg":"trace[188100244] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:750; }","duration":"196.793041ms","start":"2026-05-06T00:43:59.609082Z","end":"2026-05-06T00:43:59.805875Z","steps":["trace[188100244] 'range keys from in-memory index tree' (duration: 196.522763ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:59.805813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.579035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-06T00:43:59.806051Z","caller":"traceutil/trace.go:171","msg":"trace[1506841720] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:750; }","duration":"344.873414ms","start":"2026-05-06T00:43:59.46117Z","end":"2026-05-06T00:43:59.806044Z","steps":["trace[1506841720] 'range keys from in-memory index tree' (duration: 344.450972ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:43:59.806071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:43:59.461153Z","time spent":"344.911816ms","remote":"127.0.0.1:50086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-06T00:43:59.957464Z","caller":"traceutil/trace.go:171","msg":"trace[946908274] linearizableReadLoop","detail":"{readStateIndex:779; appliedIndex:776; }","duration":"106.462511ms","start":"2026-05-06T00:43:59.850969Z","end":"2026-05-06T00:43:59.957431Z","steps":["trace[946908274] 'read index received' (duration: 49.827392ms)","trace[946908274] 'applied index is now lower than readState.Index' (duration: 56.633929ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T00:43:59.957672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.674378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T00:43:59.957627Z","caller":"traceutil/trace.go:171","msg":"trace[1121688821] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"146.779635ms","start":"2026-05-06T00:43:59.810788Z","end":"2026-05-06T00:43:59.957567Z","steps":["trace[1121688821] 'process raft request' (duration: 146.387132ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:59.95778Z","caller":"traceutil/trace.go:171","msg":"trace[817824106] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"143.421753ms","start":"2026-05-06T00:43:59.81434Z","end":"2026-05-06T00:43:59.957761Z","steps":["trace[817824106] 'process raft request' (duration: 143.02438ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:43:59.957728Z","caller":"traceutil/trace.go:171","msg":"trace[1455196365] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:753; }","duration":"106.780661ms","start":"2026-05-06T00:43:59.850934Z","end":"2026-05-06T00:43:59.957715Z","steps":["trace[1455196365] 'agreement among raft nodes before linearized reading' (duration: 106.639117ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:44:12.329111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.165054ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-06T00:44:12.329224Z","caller":"traceutil/trace.go:171","msg":"trace[2043201239] linearizableReadLoop","detail":"{readStateIndex:930; appliedIndex:929; }","duration":"121.214312ms","start":"2026-05-06T00:44:12.207994Z","end":"2026-05-06T00:44:12.329208Z","steps":["trace[2043201239] 'read index received' (duration: 41.562µs)","trace[2043201239] 'applied index is now lower than readState.Index' (duration: 121.17153ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T00:44:12.329357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.360677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-06T00:44:12.329391Z","caller":"traceutil/trace.go:171","msg":"trace[1615190571] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:901; }","duration":"121.434339ms","start":"2026-05-06T00:44:12.207946Z","end":"2026-05-06T00:44:12.329381Z","steps":["trace[1615190571] 'agreement among raft nodes before linearized reading' (duration: 121.312965ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:44:12.329467Z","caller":"traceutil/trace.go:171","msg":"trace[2082483631] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"318.970551ms","start":"2026-05-06T00:44:12.010457Z","end":"2026-05-06T00:44:12.329428Z","steps":["trace[2082483631] 'process raft request' (duration: 54.381565ms)","trace[2082483631] 'compare' (duration: 264.02023ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T00:44:12.329635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:44:12.010434Z","time spent":"319.118346ms","remote":"127.0.0.1:50086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T00:44:12.655604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.199424ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-06T00:44:12.656008Z","caller":"traceutil/trace.go:171","msg":"trace[1391790671] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"322.290995ms","start":"2026-05-06T00:44:12.333691Z","end":"2026-05-06T00:44:12.655982Z","steps":["trace[1391790671] 'process raft request' (duration: 202.631418ms)","trace[1391790671] 'compare' (duration: 118.961258ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T00:44:12.656034Z","caller":"traceutil/trace.go:171","msg":"trace[2046232852] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"321.8063ms","start":"2026-05-06T00:44:12.334206Z","end":"2026-05-06T00:44:12.656012Z","steps":["trace[2046232852] 'process raft request' (duration: 321.647386ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:44:12.656134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:44:12.333671Z","time spent":"322.393818ms","remote":"127.0.0.1:50086","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-06T00:44:12.656138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:44:12.334183Z","time spent":"321.904463ms","remote":"127.0.0.1:50086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T00:44:12.891685Z","caller":"traceutil/trace.go:171","msg":"trace[1433826398] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"216.850136ms","start":"2026-05-06T00:44:12.6748Z","end":"2026-05-06T00:44:12.891651Z","steps":["trace[1433826398] 'process raft request' (duration: 131.83359ms)","trace[1433826398] 'compare' (duration: 84.888322ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T00:44:13.289696Z","caller":"traceutil/trace.go:171","msg":"trace[1153866730] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"118.411697ms","start":"2026-05-06T00:44:13.171262Z","end":"2026-05-06T00:44:13.289674Z","steps":["trace[1153866730] 'process raft request' (duration: 29.841274ms)","trace[1153866730] 'compare' (duration: 88.476311ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T00:44:14.233121Z","caller":"traceutil/trace.go:171","msg":"trace[161480191] linearizableReadLoop","detail":"{readStateIndex:937; appliedIndex:936; }","duration":"204.928625ms","start":"2026-05-06T00:44:14.028171Z","end":"2026-05-06T00:44:14.2331Z","steps":["trace[161480191] 'read index received' (duration: 204.707899ms)","trace[161480191] 'applied index is now lower than readState.Index' (duration: 219.566µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T00:44:14.233432Z","caller":"traceutil/trace.go:171","msg":"trace[286383153] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"257.19378ms","start":"2026-05-06T00:44:13.976222Z","end":"2026-05-06T00:44:14.233415Z","steps":["trace[286383153] 'process raft request' (duration: 256.723987ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:44:14.233701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.507001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T00:44:14.233827Z","caller":"traceutil/trace.go:171","msg":"trace[503025118] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:907; }","duration":"205.667806ms","start":"2026-05-06T00:44:14.02814Z","end":"2026-05-06T00:44:14.233807Z","steps":["trace[503025118] 'agreement among raft nodes before linearized reading' (duration: 205.504892ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:45:31.286091Z","caller":"traceutil/trace.go:171","msg":"trace[970740665] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"130.859956ms","start":"2026-05-06T00:45:31.15518Z","end":"2026-05-06T00:45:31.28604Z","steps":["trace[970740665] 'process raft request' (duration: 129.542017ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:45:56.010767Z","caller":"traceutil/trace.go:171","msg":"trace[24409354] linearizableReadLoop","detail":"{readStateIndex:1353; appliedIndex:1352; }","duration":"317.122028ms","start":"2026-05-06T00:45:55.693622Z","end":"2026-05-06T00:45:56.010744Z","steps":["trace[24409354] 'read index received' (duration: 316.924613ms)","trace[24409354] 'applied index is now lower than readState.Index' (duration: 196.525µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T00:45:56.01085Z","caller":"traceutil/trace.go:171","msg":"trace[1990346388] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"344.126272ms","start":"2026-05-06T00:45:55.666691Z","end":"2026-05-06T00:45:56.010818Z","steps":["trace[1990346388] 'process raft request' (duration: 343.908536ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:45:56.010997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.363147ms","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-06T00:45:56.011038Z","caller":"traceutil/trace.go:171","msg":"trace[610795887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1300; }","duration":"317.465969ms","start":"2026-05-06T00:45:55.693562Z","end":"2026-05-06T00:45:56.011028Z","steps":["trace[610795887] 'agreement among raft nodes before linearized reading' (duration: 317.306104ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:45:56.011031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:45:55.666652Z","time spent":"344.272257ms","remote":"127.0.0.1:50086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T00:45:56.011074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T00:45:55.693531Z","time spent":"317.534651ms","remote":"127.0.0.1:50086","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-06T00:45:56.011241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.715303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T00:45:56.011365Z","caller":"traceutil/trace.go:171","msg":"trace[773789746] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1300; }","duration":"158.876948ms","start":"2026-05-06T00:45:55.85247Z","end":"2026-05-06T00:45:56.011347Z","steps":["trace[773789746] 'agreement among raft nodes before linearized reading' (duration: 158.551469ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T00:46:01.612888Z","caller":"traceutil/trace.go:171","msg":"trace[769160498] linearizableReadLoop","detail":"{readStateIndex:1376; appliedIndex:1375; }","duration":"181.712727ms","start":"2026-05-06T00:46:01.431153Z","end":"2026-05-06T00:46:01.612865Z","steps":["trace[769160498] 'read index received' (duration: 181.506972ms)","trace[769160498] 'applied index is now lower than readState.Index' (duration: 204.835µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T00:46:01.613028Z","caller":"traceutil/trace.go:171","msg":"trace[1214766495] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"217.842636ms","start":"2026-05-06T00:46:01.395158Z","end":"2026-05-06T00:46:01.613Z","steps":["trace[1214766495] 'process raft request' (duration: 217.575179ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:46:01.613169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.198352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-06T00:46:01.613204Z","caller":"traceutil/trace.go:171","msg":"trace[1433567621] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1322; }","duration":"173.259243ms","start":"2026-05-06T00:46:01.439935Z","end":"2026-05-06T00:46:01.613195Z","steps":["trace[1433567621] 'agreement among raft nodes before linearized reading' (duration: 173.13786ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T00:46:01.613261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.088528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329944"} {"level":"info","ts":"2026-05-06T00:46:01.613313Z","caller":"traceutil/trace.go:171","msg":"trace[633809738] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1322; }","duration":"182.18551ms","start":"2026-05-06T00:46:01.431112Z","end":"2026-05-06T00:46:01.613298Z","steps":["trace[633809738] 'agreement among raft nodes before linearized reading' (duration: 181.906052ms)"],"step_count":1}