{"level":"warn","ts":"2026-04-22T00:21:41.469997Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-22T00:21:41.470181Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.210:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.210:2380","--initial-cluster=instance=https://199.204.45.210:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.210:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.210: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-04-22T00:21:41.470309Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-22T00:21:41.470322Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-04-22T00:21:41.470348Z","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-04-22T00:21:41.471512Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"]} {"level":"info","ts":"2026-04-22T00:21:41.471631Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.210: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-04-22T00:21:41.478577Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.409968ms"} {"level":"info","ts":"2026-04-22T00:21:41.490091Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1cac722af8b2b8a6","cluster-id":"ba0a336ca61ee41d"} {"level":"info","ts":"2026-04-22T00:21:41.490238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T00:21:41.490271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 0"} {"level":"info","ts":"2026-04-22T00:21:41.49029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1cac722af8b2b8a6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-22T00:21:41.490304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 1"} {"level":"info","ts":"2026-04-22T00:21:41.490358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"warn","ts":"2026-04-22T00:21:41.501978Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T00:21:41.511781Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-22T00:21:41.514388Z","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-04-22T00:21:41.517904Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1cac722af8b2b8a6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-22T00:21:41.518161Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1cac722af8b2b8a6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-22T00:21:41.518377Z","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-04-22T00:21:41.518431Z","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-04-22T00:21:41.518438Z","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-04-22T00:21:41.52134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"info","ts":"2026-04-22T00:21:41.522351Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","added-peer-id":"1cac722af8b2b8a6","added-peer-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-04-22T00:21:41.523019Z","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-04-22T00:21:41.523253Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1cac722af8b2b8a6","initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-22T00:21:41.523277Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T00:21:41.523378Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-04-22T00:21:41.52339Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-04-22T00:21:41.591598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 is starting a new election at term 1"} {"level":"info","ts":"2026-04-22T00:21:41.591893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-22T00:21:41.592048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgPreVoteResp from 1cac722af8b2b8a6 at term 1"} {"level":"info","ts":"2026-04-22T00:21:41.592182Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became candidate at term 2"} {"level":"info","ts":"2026-04-22T00:21:41.592284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgVoteResp from 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-04-22T00:21:41.592442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became leader at term 2"} {"level":"info","ts":"2026-04-22T00:21:41.592534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1cac722af8b2b8a6 elected leader 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-04-22T00:21:41.593719Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:21:41.594936Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T00:21:41.594932Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1cac722af8b2b8a6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.210:2379]}","request-path":"/0/members/1cac722af8b2b8a6/attributes","cluster-id":"ba0a336ca61ee41d","publish-timeout":"7s"} {"level":"info","ts":"2026-04-22T00:21:41.595127Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T00:21:41.59601Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T00:21:41.596076Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-22T00:21:41.59746Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-22T00:21:41.59753Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.210:2379"} {"level":"info","ts":"2026-04-22T00:21:41.602803Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:21:41.603047Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:21:41.603196Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:21:45.889619Z","caller":"traceutil/trace.go:171","msg":"trace[1830509358] transaction","detail":"{read_only:false; response_revision:160; number_of_response:1; }","duration":"276.290555ms","start":"2026-04-22T00:21:45.613288Z","end":"2026-04-22T00:21:45.889579Z","steps":["trace[1830509358] 'process raft request' (duration: 231.180228ms)","trace[1830509358] 'compare' (duration: 44.942962ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:21:46.142383Z","caller":"traceutil/trace.go:171","msg":"trace[605043117] transaction","detail":"{read_only:false; response_revision:165; number_of_response:1; }","duration":"180.935149ms","start":"2026-04-22T00:21:45.961433Z","end":"2026-04-22T00:21:46.142368Z","steps":["trace[605043117] 'process raft request' (duration: 127.139991ms)","trace[605043117] 'compare' (duration: 53.557301ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:21:46.142314Z","caller":"traceutil/trace.go:171","msg":"trace[826739043] linearizableReadLoop","detail":"{readStateIndex:169; appliedIndex:168; }","duration":"139.081395ms","start":"2026-04-22T00:21:46.0032Z","end":"2026-04-22T00:21:46.142281Z","steps":["trace[826739043] 'read index received' (duration: 85.299617ms)","trace[826739043] 'applied index is now lower than readState.Index' (duration: 53.780348ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:21:46.14263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.399706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:21:46.142755Z","caller":"traceutil/trace.go:171","msg":"trace[2066275057] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:165; }","duration":"139.577731ms","start":"2026-04-22T00:21:46.003153Z","end":"2026-04-22T00:21:46.142731Z","steps":["trace[2066275057] 'agreement among raft nodes before linearized reading' (duration: 139.339133ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:21:46.343349Z","caller":"traceutil/trace.go:171","msg":"trace[465728260] transaction","detail":"{read_only:false; response_revision:173; number_of_response:1; }","duration":"104.767168ms","start":"2026-04-22T00:21:46.23855Z","end":"2026-04-22T00:21:46.343317Z","steps":["trace[465728260] 'process raft request' (duration: 39.765828ms)","trace[465728260] 'compare' (duration: 64.850676ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:21:46.344099Z","caller":"traceutil/trace.go:171","msg":"trace[343197818] transaction","detail":"{read_only:false; response_revision:174; number_of_response:1; }","duration":"101.868817ms","start":"2026-04-22T00:21:46.242195Z","end":"2026-04-22T00:21:46.344064Z","steps":["trace[343197818] 'process raft request' (duration: 101.590279ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:21:46.588927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.582737ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-22T00:21:46.589096Z","caller":"traceutil/trace.go:171","msg":"trace[595435805] transaction","detail":"{read_only:false; response_revision:181; number_of_response:1; }","duration":"186.36158ms","start":"2026-04-22T00:21:46.402699Z","end":"2026-04-22T00:21:46.58906Z","steps":["trace[595435805] 'process raft request' (duration: 65.815146ms)","trace[595435805] 'compare' (duration: 115.399012ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:21:46.885311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.577521ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-22T00:21:46.885623Z","caller":"traceutil/trace.go:171","msg":"trace[1697604873] transaction","detail":"{read_only:false; response_revision:186; number_of_response:1; }","duration":"228.231863ms","start":"2026-04-22T00:21:46.657347Z","end":"2026-04-22T00:21:46.885578Z","steps":["trace[1697604873] 'process raft request' (duration: 58.286901ms)","trace[1697604873] 'compare' (duration: 169.355655ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:21:49.271345Z","caller":"traceutil/trace.go:171","msg":"trace[6644745] linearizableReadLoop","detail":"{readStateIndex:289; appliedIndex:288; }","duration":"277.515856ms","start":"2026-04-22T00:21:48.993792Z","end":"2026-04-22T00:21:49.271308Z","steps":["trace[6644745] 'read index received' (duration: 276.278188ms)","trace[6644745] 'applied index is now lower than readState.Index' (duration: 1.236678ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:21:49.271395Z","caller":"traceutil/trace.go:171","msg":"trace[327155336] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"282.904053ms","start":"2026-04-22T00:21:48.988449Z","end":"2026-04-22T00:21:49.271353Z","steps":["trace[327155336] 'process raft request' (duration: 281.671505ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:21:49.271584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.771624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-22T00:21:49.271667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.797678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:21:49.271703Z","caller":"traceutil/trace.go:171","msg":"trace[1174496698] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:0; response_revision:283; }","duration":"269.897701ms","start":"2026-04-22T00:21:49.001793Z","end":"2026-04-22T00:21:49.271691Z","steps":["trace[1174496698] 'agreement among raft nodes before linearized reading' (duration: 269.814679ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:21:49.271654Z","caller":"traceutil/trace.go:171","msg":"trace[1083018089] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:283; }","duration":"277.898478ms","start":"2026-04-22T00:21:48.993741Z","end":"2026-04-22T00:21:49.271639Z","steps":["trace[1083018089] 'agreement among raft nodes before linearized reading' (duration: 277.729592ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:19.610563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.816631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-22T00:22:19.610703Z","caller":"traceutil/trace.go:171","msg":"trace[778899734] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:529; }","duration":"170.033656ms","start":"2026-04-22T00:22:19.440642Z","end":"2026-04-22T00:22:19.610675Z","steps":["trace[778899734] 'range keys from in-memory index tree' (duration: 169.664115ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:20.672966Z","caller":"traceutil/trace.go:171","msg":"trace[224124589] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"529.705296ms","start":"2026-04-22T00:22:20.143234Z","end":"2026-04-22T00:22:20.672939Z","steps":["trace[224124589] 'process raft request' (duration: 529.513031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:20.673286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:20.143212Z","time spent":"529.847509ms","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:22:20.754038Z","caller":"traceutil/trace.go:171","msg":"trace[1181350049] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"592.718453ms","start":"2026-04-22T00:22:20.161275Z","end":"2026-04-22T00:22:20.753994Z","steps":["trace[1181350049] 'process raft request' (duration: 592.387875ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:20.754128Z","caller":"traceutil/trace.go:171","msg":"trace[1974463733] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"564.58929ms","start":"2026-04-22T00:22:20.189527Z","end":"2026-04-22T00:22:20.754117Z","steps":["trace[1974463733] 'process raft request' (duration: 564.428746ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:20.754121Z","caller":"traceutil/trace.go:171","msg":"trace[1736090467] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"588.556658ms","start":"2026-04-22T00:22:20.165526Z","end":"2026-04-22T00:22:20.754082Z","steps":["trace[1736090467] 'process raft request' (duration: 588.387653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:20.75423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:20.189497Z","time spent":"564.654382ms","remote":"127.0.0.1:40040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T00:22:20.754245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:20.161248Z","time spent":"592.890729ms","remote":"127.0.0.1:40040","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-04-22T00:22:20.754286Z","caller":"traceutil/trace.go:171","msg":"trace[893358930] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"553.541981ms","start":"2026-04-22T00:22:20.200668Z","end":"2026-04-22T00:22:20.75421Z","steps":["trace[893358930] 'process raft request' (duration: 553.329254ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:20.754539Z","caller":"traceutil/trace.go:171","msg":"trace[1808224398] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"483.905124ms","start":"2026-04-22T00:22:20.270606Z","end":"2026-04-22T00:22:20.754511Z","steps":["trace[1808224398] 'process raft request' (duration: 483.75751ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:20.754569Z","caller":"traceutil/trace.go:171","msg":"trace[1058025423] linearizableReadLoop","detail":"{readStateIndex:564; appliedIndex:551; }","duration":"152.486638ms","start":"2026-04-22T00:22:20.602065Z","end":"2026-04-22T00:22:20.754552Z","steps":["trace[1058025423] 'read index received' (duration: 70.58899ms)","trace[1058025423] 'applied index is now lower than readState.Index' (duration: 81.896818ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:22:20.754565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:20.20064Z","time spent":"553.90303ms","remote":"127.0.0.1:40040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T00:22:20.754618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:20.270575Z","time spent":"483.992446ms","remote":"127.0.0.1:40040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T00:22:20.754358Z","caller":"traceutil/trace.go:171","msg":"trace[89978417] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"528.202468ms","start":"2026-04-22T00:22:20.226139Z","end":"2026-04-22T00:22:20.754342Z","steps":["trace[89978417] 'process raft request' (duration: 528.055604ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:20.754747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:20.226117Z","time spent":"528.601698ms","remote":"127.0.0.1:40040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T00:22:20.754788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.718883ms","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-04-22T00:22:20.755219Z","caller":"traceutil/trace.go:171","msg":"trace[1567188946] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:543; }","duration":"153.208377ms","start":"2026-04-22T00:22:20.602Z","end":"2026-04-22T00:22:20.755209Z","steps":["trace[1567188946] 'agreement among raft nodes before linearized reading' (duration: 152.635402ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:20.754803Z","caller":"traceutil/trace.go:171","msg":"trace[2068997918] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"348.738275ms","start":"2026-04-22T00:22:20.405913Z","end":"2026-04-22T00:22:20.754652Z","steps":["trace[2068997918] 'process raft request' (duration: 348.52595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:20.755381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:20.405871Z","time spent":"349.483794ms","remote":"127.0.0.1:40040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T00:22:20.754372Z","caller":"traceutil/trace.go:171","msg":"trace[880693203] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"525.672963ms","start":"2026-04-22T00:22:20.228688Z","end":"2026-04-22T00:22:20.754361Z","steps":["trace[880693203] 'process raft request' (duration: 525.55538ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:20.755515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:20.228671Z","time spent":"526.824822ms","remote":"127.0.0.1:40040","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-04-22T00:22:20.754363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:20.165518Z","time spent":"588.715192ms","remote":"127.0.0.1:40040","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-04-22T00:22:20.754411Z","caller":"traceutil/trace.go:171","msg":"trace[648987836] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"531.406249ms","start":"2026-04-22T00:22:20.222959Z","end":"2026-04-22T00:22:20.754365Z","steps":["trace[648987836] 'process raft request' (duration: 531.197364ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:20.755825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:20.222933Z","time spent":"532.870156ms","remote":"127.0.0.1:40040","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-04-22T00:22:20.754429Z","caller":"traceutil/trace.go:171","msg":"trace[1570017468] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"521.765295ms","start":"2026-04-22T00:22:20.232653Z","end":"2026-04-22T00:22:20.754418Z","steps":["trace[1570017468] 'process raft request' (duration: 521.642392ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:20.756093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:20.232624Z","time spent":"523.448966ms","remote":"127.0.0.1:40040","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-04-22T00:22:20.754365Z","caller":"traceutil/trace.go:171","msg":"trace[1216998120] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"545.057196ms","start":"2026-04-22T00:22:20.209235Z","end":"2026-04-22T00:22:20.754292Z","steps":["trace[1216998120] 'process raft request' (duration: 544.87471ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:20.756185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:20.209207Z","time spent":"546.962684ms","remote":"127.0.0.1:40040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T00:22:20.754864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.426695ms","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-04-22T00:22:20.75634Z","caller":"traceutil/trace.go:171","msg":"trace[645465544] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:543; }","duration":"138.977695ms","start":"2026-04-22T00:22:20.617354Z","end":"2026-04-22T00:22:20.756332Z","steps":["trace[645465544] 'agreement among raft nodes before linearized reading' (duration: 137.381174ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:20.754062Z","caller":"traceutil/trace.go:171","msg":"trace[1656437630] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"588.67009ms","start":"2026-04-22T00:22:20.165356Z","end":"2026-04-22T00:22:20.754026Z","steps":["trace[1656437630] 'process raft request' (duration: 588.517046ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:20.756552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:20.165329Z","time spent":"591.201806ms","remote":"127.0.0.1:40040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T00:22:20.979601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.565003ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T00:22:20.979849Z","caller":"traceutil/trace.go:171","msg":"trace[996688930] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"217.533058ms","start":"2026-04-22T00:22:20.762292Z","end":"2026-04-22T00:22:20.979825Z","steps":["trace[996688930] 'process raft request' (duration: 108.635236ms)","trace[996688930] 'compare' (duration: 108.41636ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:22:20.979899Z","caller":"traceutil/trace.go:171","msg":"trace[944998386] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"179.500823ms","start":"2026-04-22T00:22:20.80039Z","end":"2026-04-22T00:22:20.979891Z","steps":["trace[944998386] 'process raft request' (duration: 179.423381ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:20.979906Z","caller":"traceutil/trace.go:171","msg":"trace[1029646297] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"213.656699ms","start":"2026-04-22T00:22:20.766242Z","end":"2026-04-22T00:22:20.979899Z","steps":["trace[1029646297] 'process raft request' (duration: 213.479035ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:20.982133Z","caller":"traceutil/trace.go:171","msg":"trace[507079910] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"180.273502ms","start":"2026-04-22T00:22:20.801833Z","end":"2026-04-22T00:22:20.982107Z","steps":["trace[507079910] 'process raft request' (duration: 178.029405ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:20.982464Z","caller":"traceutil/trace.go:171","msg":"trace[102264399] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"179.650247ms","start":"2026-04-22T00:22:20.80027Z","end":"2026-04-22T00:22:20.97992Z","steps":["trace[102264399] 'process raft request' (duration: 179.505183ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:20.983625Z","caller":"traceutil/trace.go:171","msg":"trace[1699359174] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"180.198071ms","start":"2026-04-22T00:22:20.80339Z","end":"2026-04-22T00:22:20.983588Z","steps":["trace[1699359174] 'process raft request' (duration: 177.905823ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:20.984143Z","caller":"traceutil/trace.go:171","msg":"trace[574159658] transaction","detail":"{read_only:false; number_of_response:1; response_revision:549; }","duration":"179.37777ms","start":"2026-04-22T00:22:20.804731Z","end":"2026-04-22T00:22:20.984109Z","steps":["trace[574159658] 'process raft request' (duration: 178.429376ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:20.984989Z","caller":"traceutil/trace.go:171","msg":"trace[683159074] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"168.827803ms","start":"2026-04-22T00:22:20.816137Z","end":"2026-04-22T00:22:20.984965Z","steps":["trace[683159074] 'process raft request' (duration: 167.11459ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:20.985239Z","caller":"traceutil/trace.go:171","msg":"trace[307594506] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"164.325537ms","start":"2026-04-22T00:22:20.820788Z","end":"2026-04-22T00:22:20.985114Z","steps":["trace[307594506] 'process raft request' (duration: 163.788454ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:20.985358Z","caller":"traceutil/trace.go:171","msg":"trace[911006226] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"161.421415ms","start":"2026-04-22T00:22:20.823761Z","end":"2026-04-22T00:22:20.985182Z","steps":["trace[911006226] 'process raft request' (duration: 160.888201ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:20.985943Z","caller":"traceutil/trace.go:171","msg":"trace[952920750] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"136.232146ms","start":"2026-04-22T00:22:20.849696Z","end":"2026-04-22T00:22:20.985929Z","steps":["trace[952920750] 'process raft request' (duration: 135.373863ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:20.989584Z","caller":"traceutil/trace.go:171","msg":"trace[554137515] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"139.370855ms","start":"2026-04-22T00:22:20.850161Z","end":"2026-04-22T00:22:20.989532Z","steps":["trace[554137515] 'process raft request' (duration: 135.555308ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:20.991801Z","caller":"traceutil/trace.go:171","msg":"trace[1104354115] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"142.179526ms","start":"2026-04-22T00:22:20.849606Z","end":"2026-04-22T00:22:20.991785Z","steps":["trace[1104354115] 'process raft request' (duration: 140.051652ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:21.072683Z","caller":"traceutil/trace.go:171","msg":"trace[1145674484] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"185.120746ms","start":"2026-04-22T00:22:20.887531Z","end":"2026-04-22T00:22:21.072651Z","steps":["trace[1145674484] 'process raft request' (duration: 184.969763ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:21.438423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.009798ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-04-22T00:22:21.43866Z","caller":"traceutil/trace.go:171","msg":"trace[215432339] transaction","detail":"{read_only:false; number_of_response:0; response_revision:556; }","duration":"447.163125ms","start":"2026-04-22T00:22:20.991446Z","end":"2026-04-22T00:22:21.438609Z","steps":["trace[215432339] 'process raft request' (duration: 223.885011ms)","trace[215432339] 'compare' (duration: 222.925166ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:22:21.438752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:20.99142Z","time spent":"447.304109ms","remote":"127.0.0.1:40494","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-04-22T00:22:21.43926Z","caller":"traceutil/trace.go:171","msg":"trace[482154359] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"435.820857ms","start":"2026-04-22T00:22:21.003407Z","end":"2026-04-22T00:22:21.439228Z","steps":["trace[482154359] 'process raft request' (duration: 435.519599ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:21.43932Z","caller":"traceutil/trace.go:171","msg":"trace[1930872255] transaction","detail":"{read_only:false; number_of_response:0; response_revision:556; }","duration":"447.245837ms","start":"2026-04-22T00:22:20.992063Z","end":"2026-04-22T00:22:21.439309Z","steps":["trace[1930872255] 'process raft request' (duration: 446.479798ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:21.439411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:20.992027Z","time spent":"447.32533ms","remote":"127.0.0.1:40494","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T00:22:21.439461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:21.003377Z","time spent":"435.97208ms","remote":"127.0.0.1:40040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10488,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:22:21.439633Z","caller":"traceutil/trace.go:171","msg":"trace[1635365001] transaction","detail":"{read_only:false; number_of_response:1; response_revision:559; }","duration":"432.720679ms","start":"2026-04-22T00:22:21.006895Z","end":"2026-04-22T00:22:21.439616Z","steps":["trace[1635365001] 'process raft request' (duration: 432.255717ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:21.439707Z","caller":"traceutil/trace.go:171","msg":"trace[1873173473] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"446.739954ms","start":"2026-04-22T00:22:20.992958Z","end":"2026-04-22T00:22:21.439698Z","steps":["trace[1873173473] 'process raft request' (duration: 445.674976ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:21.439759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:20.992944Z","time spent":"446.790556ms","remote":"127.0.0.1:40040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7684,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:22:21.439894Z","caller":"traceutil/trace.go:171","msg":"trace[799114626] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"432.765709ms","start":"2026-04-22T00:22:21.007086Z","end":"2026-04-22T00:22:21.439852Z","steps":["trace[799114626] 'process raft request' (duration: 432.116423ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:21.440001Z","caller":"traceutil/trace.go:171","msg":"trace[1028576836] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"436.492514ms","start":"2026-04-22T00:22:21.003499Z","end":"2026-04-22T00:22:21.439992Z","steps":["trace[1028576836] 'process raft request' (duration: 435.564031ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:21.440107Z","caller":"traceutil/trace.go:171","msg":"trace[1051011972] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"425.664611ms","start":"2026-04-22T00:22:21.014431Z","end":"2026-04-22T00:22:21.440095Z","steps":["trace[1051011972] 'process raft request' (duration: 424.892932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:21.440226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:21.014388Z","time spent":"425.782304ms","remote":"127.0.0.1:40040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:22:21.440005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:21.007056Z","time spent":"432.876722ms","remote":"127.0.0.1:40040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:22:21.440112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:21.003471Z","time spent":"436.591145ms","remote":"127.0.0.1:40040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:22:21.439898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:21.006867Z","time spent":"432.961594ms","remote":"127.0.0.1:40040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":101,"response count":0,"response size":10537,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:22:21.440117Z","caller":"traceutil/trace.go:171","msg":"trace[316155734] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"380.447759ms","start":"2026-04-22T00:22:21.059648Z","end":"2026-04-22T00:22:21.440096Z","steps":["trace[316155734] 'process raft request' (duration: 380.014469ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:21.440823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:21.059616Z","time spent":"381.072825ms","remote":"127.0.0.1:40040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:22:21.454017Z","caller":"traceutil/trace.go:171","msg":"trace[1709945751] linearizableReadLoop","detail":"{readStateIndex:588; appliedIndex:578; }","duration":"308.459183ms","start":"2026-04-22T00:22:21.145535Z","end":"2026-04-22T00:22:21.453994Z","steps":["trace[1709945751] 'read index received' (duration: 69.799951ms)","trace[1709945751] 'applied index is now lower than readState.Index' (duration: 238.658152ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:22:21.454123Z","caller":"traceutil/trace.go:171","msg":"trace[1232672820] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"281.684828ms","start":"2026-04-22T00:22:21.172421Z","end":"2026-04-22T00:22:21.454106Z","steps":["trace[1232672820] 'process raft request' (duration: 281.525114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:21.454266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.70547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-22T00:22:21.454305Z","caller":"traceutil/trace.go:171","msg":"trace[1529277017] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:564; }","duration":"308.809692ms","start":"2026-04-22T00:22:21.145483Z","end":"2026-04-22T00:22:21.454293Z","steps":["trace[1529277017] 'agreement among raft nodes before linearized reading' (duration: 308.678708ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:21.454332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:21.145458Z","time spent":"308.865325ms","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-22T00:22:21.454138Z","caller":"traceutil/trace.go:171","msg":"trace[59267916] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"375.804112ms","start":"2026-04-22T00:22:21.07832Z","end":"2026-04-22T00:22:21.454124Z","steps":["trace[59267916] 'process raft request' (duration: 375.481585ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:21.454491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:21.078297Z","time spent":"376.140261ms","remote":"127.0.0.1:40494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T00:22:21.679756Z","caller":"traceutil/trace.go:171","msg":"trace[1425680568] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"232.324353ms","start":"2026-04-22T00:22:21.447402Z","end":"2026-04-22T00:22:21.679726Z","steps":["trace[1425680568] 'process raft request' (duration: 214.925653ms)","trace[1425680568] 'compare' (duration: 17.153183ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:22:21.679941Z","caller":"traceutil/trace.go:171","msg":"trace[407921645] linearizableReadLoop","detail":"{readStateIndex:591; appliedIndex:589; }","duration":"225.740177ms","start":"2026-04-22T00:22:21.454163Z","end":"2026-04-22T00:22:21.679904Z","steps":["trace[407921645] 'read index received' (duration: 208.091442ms)","trace[407921645] 'applied index is now lower than readState.Index' (duration: 17.641765ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:22:21.680089Z","caller":"traceutil/trace.go:171","msg":"trace[650882611] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"227.11173ms","start":"2026-04-22T00:22:21.452965Z","end":"2026-04-22T00:22:21.680077Z","steps":["trace[650882611] 'process raft request' (duration: 226.70072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:21.680306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.339084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1010"} {"level":"info","ts":"2026-04-22T00:22:21.680361Z","caller":"traceutil/trace.go:171","msg":"trace[455527053] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:566; }","duration":"238.416545ms","start":"2026-04-22T00:22:21.44193Z","end":"2026-04-22T00:22:21.680346Z","steps":["trace[455527053] 'agreement among raft nodes before linearized reading' (duration: 238.1858ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:21.6806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.697344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:1019"} {"level":"info","ts":"2026-04-22T00:22:21.680677Z","caller":"traceutil/trace.go:171","msg":"trace[689946960] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:566; }","duration":"238.794686ms","start":"2026-04-22T00:22:21.441867Z","end":"2026-04-22T00:22:21.680662Z","steps":["trace[689946960] 'agreement among raft nodes before linearized reading' (duration: 238.313783ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:21.6957Z","caller":"traceutil/trace.go:171","msg":"trace[337547682] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"227.272474ms","start":"2026-04-22T00:22:21.468384Z","end":"2026-04-22T00:22:21.695656Z","steps":["trace[337547682] 'process raft request' (duration: 227.034578ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:21.695838Z","caller":"traceutil/trace.go:171","msg":"trace[679413107] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"172.147094ms","start":"2026-04-22T00:22:21.523652Z","end":"2026-04-22T00:22:21.6958Z","steps":["trace[679413107] 'process raft request' (duration: 172.01107ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:21.695909Z","caller":"traceutil/trace.go:171","msg":"trace[1368343964] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"225.953771ms","start":"2026-04-22T00:22:21.469948Z","end":"2026-04-22T00:22:21.695902Z","steps":["trace[1368343964] 'process raft request' (duration: 225.608252ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:22.942522Z","caller":"traceutil/trace.go:171","msg":"trace[709550360] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"387.029915ms","start":"2026-04-22T00:22:22.555443Z","end":"2026-04-22T00:22:22.942472Z","steps":["trace[709550360] 'process raft request' (duration: 367.269249ms)","trace[709550360] 'compare' (duration: 18.790772ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:22:22.942761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:22.555407Z","time spent":"387.222181ms","remote":"127.0.0.1:40040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20842,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:22:22.949352Z","caller":"traceutil/trace.go:171","msg":"trace[297417232] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"284.571683ms","start":"2026-04-22T00:22:22.664752Z","end":"2026-04-22T00:22:22.949324Z","steps":["trace[297417232] 'process raft request' (duration: 284.198284ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:22.949595Z","caller":"traceutil/trace.go:171","msg":"trace[1491433434] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:621; }","duration":"371.373342ms","start":"2026-04-22T00:22:22.578185Z","end":"2026-04-22T00:22:22.949558Z","steps":["trace[1491433434] 'read index received' (duration: 344.441286ms)","trace[1491433434] 'applied index is now lower than readState.Index' (duration: 26.930676ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:22:22.949672Z","caller":"traceutil/trace.go:171","msg":"trace[1969711300] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"158.982472ms","start":"2026-04-22T00:22:22.790676Z","end":"2026-04-22T00:22:22.949659Z","steps":["trace[1969711300] 'process raft request' (duration: 158.585032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:22.949847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.628819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T00:22:22.94987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.592338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:22:22.949911Z","caller":"traceutil/trace.go:171","msg":"trace[761164564] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:599; }","duration":"371.66741ms","start":"2026-04-22T00:22:22.57823Z","end":"2026-04-22T00:22:22.949898Z","steps":["trace[761164564] 'agreement among raft nodes before linearized reading' (duration: 371.572158ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:22.949942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:22.578223Z","time spent":"371.707381ms","remote":"127.0.0.1:38830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"info","ts":"2026-04-22T00:22:22.94988Z","caller":"traceutil/trace.go:171","msg":"trace[187729220] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:599; }","duration":"371.729951ms","start":"2026-04-22T00:22:22.578138Z","end":"2026-04-22T00:22:22.949868Z","steps":["trace[187729220] 'agreement among raft nodes before linearized reading' (duration: 371.591758ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:22.950058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:22.578114Z","time spent":"371.896205ms","remote":"127.0.0.1:38830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-22T00:22:23.691647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.800079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:80703"} {"level":"info","ts":"2026-04-22T00:22:23.691799Z","caller":"traceutil/trace.go:171","msg":"trace[466105373] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:602; }","duration":"598.077206ms","start":"2026-04-22T00:22:23.093651Z","end":"2026-04-22T00:22:23.691728Z","steps":["trace[466105373] 'range keys from in-memory index tree' (duration: 597.555623ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:23.691852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:23.093624Z","time spent":"598.21607ms","remote":"127.0.0.1:40040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":1,"response size":80726,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-04-22T00:22:23.693397Z","caller":"traceutil/trace.go:171","msg":"trace[1446272120] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"540.193171ms","start":"2026-04-22T00:22:23.153169Z","end":"2026-04-22T00:22:23.693363Z","steps":["trace[1446272120] 'process raft request' (duration: 539.906203ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:23.693649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:23.153134Z","time spent":"540.398026ms","remote":"127.0.0.1:40040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98698,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:22:23.723823Z","caller":"traceutil/trace.go:171","msg":"trace[318443336] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"493.085394ms","start":"2026-04-22T00:22:23.230699Z","end":"2026-04-22T00:22:23.723784Z","steps":["trace[318443336] 'process raft request' (duration: 491.863504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:23.724004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:23.230659Z","time spent":"493.242008ms","remote":"127.0.0.1:40040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:22:30.04998Z","caller":"traceutil/trace.go:171","msg":"trace[1255161623] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"266.544315ms","start":"2026-04-22T00:22:29.783397Z","end":"2026-04-22T00:22:30.049941Z","steps":["trace[1255161623] 'process raft request' (duration: 266.28455ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:30.050237Z","caller":"traceutil/trace.go:171","msg":"trace[112288424] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:660; }","duration":"260.334015ms","start":"2026-04-22T00:22:29.789852Z","end":"2026-04-22T00:22:30.050186Z","steps":["trace[112288424] 'read index received' (duration: 260.310525ms)","trace[112288424] 'applied index is now lower than readState.Index' (duration: 18.55µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:22:30.05054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.674913ms","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-04-22T00:22:30.050598Z","caller":"traceutil/trace.go:171","msg":"trace[524606660] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:633; }","duration":"260.805466ms","start":"2026-04-22T00:22:29.789783Z","end":"2026-04-22T00:22:30.050589Z","steps":["trace[524606660] 'agreement among raft nodes before linearized reading' (duration: 260.54976ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:30.129011Z","caller":"traceutil/trace.go:171","msg":"trace[1002881989] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"243.213501ms","start":"2026-04-22T00:22:29.885763Z","end":"2026-04-22T00:22:30.128977Z","steps":["trace[1002881989] 'process raft request' (duration: 242.478614ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:32.265738Z","caller":"traceutil/trace.go:171","msg":"trace[2067768379] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:675; }","duration":"113.966303ms","start":"2026-04-22T00:22:32.151748Z","end":"2026-04-22T00:22:32.265714Z","steps":["trace[2067768379] 'read index received' (duration: 113.267526ms)","trace[2067768379] 'applied index is now lower than readState.Index' (duration: 697.877µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:22:32.265949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.183489ms","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-04-22T00:22:32.26599Z","caller":"traceutil/trace.go:171","msg":"trace[458885127] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:649; }","duration":"114.348004ms","start":"2026-04-22T00:22:32.151632Z","end":"2026-04-22T00:22:32.26598Z","steps":["trace[458885127] 'agreement among raft nodes before linearized reading' (duration: 114.194611ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:32.266778Z","caller":"traceutil/trace.go:171","msg":"trace[1052943749] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"130.579692ms","start":"2026-04-22T00:22:32.136189Z","end":"2026-04-22T00:22:32.266769Z","steps":["trace[1052943749] 'process raft request' (duration: 129.063696ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:32.663323Z","caller":"traceutil/trace.go:171","msg":"trace[1555191278] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"316.605787ms","start":"2026-04-22T00:22:32.34665Z","end":"2026-04-22T00:22:32.663256Z","steps":["trace[1555191278] 'process raft request' (duration: 316.354712ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:32.663557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:32.346619Z","time spent":"316.839024ms","remote":"127.0.0.1:40310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T00:22:33.575241Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495539365181325,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T00:22:34.076176Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495539365181325,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T00:22:34.095947Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.03982817s","expected-duration":"1s"} {"level":"info","ts":"2026-04-22T00:22:34.096655Z","caller":"traceutil/trace.go:171","msg":"trace[362992173] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"1.040609708s","start":"2026-04-22T00:22:33.055962Z","end":"2026-04-22T00:22:34.096572Z","steps":["trace[362992173] 'process raft request' (duration: 1.040393792s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:34.097017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:33.055928Z","time spent":"1.040959086s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:22:34.157117Z","caller":"traceutil/trace.go:171","msg":"trace[46871282] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"929.961949ms","start":"2026-04-22T00:22:33.227119Z","end":"2026-04-22T00:22:34.157081Z","steps":["trace[46871282] 'process raft request' (duration: 918.142299ms)","trace[46871282] 'compare' (duration: 11.231346ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:22:34.157117Z","caller":"traceutil/trace.go:171","msg":"trace[1233448306] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:679; }","duration":"1.081893003s","start":"2026-04-22T00:22:33.075149Z","end":"2026-04-22T00:22:34.157042Z","steps":["trace[1233448306] 'read index received' (duration: 1.021255086s)","trace[1233448306] 'applied index is now lower than readState.Index' (duration: 60.636047ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:22:34.1573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.082136178s","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-04-22T00:22:34.157343Z","caller":"traceutil/trace.go:171","msg":"trace[718191460] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:653; }","duration":"1.082227091s","start":"2026-04-22T00:22:33.075105Z","end":"2026-04-22T00:22:34.157332Z","steps":["trace[718191460] 'agreement among raft nodes before linearized reading' (duration: 1.082035866s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:34.157365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:33.075079Z","time spent":"1.082280982s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-22T00:22:34.157355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:33.227078Z","time spent":"930.139153ms","remote":"127.0.0.1:40076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:22:34.157542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.632426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:22:34.157622Z","caller":"traceutil/trace.go:171","msg":"trace[377005629] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:653; }","duration":"532.795899ms","start":"2026-04-22T00:22:33.624798Z","end":"2026-04-22T00:22:34.157594Z","steps":["trace[377005629] 'agreement among raft nodes before linearized reading' (duration: 532.634326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:34.157665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:33.624777Z","time spent":"532.877792ms","remote":"127.0.0.1:40010","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-04-22T00:22:52.309426Z","caller":"traceutil/trace.go:171","msg":"trace[679011518] linearizableReadLoop","detail":"{readStateIndex:855; appliedIndex:854; }","duration":"133.291632ms","start":"2026-04-22T00:22:52.176104Z","end":"2026-04-22T00:22:52.309396Z","steps":["trace[679011518] 'read index received' (duration: 120.89482ms)","trace[679011518] 'applied index is now lower than readState.Index' (duration: 12.395672ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:22:52.309583Z","caller":"traceutil/trace.go:171","msg":"trace[1216032697] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"135.473441ms","start":"2026-04-22T00:22:52.174059Z","end":"2026-04-22T00:22:52.309532Z","steps":["trace[1216032697] 'process raft request' (duration: 123.006396ms)","trace[1216032697] 'compare' (duration: 12.176068ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:22:52.30967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.524838ms","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-04-22T00:22:52.309711Z","caller":"traceutil/trace.go:171","msg":"trace[305535611] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:822; }","duration":"133.62291ms","start":"2026-04-22T00:22:52.176078Z","end":"2026-04-22T00:22:52.309701Z","steps":["trace[305535611] 'agreement among raft nodes before linearized reading' (duration: 133.487477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:52.309932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.698321ms","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":"info","ts":"2026-04-22T00:22:52.309978Z","caller":"traceutil/trace.go:171","msg":"trace[33798759] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:822; }","duration":"133.798994ms","start":"2026-04-22T00:22:52.176165Z","end":"2026-04-22T00:22:52.309964Z","steps":["trace[33798759] 'agreement among raft nodes before linearized reading' (duration: 133.685711ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:52.310407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.620019ms","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-04-22T00:22:52.310443Z","caller":"traceutil/trace.go:171","msg":"trace[1353080962] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:822; }","duration":"133.672101ms","start":"2026-04-22T00:22:52.176763Z","end":"2026-04-22T00:22:52.310435Z","steps":["trace[1353080962] 'agreement among raft nodes before linearized reading' (duration: 133.61809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:53.141147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.456117ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T00:22:53.141598Z","caller":"traceutil/trace.go:171","msg":"trace[861299369] transaction","detail":"{read_only:false; response_revision:828; number_of_response:1; }","duration":"741.388439ms","start":"2026-04-22T00:22:52.400189Z","end":"2026-04-22T00:22:53.141578Z","steps":["trace[861299369] 'process raft request' (duration: 11.39459ms)","trace[861299369] 'compare' (duration: 729.331214ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:22:53.141713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:52.400161Z","time spent":"741.521292ms","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:22:53.141803Z","caller":"traceutil/trace.go:171","msg":"trace[1250312364] linearizableReadLoop","detail":"{readStateIndex:861; appliedIndex:860; }","duration":"647.147626ms","start":"2026-04-22T00:22:52.49462Z","end":"2026-04-22T00:22:53.141768Z","steps":["trace[1250312364] 'read index received' (duration: 56.731µs)","trace[1250312364] 'applied index is now lower than readState.Index' (duration: 647.086005ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:22:53.20685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.177161ms","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-04-22T00:22:53.206973Z","caller":"traceutil/trace.go:171","msg":"trace[1790579439] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:828; }","duration":"712.369526ms","start":"2026-04-22T00:22:52.494575Z","end":"2026-04-22T00:22:53.206945Z","steps":["trace[1790579439] 'agreement among raft nodes before linearized reading' (duration: 647.233088ms)","trace[1790579439] 'range keys from in-memory index tree' (duration: 64.262939ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:22:53.207021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:52.49455Z","time spent":"712.458238ms","remote":"127.0.0.1:45024","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-04-22T00:22:53.207774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.97834ms","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-04-22T00:22:53.207814Z","caller":"traceutil/trace.go:171","msg":"trace[491676421] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:829; }","duration":"713.064631ms","start":"2026-04-22T00:22:52.494741Z","end":"2026-04-22T00:22:53.207806Z","steps":["trace[491676421] 'agreement among raft nodes before linearized reading' (duration: 712.939398ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:53.207837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:52.494718Z","time spent":"713.112392ms","remote":"127.0.0.1:45024","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-04-22T00:22:53.208113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.280869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T00:22:53.208133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.390552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:22:53.20824Z","caller":"traceutil/trace.go:171","msg":"trace[1999486889] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:829; }","duration":"530.526765ms","start":"2026-04-22T00:22:52.677702Z","end":"2026-04-22T00:22:53.208229Z","steps":["trace[1999486889] 'agreement among raft nodes before linearized reading' (duration: 530.377592ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:53.208232Z","caller":"traceutil/trace.go:171","msg":"trace[2095273402] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:829; }","duration":"530.444392ms","start":"2026-04-22T00:22:52.67776Z","end":"2026-04-22T00:22:53.208204Z","steps":["trace[2095273402] 'agreement among raft nodes before linearized reading' (duration: 530.205297ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:53.208269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:52.677679Z","time spent":"530.581115ms","remote":"127.0.0.1:45050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 "} {"level":"warn","ts":"2026-04-22T00:22:53.208451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.028156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:22:53.20852Z","caller":"traceutil/trace.go:171","msg":"trace[803471987] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:829; }","duration":"501.178629ms","start":"2026-04-22T00:22:52.707322Z","end":"2026-04-22T00:22:53.2085Z","steps":["trace[803471987] 'agreement among raft nodes before linearized reading' (duration: 501.005426ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:53.208528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.27725ms","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":"warn","ts":"2026-04-22T00:22:53.208557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:52.707314Z","time spent":"501.232ms","remote":"127.0.0.1:45072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-22T00:22:53.208566Z","caller":"traceutil/trace.go:171","msg":"trace[438467356] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:829; }","duration":"695.360191ms","start":"2026-04-22T00:22:52.51319Z","end":"2026-04-22T00:22:53.20855Z","steps":["trace[438467356] 'agreement among raft nodes before linearized reading' (duration: 695.31142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:53.208572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.369391ms","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-04-22T00:22:53.208585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.450784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:22:53.208599Z","caller":"traceutil/trace.go:171","msg":"trace[386255690] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:829; }","duration":"695.400752ms","start":"2026-04-22T00:22:52.513191Z","end":"2026-04-22T00:22:53.208592Z","steps":["trace[386255690] 'agreement among raft nodes before linearized reading' (duration: 695.330881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:53.208602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:52.513152Z","time spent":"695.439493ms","remote":"127.0.0.1:45030","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-04-22T00:22:53.208381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.338965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:22:53.208617Z","caller":"traceutil/trace.go:171","msg":"trace[2019555651] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:829; }","duration":"500.503164ms","start":"2026-04-22T00:22:52.708104Z","end":"2026-04-22T00:22:53.208607Z","steps":["trace[2019555651] 'agreement among raft nodes before linearized reading' (duration: 500.446343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:53.208647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:52.513097Z","time spent":"695.520476ms","remote":"127.0.0.1:45030","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-04-22T00:22:53.208656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:52.708095Z","time spent":"500.552625ms","remote":"127.0.0.1:45072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 "} {"level":"info","ts":"2026-04-22T00:22:53.208656Z","caller":"traceutil/trace.go:171","msg":"trace[1161187753] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:829; }","duration":"517.625191ms","start":"2026-04-22T00:22:52.691013Z","end":"2026-04-22T00:22:53.208638Z","steps":["trace[1161187753] 'agreement among raft nodes before linearized reading' (duration: 517.298973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:53.20844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.043236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:22:53.208708Z","caller":"traceutil/trace.go:171","msg":"trace[1595938686] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:829; }","duration":"501.422234ms","start":"2026-04-22T00:22:52.707276Z","end":"2026-04-22T00:22:53.208699Z","steps":["trace[1595938686] 'agreement among raft nodes before linearized reading' (duration: 501.053757ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:53.20871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:52.691006Z","time spent":"517.684672ms","remote":"127.0.0.1:45066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 "} {"level":"warn","ts":"2026-04-22T00:22:53.208732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.471968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T00:22:53.208738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:52.707247Z","time spent":"501.479346ms","remote":"127.0.0.1:45072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-22T00:22:53.208762Z","caller":"traceutil/trace.go:171","msg":"trace[1758008033] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:829; }","duration":"547.534809ms","start":"2026-04-22T00:22:52.66122Z","end":"2026-04-22T00:22:53.208754Z","steps":["trace[1758008033] 'agreement among raft nodes before linearized reading' (duration: 547.486628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:53.208789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:52.661196Z","time spent":"547.58525ms","remote":"127.0.0.1:45044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-22T00:22:53.208791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.162683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T00:22:53.208856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.038816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T00:22:53.208859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.643837ms","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-04-22T00:22:53.208883Z","caller":"traceutil/trace.go:171","msg":"trace[929414486] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:829; }","duration":"531.084137ms","start":"2026-04-22T00:22:52.67779Z","end":"2026-04-22T00:22:53.208874Z","steps":["trace[929414486] 'agreement among raft nodes before linearized reading' (duration: 531.019646ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:53.208893Z","caller":"traceutil/trace.go:171","msg":"trace[1773810022] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:829; }","duration":"695.75851ms","start":"2026-04-22T00:22:52.513126Z","end":"2026-04-22T00:22:53.208884Z","steps":["trace[1773810022] 'agreement among raft nodes before linearized reading' (duration: 695.671378ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:53.208909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:52.677776Z","time spent":"531.125617ms","remote":"127.0.0.1:45050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"info","ts":"2026-04-22T00:22:53.208899Z","caller":"traceutil/trace.go:171","msg":"trace[52522503] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:829; }","duration":"518.298726ms","start":"2026-04-22T00:22:52.690568Z","end":"2026-04-22T00:22:53.208867Z","steps":["trace[52522503] 'agreement among raft nodes before linearized reading' (duration: 518.187173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:53.208944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:52.513098Z","time spent":"695.815502ms","remote":"127.0.0.1:45030","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-04-22T00:22:53.208973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:52.690545Z","time spent":"518.410578ms","remote":"127.0.0.1:45066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-04-22T00:22:53.209026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.380589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:22:53.209048Z","caller":"traceutil/trace.go:171","msg":"trace[524653911] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:829; }","duration":"548.442629ms","start":"2026-04-22T00:22:52.660599Z","end":"2026-04-22T00:22:53.209042Z","steps":["trace[524653911] 'agreement among raft nodes before linearized reading' (duration: 548.410778ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:53.208995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.278885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T00:22:53.209068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:52.660576Z","time spent":"548.486101ms","remote":"127.0.0.1:45044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"info","ts":"2026-04-22T00:22:53.209082Z","caller":"traceutil/trace.go:171","msg":"trace[943323973] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:829; }","duration":"548.387509ms","start":"2026-04-22T00:22:52.660679Z","end":"2026-04-22T00:22:53.209067Z","steps":["trace[943323973] 'agreement among raft nodes before linearized reading' (duration: 548.292176ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:53.209109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:52.660655Z","time spent":"548.44524ms","remote":"127.0.0.1:45044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-22T00:22:53.209163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.950467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:22:53.20918Z","caller":"traceutil/trace.go:171","msg":"trace[229885313] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:829; }","duration":"582.009318ms","start":"2026-04-22T00:22:52.627166Z","end":"2026-04-22T00:22:53.209175Z","steps":["trace[229885313] 'agreement among raft nodes before linearized reading' (duration: 581.979967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:53.209197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:52.627143Z","time spent":"582.050259ms","remote":"127.0.0.1:40010","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-04-22T00:22:53.208682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.00383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:22:53.209295Z","caller":"traceutil/trace.go:171","msg":"trace[445811060] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:829; }","duration":"518.710835ms","start":"2026-04-22T00:22:52.690576Z","end":"2026-04-22T00:22:53.209287Z","steps":["trace[445811060] 'agreement among raft nodes before linearized reading' (duration: 517.952549ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:53.209316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:52.690558Z","time spent":"518.749926ms","remote":"127.0.0.1:45066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 "} {"level":"warn","ts":"2026-04-22T00:22:53.20947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:52.677755Z","time spent":"531.692351ms","remote":"127.0.0.1:45050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 "} {"level":"warn","ts":"2026-04-22T00:22:58.40728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.935395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050268"} {"level":"info","ts":"2026-04-22T00:22:58.407386Z","caller":"traceutil/trace.go:171","msg":"trace[1563348614] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:879; }","duration":"245.099459ms","start":"2026-04-22T00:22:58.162262Z","end":"2026-04-22T00:22:58.407361Z","steps":["trace[1563348614] 'range keys from in-memory index tree' (duration: 243.456423ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:58.660473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.10582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T00:22:58.660582Z","caller":"traceutil/trace.go:171","msg":"trace[2116020022] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:882; }","duration":"103.287064ms","start":"2026-04-22T00:22:58.557269Z","end":"2026-04-22T00:22:58.660556Z","steps":["trace[2116020022] 'count revisions from in-memory index tree' (duration: 102.931086ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:23:09.404025Z","caller":"traceutil/trace.go:171","msg":"trace[1015379290] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"235.357524ms","start":"2026-04-22T00:23:09.168638Z","end":"2026-04-22T00:23:09.403996Z","steps":["trace[1015379290] 'process raft request' (duration: 235.178071ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:23:09.407835Z","caller":"traceutil/trace.go:171","msg":"trace[75993440] linearizableReadLoop","detail":"{readStateIndex:1037; appliedIndex:1035; }","duration":"170.634298ms","start":"2026-04-22T00:23:09.237171Z","end":"2026-04-22T00:23:09.407806Z","steps":["trace[75993440] 'read index received' (duration: 166.679115ms)","trace[75993440] 'applied index is now lower than readState.Index' (duration: 3.953863ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:23:09.407921Z","caller":"traceutil/trace.go:171","msg":"trace[1404693282] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"202.962401ms","start":"2026-04-22T00:23:09.204937Z","end":"2026-04-22T00:23:09.407899Z","steps":["trace[1404693282] 'process raft request' (duration: 202.697944ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:23:09.408149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.940744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-22T00:23:09.408192Z","caller":"traceutil/trace.go:171","msg":"trace[1568116705] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1000; }","duration":"171.071047ms","start":"2026-04-22T00:23:09.237112Z","end":"2026-04-22T00:23:09.408183Z","steps":["trace[1568116705] 'agreement among raft nodes before linearized reading' (duration: 170.856833ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:23:49.031684Z","caller":"traceutil/trace.go:171","msg":"trace[1015156405] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"157.791326ms","start":"2026-04-22T00:23:48.873861Z","end":"2026-04-22T00:23:49.031653Z","steps":["trace[1015156405] 'process raft request' (duration: 157.612663ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:23:49.072806Z","caller":"traceutil/trace.go:171","msg":"trace[397792382] transaction","detail":"{read_only:false; response_revision:1143; number_of_response:1; }","duration":"196.734904ms","start":"2026-04-22T00:23:48.876043Z","end":"2026-04-22T00:23:49.072777Z","steps":["trace[397792382] 'process raft request' (duration: 196.57695ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:23:49.914841Z","caller":"traceutil/trace.go:171","msg":"trace[3340978] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"123.622263ms","start":"2026-04-22T00:23:49.791188Z","end":"2026-04-22T00:23:49.91481Z","steps":["trace[3340978] 'process raft request' (duration: 123.43162ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:23:51.242834Z","caller":"traceutil/trace.go:171","msg":"trace[1572668240] linearizableReadLoop","detail":"{readStateIndex:1194; appliedIndex:1193; }","duration":"164.446587ms","start":"2026-04-22T00:23:51.078361Z","end":"2026-04-22T00:23:51.242808Z","steps":["trace[1572668240] 'read index received' (duration: 164.176852ms)","trace[1572668240] 'applied index is now lower than readState.Index' (duration: 268.785µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:23:51.242947Z","caller":"traceutil/trace.go:171","msg":"trace[350589778] transaction","detail":"{read_only:false; response_revision:1148; number_of_response:1; }","duration":"200.771072ms","start":"2026-04-22T00:23:51.042132Z","end":"2026-04-22T00:23:51.242903Z","steps":["trace[350589778] 'process raft request' (duration: 200.517888ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:23:51.243099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.711152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-22T00:23:51.243182Z","caller":"traceutil/trace.go:171","msg":"trace[692781770] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1148; }","duration":"164.816914ms","start":"2026-04-22T00:23:51.078307Z","end":"2026-04-22T00:23:51.243124Z","steps":["trace[692781770] 'agreement among raft nodes before linearized reading' (duration: 164.65368ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:24:31.624298Z","caller":"traceutil/trace.go:171","msg":"trace[1249405397] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"168.530964ms","start":"2026-04-22T00:24:31.455722Z","end":"2026-04-22T00:24:31.624253Z","steps":["trace[1249405397] 'process raft request' (duration: 168.228788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:24:40.596559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.547188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5548"} {"level":"info","ts":"2026-04-22T00:24:40.596652Z","caller":"traceutil/trace.go:171","msg":"trace[1223186108] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1311; }","duration":"133.71225ms","start":"2026-04-22T00:24:40.46292Z","end":"2026-04-22T00:24:40.596632Z","steps":["trace[1223186108] 'range keys from in-memory index tree' (duration: 133.319433ms)"],"step_count":1}