{"level":"warn","ts":"2026-04-23T07:40:25.864535Z","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-23T07:40:25.864636Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.12:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.12:2380","--initial-cluster=instance=https://199.19.213.12:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.12:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.12: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-23T07:40:25.864721Z","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-23T07:40:25.864735Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.12:2380"]} {"level":"info","ts":"2026-04-23T07:40:25.864755Z","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-23T07:40:25.865408Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.12:2379"]} {"level":"info","ts":"2026-04-23T07:40:25.865489Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.12:2380"],"listen-peer-urls":["https://199.19.213.12:2380"],"advertise-client-urls":["https://199.19.213.12:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.12:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.12: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-23T07:40:25.869546Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.793048ms"} {"level":"info","ts":"2026-04-23T07:40:25.879178Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"790561176553eafe","cluster-id":"e32c72c573d8545f"} {"level":"info","ts":"2026-04-23T07:40:25.879292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe switched to configuration voters=()"} {"level":"info","ts":"2026-04-23T07:40:25.879324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became follower at term 0"} {"level":"info","ts":"2026-04-23T07:40:25.879337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 790561176553eafe [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-23T07:40:25.879351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became follower at term 1"} {"level":"info","ts":"2026-04-23T07:40:25.879393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe switched to configuration voters=(8720483006584974078)"} {"level":"warn","ts":"2026-04-23T07:40:25.88776Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-23T07:40:25.889049Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-23T07:40:25.892115Z","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-23T07:40:25.895563Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"790561176553eafe","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-23T07:40:25.895947Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"790561176553eafe","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-23T07:40:25.896019Z","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-23T07:40:25.896124Z","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-23T07:40:25.896146Z","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-23T07:40:25.898131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe switched to configuration voters=(8720483006584974078)"} {"level":"info","ts":"2026-04-23T07:40:25.898381Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e32c72c573d8545f","local-member-id":"790561176553eafe","added-peer-id":"790561176553eafe","added-peer-peer-urls":["https://199.19.213.12:2380"]} {"level":"info","ts":"2026-04-23T07:40:25.904124Z","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-23T07:40:25.904458Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"790561176553eafe","initial-advertise-peer-urls":["https://199.19.213.12:2380"],"listen-peer-urls":["https://199.19.213.12:2380"],"advertise-client-urls":["https://199.19.213.12:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.12:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-23T07:40:25.904464Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.12:2380"} {"level":"info","ts":"2026-04-23T07:40:25.904514Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.12:2380"} {"level":"info","ts":"2026-04-23T07:40:25.904511Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-23T07:40:26.779727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe is starting a new election at term 1"} {"level":"info","ts":"2026-04-23T07:40:26.779846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became pre-candidate at term 1"} {"level":"info","ts":"2026-04-23T07:40:26.779889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe received MsgPreVoteResp from 790561176553eafe at term 1"} {"level":"info","ts":"2026-04-23T07:40:26.779914Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became candidate at term 2"} {"level":"info","ts":"2026-04-23T07:40:26.779927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe received MsgVoteResp from 790561176553eafe at term 2"} {"level":"info","ts":"2026-04-23T07:40:26.779946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became leader at term 2"} {"level":"info","ts":"2026-04-23T07:40:26.779968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 790561176553eafe elected leader 790561176553eafe at term 2"} {"level":"info","ts":"2026-04-23T07:40:26.780924Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"790561176553eafe","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.12:2379]}","request-path":"/0/members/790561176553eafe/attributes","cluster-id":"e32c72c573d8545f","publish-timeout":"7s"} {"level":"info","ts":"2026-04-23T07:40:26.781151Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T07:40:26.78153Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T07:40:26.781801Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T07:40:26.782395Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-23T07:40:26.782425Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-23T07:40:26.785057Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.12:2379"} {"level":"info","ts":"2026-04-23T07:40:26.78551Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-23T07:40:26.789409Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e32c72c573d8545f","local-member-id":"790561176553eafe","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T07:40:26.789683Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T07:40:26.789748Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T07:40:28.751095Z","caller":"traceutil/trace.go:171","msg":"trace[348300918] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"407.117942ms","start":"2026-04-23T07:40:28.343856Z","end":"2026-04-23T07:40:28.750974Z","steps":["trace[348300918] 'process raft request' (duration: 368.308141ms)","trace[348300918] 'compare' (duration: 38.555133ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:40:28.751878Z","caller":"traceutil/trace.go:171","msg":"trace[122226122] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"407.836274ms","start":"2026-04-23T07:40:28.34401Z","end":"2026-04-23T07:40:28.751846Z","steps":["trace[122226122] 'process raft request' (duration: 407.541024ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:28.751913Z","caller":"traceutil/trace.go:171","msg":"trace[1563563159] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"407.817282ms","start":"2026-04-23T07:40:28.344042Z","end":"2026-04-23T07:40:28.751859Z","steps":["trace[1563563159] 'process raft request' (duration: 407.627076ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:28.751972Z","caller":"traceutil/trace.go:171","msg":"trace[1492980165] linearizableReadLoop","detail":"{readStateIndex:42; appliedIndex:33; }","duration":"353.084182ms","start":"2026-04-23T07:40:28.398845Z","end":"2026-04-23T07:40:28.751929Z","steps":["trace[1492980165] 'read index received' (duration: 313.23874ms)","trace[1492980165] 'applied index is now lower than readState.Index' (duration: 39.844622ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:40:28.752145Z","caller":"traceutil/trace.go:171","msg":"trace[839871106] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"407.801852ms","start":"2026-04-23T07:40:28.344334Z","end":"2026-04-23T07:40:28.752136Z","steps":["trace[839871106] 'process raft request' (duration: 407.401019ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:28.752281Z","caller":"traceutil/trace.go:171","msg":"trace[1921205224] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"408.34338ms","start":"2026-04-23T07:40:28.34392Z","end":"2026-04-23T07:40:28.752264Z","steps":["trace[1921205224] 'process raft request' (duration: 407.443222ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:28.752408Z","caller":"traceutil/trace.go:171","msg":"trace[1051807713] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"407.991728ms","start":"2026-04-23T07:40:28.344402Z","end":"2026-04-23T07:40:28.752394Z","steps":["trace[1051807713] 'process raft request' (duration: 407.43402ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:28.752488Z","caller":"traceutil/trace.go:171","msg":"trace[452579774] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"408.104451ms","start":"2026-04-23T07:40:28.344374Z","end":"2026-04-23T07:40:28.752478Z","steps":["trace[452579774] 'process raft request' (duration: 407.398419ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:28.752524Z","caller":"traceutil/trace.go:171","msg":"trace[582896876] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"408.08398ms","start":"2026-04-23T07:40:28.344425Z","end":"2026-04-23T07:40:28.752509Z","steps":["trace[582896876] 'process raft request' (duration: 407.451751ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:28.752645Z","caller":"traceutil/trace.go:171","msg":"trace[982558571] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"408.167853ms","start":"2026-04-23T07:40:28.344466Z","end":"2026-04-23T07:40:28.752634Z","steps":["trace[982558571] 'process raft request' (duration: 407.42765ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:40:28.75273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.875127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-23T07:40:28.752771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.855105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-23T07:40:28.752804Z","caller":"traceutil/trace.go:171","msg":"trace[213549750] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:38; }","duration":"354.007461ms","start":"2026-04-23T07:40:28.398786Z","end":"2026-04-23T07:40:28.752794Z","steps":["trace[213549750] 'agreement among raft nodes before linearized reading' (duration: 353.844326ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:28.752837Z","caller":"traceutil/trace.go:171","msg":"trace[904615836] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:38; }","duration":"290.970448ms","start":"2026-04-23T07:40:28.461849Z","end":"2026-04-23T07:40:28.752819Z","steps":["trace[904615836] 'agreement among raft nodes before linearized reading' (duration: 290.785682ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:40:28.752868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:40:28.398765Z","time spent":"354.061692ms","remote":"127.0.0.1:47484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-04-23T07:40:28.753841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:40:28.343841Z","time spent":"407.400901ms","remote":"127.0.0.1:47900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T07:40:28.753933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:40:28.343998Z","time spent":"407.941738ms","remote":"127.0.0.1:47470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3004,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T07:40:28.754059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:40:28.344032Z","time spent":"408.001278ms","remote":"127.0.0.1:47900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":926,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T07:40:28.754146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:40:28.344312Z","time spent":"407.905395ms","remote":"127.0.0.1:47900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T07:40:28.754229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:40:28.343906Z","time spent":"408.417553ms","remote":"127.0.0.1:47484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":350,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T07:40:28.754347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:40:28.344388Z","time spent":"408.06005ms","remote":"127.0.0.1:47900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T07:40:28.75445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:40:28.344361Z","time spent":"408.153542ms","remote":"127.0.0.1:47614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T07:40:28.754595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:40:28.344373Z","time spent":"408.204464ms","remote":"127.0.0.1:47900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":983,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T07:40:28.754742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:40:28.344404Z","time spent":"408.274697ms","remote":"127.0.0.1:47804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":711,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T07:40:29.781676Z","caller":"traceutil/trace.go:171","msg":"trace[1803587434] transaction","detail":"{read_only:false; response_revision:171; number_of_response:1; }","duration":"126.459372ms","start":"2026-04-23T07:40:29.655187Z","end":"2026-04-23T07:40:29.781646Z","steps":["trace[1803587434] 'process raft request' (duration: 81.3018ms)","trace[1803587434] 'compare' (duration: 45.020988ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T07:40:30.575948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.65357ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-23T07:40:30.576361Z","caller":"traceutil/trace.go:171","msg":"trace[1550912498] transaction","detail":"{read_only:false; response_revision:229; number_of_response:1; }","duration":"214.168113ms","start":"2026-04-23T07:40:30.36216Z","end":"2026-04-23T07:40:30.576328Z","steps":["trace[1550912498] 'compare' (duration: 208.454064ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:30.576493Z","caller":"traceutil/trace.go:171","msg":"trace[1425758266] transaction","detail":"{read_only:false; response_revision:230; number_of_response:1; }","duration":"213.40292ms","start":"2026-04-23T07:40:30.363059Z","end":"2026-04-23T07:40:30.576462Z","steps":["trace[1425758266] 'process raft request' (duration: 213.222884ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:30.576814Z","caller":"traceutil/trace.go:171","msg":"trace[1807024161] transaction","detail":"{read_only:false; response_revision:231; number_of_response:1; }","duration":"211.995216ms","start":"2026-04-23T07:40:30.364801Z","end":"2026-04-23T07:40:30.576796Z","steps":["trace[1807024161] 'process raft request' (duration: 211.598693ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:31.187031Z","caller":"traceutil/trace.go:171","msg":"trace[269415830] transaction","detail":"{read_only:false; response_revision:239; number_of_response:1; }","duration":"199.363585ms","start":"2026-04-23T07:40:30.987641Z","end":"2026-04-23T07:40:31.187004Z","steps":["trace[269415830] 'process raft request' (duration: 199.258502ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:31.1872Z","caller":"traceutil/trace.go:171","msg":"trace[1263257517] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"243.832159ms","start":"2026-04-23T07:40:30.943316Z","end":"2026-04-23T07:40:31.187149Z","steps":["trace[1263257517] 'process raft request' (duration: 180.358765ms)","trace[1263257517] 'compare' (duration: 63.056401ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:40:31.939143Z","caller":"traceutil/trace.go:171","msg":"trace[587806930] linearizableReadLoop","detail":"{readStateIndex:265; appliedIndex:264; }","duration":"111.880354ms","start":"2026-04-23T07:40:31.827233Z","end":"2026-04-23T07:40:31.939113Z","steps":["trace[587806930] 'read index received' (duration: 80.916016ms)","trace[587806930] 'applied index is now lower than readState.Index' (duration: 30.962458ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:40:31.939204Z","caller":"traceutil/trace.go:171","msg":"trace[1794314240] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"157.522324ms","start":"2026-04-23T07:40:31.781638Z","end":"2026-04-23T07:40:31.939161Z","steps":["trace[1794314240] 'process raft request' (duration: 126.578927ms)","trace[1794314240] 'compare' (duration: 30.764772ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T07:40:31.93943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.177213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-23T07:40:31.939511Z","caller":"traceutil/trace.go:171","msg":"trace[51142625] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:259; }","duration":"112.312168ms","start":"2026-04-23T07:40:31.827177Z","end":"2026-04-23T07:40:31.93949Z","steps":["trace[51142625] 'agreement among raft nodes before linearized reading' (duration: 112.06522ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:32.133912Z","caller":"traceutil/trace.go:171","msg":"trace[316425839] linearizableReadLoop","detail":"{readStateIndex:268; appliedIndex:267; }","duration":"156.83371ms","start":"2026-04-23T07:40:31.977054Z","end":"2026-04-23T07:40:32.133887Z","steps":["trace[316425839] 'read index received' (duration: 83.459569ms)","trace[316425839] 'applied index is now lower than readState.Index' (duration: 73.37317ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:40:32.133979Z","caller":"traceutil/trace.go:171","msg":"trace[1837385614] transaction","detail":"{read_only:false; response_revision:262; number_of_response:1; }","duration":"169.661274ms","start":"2026-04-23T07:40:31.964273Z","end":"2026-04-23T07:40:32.133934Z","steps":["trace[1837385614] 'process raft request' (duration: 96.247742ms)","trace[1837385614] 'compare' (duration: 73.230826ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T07:40:32.134071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.998304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-23T07:40:32.134121Z","caller":"traceutil/trace.go:171","msg":"trace[2004529587] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:262; }","duration":"157.079797ms","start":"2026-04-23T07:40:31.97702Z","end":"2026-04-23T07:40:32.1341Z","steps":["trace[2004529587] 'agreement among raft nodes before linearized reading' (duration: 156.967514ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:40:32.49246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.433901ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-23T07:40:32.492859Z","caller":"traceutil/trace.go:171","msg":"trace[1651004587] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"273.551132ms","start":"2026-04-23T07:40:32.219275Z","end":"2026-04-23T07:40:32.492827Z","steps":["trace[1651004587] 'process raft request' (duration: 22.680657ms)","trace[1651004587] 'compare' (duration: 249.76016ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:40:32.493109Z","caller":"traceutil/trace.go:171","msg":"trace[1212413935] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"233.732584ms","start":"2026-04-23T07:40:32.25936Z","end":"2026-04-23T07:40:32.493093Z","steps":["trace[1212413935] 'process raft request' (duration: 233.464905ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:32.493241Z","caller":"traceutil/trace.go:171","msg":"trace[1680464415] linearizableReadLoop","detail":"{readStateIndex:272; appliedIndex:270; }","duration":"248.322075ms","start":"2026-04-23T07:40:32.244864Z","end":"2026-04-23T07:40:32.493187Z","steps":["trace[1680464415] 'read index received' (duration: 228.234809ms)","trace[1680464415] 'applied index is now lower than readState.Index' (duration: 20.083876ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:40:32.493075Z","caller":"traceutil/trace.go:171","msg":"trace[1689641855] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"271.033254ms","start":"2026-04-23T07:40:32.221986Z","end":"2026-04-23T07:40:32.493019Z","steps":["trace[1689641855] 'process raft request' (duration: 270.790475ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:40:32.493448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.563963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:40:32.493493Z","caller":"traceutil/trace.go:171","msg":"trace[1543823970] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:267; }","duration":"248.669596ms","start":"2026-04-23T07:40:32.244812Z","end":"2026-04-23T07:40:32.493482Z","steps":["trace[1543823970] 'agreement among raft nodes before linearized reading' (duration: 248.514381ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:36.586755Z","caller":"traceutil/trace.go:171","msg":"trace[1353581626] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"119.209472ms","start":"2026-04-23T07:40:36.467508Z","end":"2026-04-23T07:40:36.586718Z","steps":["trace[1353581626] 'process raft request' (duration: 63.996556ms)","trace[1353581626] 'compare' (duration: 55.01614ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:40:36.587334Z","caller":"traceutil/trace.go:171","msg":"trace[1879802164] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"117.101825ms","start":"2026-04-23T07:40:36.470218Z","end":"2026-04-23T07:40:36.58732Z","steps":["trace[1879802164] 'process raft request' (duration: 116.694722ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:36.587393Z","caller":"traceutil/trace.go:171","msg":"trace[822550804] linearizableReadLoop","detail":"{readStateIndex:371; appliedIndex:366; }","duration":"110.801683ms","start":"2026-04-23T07:40:36.476553Z","end":"2026-04-23T07:40:36.587354Z","steps":["trace[822550804] 'read index received' (duration: 54.971067ms)","trace[822550804] 'applied index is now lower than readState.Index' (duration: 55.828996ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:40:36.587628Z","caller":"traceutil/trace.go:171","msg":"trace[2038170494] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"116.94139ms","start":"2026-04-23T07:40:36.470663Z","end":"2026-04-23T07:40:36.587604Z","steps":["trace[2038170494] 'process raft request' (duration: 116.526637ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:36.58789Z","caller":"traceutil/trace.go:171","msg":"trace[447815834] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"116.917668ms","start":"2026-04-23T07:40:36.470955Z","end":"2026-04-23T07:40:36.587873Z","steps":["trace[447815834] 'process raft request' (duration: 116.278577ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:40:36.588156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.582308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-04-23T07:40:36.588234Z","caller":"traceutil/trace.go:171","msg":"trace[2136622145] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:359; }","duration":"111.693771ms","start":"2026-04-23T07:40:36.476524Z","end":"2026-04-23T07:40:36.588218Z","steps":["trace[2136622145] 'agreement among raft nodes before linearized reading' (duration: 111.533426ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:36.588397Z","caller":"traceutil/trace.go:171","msg":"trace[1523237589] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"116.633459ms","start":"2026-04-23T07:40:36.471742Z","end":"2026-04-23T07:40:36.588376Z","steps":["trace[1523237589] 'process raft request' (duration: 115.555995ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:36.784884Z","caller":"traceutil/trace.go:171","msg":"trace[567399644] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"103.957387ms","start":"2026-04-23T07:40:36.680897Z","end":"2026-04-23T07:40:36.784854Z","steps":["trace[567399644] 'process raft request' (duration: 16.301379ms)","trace[567399644] 'compare' (duration: 87.526194ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:40:36.786818Z","caller":"traceutil/trace.go:171","msg":"trace[306247803] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"101.763037ms","start":"2026-04-23T07:40:36.685039Z","end":"2026-04-23T07:40:36.786802Z","steps":["trace[306247803] 'process raft request' (duration: 101.674944ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:36.786827Z","caller":"traceutil/trace.go:171","msg":"trace[477958775] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"101.797057ms","start":"2026-04-23T07:40:36.684992Z","end":"2026-04-23T07:40:36.786789Z","steps":["trace[477958775] 'process raft request' (duration: 101.638282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:40:36.786921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.53548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3706"} {"level":"info","ts":"2026-04-23T07:40:36.786992Z","caller":"traceutil/trace.go:171","msg":"trace[16728318] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:370; }","duration":"101.641753ms","start":"2026-04-23T07:40:36.685338Z","end":"2026-04-23T07:40:36.78698Z","steps":["trace[16728318] 'agreement among raft nodes before linearized reading' (duration: 101.509079ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:36.786812Z","caller":"traceutil/trace.go:171","msg":"trace[1999799889] linearizableReadLoop","detail":"{readStateIndex:381; appliedIndex:378; }","duration":"101.427516ms","start":"2026-04-23T07:40:36.685365Z","end":"2026-04-23T07:40:36.786793Z","steps":["trace[1999799889] 'read index received' (duration: 11.821846ms)","trace[1999799889] 'applied index is now lower than readState.Index' (duration: 89.60465ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:40:38.844619Z","caller":"traceutil/trace.go:171","msg":"trace[1609697367] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"178.345527ms","start":"2026-04-23T07:40:38.666242Z","end":"2026-04-23T07:40:38.844588Z","steps":["trace[1609697367] 'process raft request' (duration: 178.10907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:40:39.833734Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16933145068069558881,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T07:40:40.263768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.002585462s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T07:40:40.263889Z","caller":"traceutil/trace.go:171","msg":"trace[924999643] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"1.414624302s","start":"2026-04-23T07:40:38.849245Z","end":"2026-04-23T07:40:40.263869Z","steps":["trace[924999643] 'process raft request' (duration: 411.634097ms)","trace[924999643] 'compare' (duration: 1.002446818s)"],"step_count":2} {"level":"warn","ts":"2026-04-23T07:40:40.264085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:40:38.849223Z","time spent":"1.414755768s","remote":"127.0.0.1:47614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T07:40:40.334467Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16933145068069558881,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T07:40:40.767412Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.506505213s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-23T07:40:40.892885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.995566ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T07:40:40.893169Z","caller":"traceutil/trace.go:171","msg":"trace[1345592381] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"2.043703073s","start":"2026-04-23T07:40:38.849434Z","end":"2026-04-23T07:40:40.893137Z","steps":["trace[1345592381] 'process raft request' (duration: 1.918300474s)","trace[1345592381] 'compare' (duration: 124.826281ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T07:40:40.89333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:40:38.84942Z","time spent":"2.043844687s","remote":"127.0.0.1:47614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T07:40:40.89373Z","caller":"traceutil/trace.go:171","msg":"trace[492313257] linearizableReadLoop","detail":"{readStateIndex:401; appliedIndex:399; }","duration":"1.56076768s","start":"2026-04-23T07:40:39.332952Z","end":"2026-04-23T07:40:40.89372Z","steps":["trace[492313257] 'read index received' (duration: 1.43471324s)","trace[492313257] 'applied index is now lower than readState.Index' (duration: 126.05293ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T07:40:40.893995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.560997828s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4322"} {"level":"info","ts":"2026-04-23T07:40:40.894085Z","caller":"traceutil/trace.go:171","msg":"trace[120685565] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:389; }","duration":"1.561161132s","start":"2026-04-23T07:40:39.332899Z","end":"2026-04-23T07:40:40.89406Z","steps":["trace[120685565] 'agreement among raft nodes before linearized reading' (duration: 1.560982287s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:40:40.894134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:40:39.332884Z","time spent":"1.561239735s","remote":"127.0.0.1:47534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4345,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-04-23T07:40:40.894194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.263809268s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-23T07:40:40.894249Z","caller":"traceutil/trace.go:171","msg":"trace[2128571983] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:389; }","duration":"1.263910182s","start":"2026-04-23T07:40:39.630329Z","end":"2026-04-23T07:40:40.894239Z","steps":["trace[2128571983] 'agreement among raft nodes before linearized reading' (duration: 1.263799319s)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:40.894168Z","caller":"traceutil/trace.go:171","msg":"trace[728031460] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"1.895336462s","start":"2026-04-23T07:40:38.99876Z","end":"2026-04-23T07:40:40.894096Z","steps":["trace[728031460] 'process raft request' (duration: 1.894889807s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:40:40.894515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:40:38.998733Z","time spent":"1.895597951s","remote":"127.0.0.1:47614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T07:40:40.894278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:40:39.630306Z","time spent":"1.263965613s","remote":"127.0.0.1:47614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-23T07:40:49.186603Z","caller":"traceutil/trace.go:171","msg":"trace[2044456416] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"152.61502ms","start":"2026-04-23T07:40:49.033955Z","end":"2026-04-23T07:40:49.18657Z","steps":["trace[2044456416] 'process raft request' (duration: 84.610143ms)","trace[2044456416] 'compare' (duration: 67.683446ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:40:49.198139Z","caller":"traceutil/trace.go:171","msg":"trace[2104871741] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"163.952107ms","start":"2026-04-23T07:40:49.034155Z","end":"2026-04-23T07:40:49.198107Z","steps":["trace[2104871741] 'process raft request' (duration: 163.828793ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:51.4159Z","caller":"traceutil/trace.go:171","msg":"trace[945453890] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"247.267554ms","start":"2026-04-23T07:40:51.168593Z","end":"2026-04-23T07:40:51.415861Z","steps":["trace[945453890] 'process raft request' (duration: 149.326244ms)","trace[945453890] 'compare' (duration: 97.399332ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:40:51.433124Z","caller":"traceutil/trace.go:171","msg":"trace[34100660] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"251.344866ms","start":"2026-04-23T07:40:51.181756Z","end":"2026-04-23T07:40:51.433101Z","steps":["trace[34100660] 'process raft request' (duration: 251.16491ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:51.435015Z","caller":"traceutil/trace.go:171","msg":"trace[1711573357] linearizableReadLoop","detail":"{readStateIndex:466; appliedIndex:464; }","duration":"245.077362ms","start":"2026-04-23T07:40:51.189915Z","end":"2026-04-23T07:40:51.434992Z","steps":["trace[1711573357] 'read index received' (duration: 128.24712ms)","trace[1711573357] 'applied index is now lower than readState.Index' (duration: 116.828742ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T07:40:51.435218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.27963ms","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-23T07:40:51.435288Z","caller":"traceutil/trace.go:171","msg":"trace[1742419426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:449; }","duration":"245.367892ms","start":"2026-04-23T07:40:51.189883Z","end":"2026-04-23T07:40:51.43525Z","steps":["trace[1742419426] 'agreement among raft nodes before linearized reading' (duration: 245.240048ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:51.435321Z","caller":"traceutil/trace.go:171","msg":"trace[77667166] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"243.12224ms","start":"2026-04-23T07:40:51.19215Z","end":"2026-04-23T07:40:51.435272Z","steps":["trace[77667166] 'process raft request' (duration: 240.884268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:40:51.443217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.682184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-23T07:40:51.44348Z","caller":"traceutil/trace.go:171","msg":"trace[693066009] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:450; }","duration":"241.939482ms","start":"2026-04-23T07:40:51.201442Z","end":"2026-04-23T07:40:51.443382Z","steps":["trace[693066009] 'agreement among raft nodes before linearized reading' (duration: 241.674803ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:51.558949Z","caller":"traceutil/trace.go:171","msg":"trace[73492958] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"117.252065ms","start":"2026-04-23T07:40:51.441648Z","end":"2026-04-23T07:40:51.5589Z","steps":["trace[73492958] 'process raft request' (duration: 106.900531ms)","trace[73492958] 'compare' (duration: 10.21023ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:40:51.559307Z","caller":"traceutil/trace.go:171","msg":"trace[799125491] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"117.284457ms","start":"2026-04-23T07:40:51.441977Z","end":"2026-04-23T07:40:51.559261Z","steps":["trace[799125491] 'process raft request' (duration: 116.895404ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:51.559355Z","caller":"traceutil/trace.go:171","msg":"trace[766191806] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"117.06161ms","start":"2026-04-23T07:40:51.442259Z","end":"2026-04-23T07:40:51.559321Z","steps":["trace[766191806] 'process raft request' (duration: 116.871593ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:51.559444Z","caller":"traceutil/trace.go:171","msg":"trace[949044699] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"117.06292ms","start":"2026-04-23T07:40:51.442356Z","end":"2026-04-23T07:40:51.559418Z","steps":["trace[949044699] 'process raft request' (duration: 116.865834ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:51.560079Z","caller":"traceutil/trace.go:171","msg":"trace[2066637551] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"112.715059ms","start":"2026-04-23T07:40:51.447349Z","end":"2026-04-23T07:40:51.560065Z","steps":["trace[2066637551] 'process raft request' (duration: 112.665977ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:51.560509Z","caller":"traceutil/trace.go:171","msg":"trace[203699739] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"117.733742ms","start":"2026-04-23T07:40:51.44276Z","end":"2026-04-23T07:40:51.560493Z","steps":["trace[203699739] 'process raft request' (duration: 116.496572ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:51.760285Z","caller":"traceutil/trace.go:171","msg":"trace[1948408701] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"126.799855ms","start":"2026-04-23T07:40:51.633459Z","end":"2026-04-23T07:40:51.760259Z","steps":["trace[1948408701] 'process raft request' (duration: 26.965194ms)","trace[1948408701] 'compare' (duration: 99.713577ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:40:54.685063Z","caller":"traceutil/trace.go:171","msg":"trace[1911571832] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"250.134012ms","start":"2026-04-23T07:40:54.434904Z","end":"2026-04-23T07:40:54.685038Z","steps":["trace[1911571832] 'process raft request' (duration: 249.990107ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:40:59.244232Z","caller":"traceutil/trace.go:171","msg":"trace[1560995365] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"127.287743ms","start":"2026-04-23T07:40:59.116923Z","end":"2026-04-23T07:40:59.24421Z","steps":["trace[1560995365] 'process raft request' (duration: 127.152529ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:01.83729Z","caller":"traceutil/trace.go:171","msg":"trace[203475942] linearizableReadLoop","detail":"{readStateIndex:500; appliedIndex:499; }","duration":"135.426596ms","start":"2026-04-23T07:41:01.701839Z","end":"2026-04-23T07:41:01.837265Z","steps":["trace[203475942] 'read index received' (duration: 58.794161ms)","trace[203475942] 'applied index is now lower than readState.Index' (duration: 76.631485ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T07:41:01.83743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.57401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-23T07:41:01.837389Z","caller":"traceutil/trace.go:171","msg":"trace[730119439] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"137.009697ms","start":"2026-04-23T07:41:01.700337Z","end":"2026-04-23T07:41:01.837347Z","steps":["trace[730119439] 'process raft request' (duration: 60.235628ms)","trace[730119439] 'compare' (duration: 76.555222ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:41:01.837491Z","caller":"traceutil/trace.go:171","msg":"trace[1661516528] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:480; }","duration":"135.686355ms","start":"2026-04-23T07:41:01.70179Z","end":"2026-04-23T07:41:01.837477Z","steps":["trace[1661516528] 'agreement among raft nodes before linearized reading' (duration: 135.560721ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:02.840805Z","caller":"traceutil/trace.go:171","msg":"trace[626224555] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"113.087789ms","start":"2026-04-23T07:41:02.727686Z","end":"2026-04-23T07:41:02.840773Z","steps":["trace[626224555] 'process raft request' (duration: 112.887143ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:02.975423Z","caller":"traceutil/trace.go:171","msg":"trace[1949267146] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"125.406522ms","start":"2026-04-23T07:41:02.849989Z","end":"2026-04-23T07:41:02.975395Z","steps":["trace[1949267146] 'process raft request' (duration: 122.154726ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:03.251309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.208484ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-23T07:41:03.251402Z","caller":"traceutil/trace.go:171","msg":"trace[2142834258] linearizableReadLoop","detail":"{readStateIndex:505; appliedIndex:504; }","duration":"143.748646ms","start":"2026-04-23T07:41:03.107639Z","end":"2026-04-23T07:41:03.251388Z","steps":["trace[2142834258] 'read index received' (duration: 68.542µs)","trace[2142834258] 'applied index is now lower than readState.Index' (duration: 143.679034ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T07:41:03.251483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.844109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:03.251474Z","caller":"traceutil/trace.go:171","msg":"trace[157452358] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"254.740389ms","start":"2026-04-23T07:41:02.996687Z","end":"2026-04-23T07:41:03.251427Z","steps":["trace[157452358] 'process raft request' (duration: 98.332128ms)","trace[157452358] 'compare' (duration: 155.828742ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:41:03.251508Z","caller":"traceutil/trace.go:171","msg":"trace[1980927644] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:485; }","duration":"143.874859ms","start":"2026-04-23T07:41:03.107624Z","end":"2026-04-23T07:41:03.251499Z","steps":["trace[1980927644] 'agreement among raft nodes before linearized reading' (duration: 143.800187ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:03.513962Z","caller":"traceutil/trace.go:171","msg":"trace[64396121] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"157.901469ms","start":"2026-04-23T07:41:03.356029Z","end":"2026-04-23T07:41:03.51393Z","steps":["trace[64396121] 'process raft request' (duration: 106.459445ms)","trace[64396121] 'compare' (duration: 51.183906ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:41:03.517367Z","caller":"traceutil/trace.go:171","msg":"trace[1339212583] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"160.877537ms","start":"2026-04-23T07:41:03.356464Z","end":"2026-04-23T07:41:03.517342Z","steps":["trace[1339212583] 'process raft request' (duration: 160.837625ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:03.517762Z","caller":"traceutil/trace.go:171","msg":"trace[2082919300] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"161.435084ms","start":"2026-04-23T07:41:03.356259Z","end":"2026-04-23T07:41:03.517694Z","steps":["trace[2082919300] 'process raft request' (duration: 160.957749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:04.143023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.984678ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-23T07:41:04.143343Z","caller":"traceutil/trace.go:171","msg":"trace[266527659] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"325.850882ms","start":"2026-04-23T07:41:03.817472Z","end":"2026-04-23T07:41:04.143323Z","steps":["trace[266527659] 'process raft request' (duration: 325.79002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:04.143436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:03.817461Z","time spent":"325.927374ms","remote":"127.0.0.1:47846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14386,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T07:41:04.143442Z","caller":"traceutil/trace.go:171","msg":"trace[1823913976] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"331.92276ms","start":"2026-04-23T07:41:03.811489Z","end":"2026-04-23T07:41:04.143411Z","steps":["trace[1823913976] 'process raft request' (duration: 331.682252ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:04.143384Z","caller":"traceutil/trace.go:171","msg":"trace[1186784823] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"332.013943ms","start":"2026-04-23T07:41:03.811304Z","end":"2026-04-23T07:41:04.143318Z","steps":["trace[1186784823] 'process raft request' (duration: 183.594441ms)","trace[1186784823] 'compare' (duration: 147.815152ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T07:41:04.143599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:03.811465Z","time spent":"332.045874ms","remote":"127.0.0.1:47534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15061,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T07:41:04.143712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:03.811277Z","time spent":"332.283702ms","remote":"127.0.0.1:47444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":653,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T07:41:04.154406Z","caller":"traceutil/trace.go:171","msg":"trace[1296200379] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"322.11401ms","start":"2026-04-23T07:41:03.832272Z","end":"2026-04-23T07:41:04.154386Z","steps":["trace[1296200379] 'process raft request' (duration: 321.965974ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:04.154435Z","caller":"traceutil/trace.go:171","msg":"trace[2024781305] linearizableReadLoop","detail":"{readStateIndex:528; appliedIndex:522; }","duration":"318.714648ms","start":"2026-04-23T07:41:03.835706Z","end":"2026-04-23T07:41:04.154421Z","steps":["trace[2024781305] 'read index received' (duration: 159.210952ms)","trace[2024781305] 'applied index is now lower than readState.Index' (duration: 159.502896ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T07:41:04.154511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:03.832245Z","time spent":"322.213412ms","remote":"127.0.0.1:47444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":736,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T07:41:04.154571Z","caller":"traceutil/trace.go:171","msg":"trace[891785931] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"318.884723ms","start":"2026-04-23T07:41:03.835669Z","end":"2026-04-23T07:41:04.154553Z","steps":["trace[891785931] 'process raft request' (duration: 318.688717ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:04.154608Z","caller":"traceutil/trace.go:171","msg":"trace[24304544] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"322.094118ms","start":"2026-04-23T07:41:03.83249Z","end":"2026-04-23T07:41:04.154584Z","steps":["trace[24304544] 'process raft request' (duration: 321.82758ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:04.154668Z","caller":"traceutil/trace.go:171","msg":"trace[1787123136] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"209.493553ms","start":"2026-04-23T07:41:03.945114Z","end":"2026-04-23T07:41:04.154608Z","steps":["trace[1787123136] 'process raft request' (duration: 209.274576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:04.154692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.979996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4335"} {"level":"warn","ts":"2026-04-23T07:41:04.154698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:03.832481Z","time spent":"322.170022ms","remote":"127.0.0.1:47534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3622,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T07:41:04.154698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:03.835648Z","time spent":"318.981547ms","remote":"127.0.0.1:47860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4294,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T07:41:04.154738Z","caller":"traceutil/trace.go:171","msg":"trace[601442114] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:509; }","duration":"319.060109ms","start":"2026-04-23T07:41:03.835667Z","end":"2026-04-23T07:41:04.154727Z","steps":["trace[601442114] 'agreement among raft nodes before linearized reading' (duration: 318.940945ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:04.154767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:03.835654Z","time spent":"319.105071ms","remote":"127.0.0.1:47814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":4358,"request content":"key:\"/registry/deployments/kube-system/cilium-operator\" "} {"level":"warn","ts":"2026-04-23T07:41:04.163139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.838449ms","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-23T07:41:04.163262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.822125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-23T07:41:04.163345Z","caller":"traceutil/trace.go:171","msg":"trace[1492501959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:510; }","duration":"297.96284ms","start":"2026-04-23T07:41:03.865356Z","end":"2026-04-23T07:41:04.163319Z","steps":["trace[1492501959] 'agreement among raft nodes before linearized reading' (duration: 297.812745ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:04.163201Z","caller":"traceutil/trace.go:171","msg":"trace[807701687] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:510; }","duration":"320.934101ms","start":"2026-04-23T07:41:03.842254Z","end":"2026-04-23T07:41:04.163188Z","steps":["trace[807701687] 'agreement among raft nodes before linearized reading' (duration: 320.800647ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:04.163408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.019277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329956"} {"level":"info","ts":"2026-04-23T07:41:04.163491Z","caller":"traceutil/trace.go:171","msg":"trace[607452720] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:510; }","duration":"267.10816ms","start":"2026-04-23T07:41:03.89637Z","end":"2026-04-23T07:41:04.163478Z","steps":["trace[607452720] 'agreement among raft nodes before linearized reading' (duration: 266.770669ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:04.163447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:03.842231Z","time spent":"321.20287ms","remote":"127.0.0.1:47614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-23T07:41:04.536801Z","caller":"traceutil/trace.go:171","msg":"trace[1785165324] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:537; }","duration":"292.709061ms","start":"2026-04-23T07:41:04.244065Z","end":"2026-04-23T07:41:04.536774Z","steps":["trace[1785165324] 'read index received' (duration: 210.535768ms)","trace[1785165324] 'applied index is now lower than readState.Index' (duration: 82.172303ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:41:04.536928Z","caller":"traceutil/trace.go:171","msg":"trace[1035757242] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"336.244027ms","start":"2026-04-23T07:41:04.200672Z","end":"2026-04-23T07:41:04.536916Z","steps":["trace[1035757242] 'process raft request' (duration: 253.938401ms)","trace[1035757242] 'compare' (duration: 82.041518ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T07:41:04.537029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:04.200654Z","time spent":"336.30232ms","remote":"127.0.0.1:47814","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4656,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T07:41:04.537178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.116783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-9lk2b\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-04-23T07:41:04.537215Z","caller":"traceutil/trace.go:171","msg":"trace[1770767990] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-9lk2b; range_end:; response_count:1; response_revision:518; }","duration":"293.186226ms","start":"2026-04-23T07:41:04.244018Z","end":"2026-04-23T07:41:04.537204Z","steps":["trace[1770767990] 'agreement among raft nodes before linearized reading' (duration: 293.118973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:04.53742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.345587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"} {"level":"warn","ts":"2026-04-23T07:41:04.537432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.358507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"} {"level":"info","ts":"2026-04-23T07:41:04.537489Z","caller":"traceutil/trace.go:171","msg":"trace[1114308496] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:518; }","duration":"107.44882ms","start":"2026-04-23T07:41:04.430019Z","end":"2026-04-23T07:41:04.537468Z","steps":["trace[1114308496] 'agreement among raft nodes before linearized reading' (duration: 107.337386ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:04.537498Z","caller":"traceutil/trace.go:171","msg":"trace[581674589] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:518; }","duration":"107.442839ms","start":"2026-04-23T07:41:04.430038Z","end":"2026-04-23T07:41:04.537481Z","steps":["trace[581674589] 'agreement among raft nodes before linearized reading' (duration: 107.310145ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:04.537489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.662894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329956"} {"level":"info","ts":"2026-04-23T07:41:04.537554Z","caller":"traceutil/trace.go:171","msg":"trace[156860481] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:518; }","duration":"247.759797ms","start":"2026-04-23T07:41:04.289779Z","end":"2026-04-23T07:41:04.537539Z","steps":["trace[156860481] 'agreement among raft nodes before linearized reading' (duration: 247.400486ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:06.500993Z","caller":"traceutil/trace.go:171","msg":"trace[1587612213] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"577.1722ms","start":"2026-04-23T07:41:05.923788Z","end":"2026-04-23T07:41:06.50096Z","steps":["trace[1587612213] 'process raft request' (duration: 576.981093ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:06.501644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:05.923757Z","time spent":"577.767839ms","remote":"127.0.0.1:47424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T07:41:06.518388Z","caller":"traceutil/trace.go:171","msg":"trace[1915322102] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"589.111551ms","start":"2026-04-23T07:41:05.929236Z","end":"2026-04-23T07:41:06.518347Z","steps":["trace[1915322102] 'process raft request' (duration: 588.959276ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:06.518385Z","caller":"traceutil/trace.go:171","msg":"trace[353826571] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"589.774933ms","start":"2026-04-23T07:41:05.928556Z","end":"2026-04-23T07:41:06.51833Z","steps":["trace[353826571] 'process raft request' (duration: 589.472203ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:06.518526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:05.929225Z","time spent":"589.248036ms","remote":"127.0.0.1:47424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T07:41:06.518627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:05.928525Z","time spent":"590.006401ms","remote":"127.0.0.1:47424","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-23T07:41:06.525819Z","caller":"traceutil/trace.go:171","msg":"trace[1316569288] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"582.94138ms","start":"2026-04-23T07:41:05.942862Z","end":"2026-04-23T07:41:06.525804Z","steps":["trace[1316569288] 'process raft request' (duration: 582.669231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:06.525885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:05.942832Z","time spent":"583.027173ms","remote":"127.0.0.1:47424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T07:41:06.526029Z","caller":"traceutil/trace.go:171","msg":"trace[1196004739] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"580.275652ms","start":"2026-04-23T07:41:05.945719Z","end":"2026-04-23T07:41:06.525994Z","steps":["trace[1196004739] 'process raft request' (duration: 579.999143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:06.526235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:05.945707Z","time spent":"580.441427ms","remote":"127.0.0.1:47424","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-23T07:41:06.526333Z","caller":"traceutil/trace.go:171","msg":"trace[436276556] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"577.647616ms","start":"2026-04-23T07:41:05.948676Z","end":"2026-04-23T07:41:06.526324Z","steps":["trace[436276556] 'process raft request' (duration: 577.104158ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:06.526381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:05.948645Z","time spent":"577.718138ms","remote":"127.0.0.1:47424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T07:41:06.526524Z","caller":"traceutil/trace.go:171","msg":"trace[1033337288] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"577.698007ms","start":"2026-04-23T07:41:05.948812Z","end":"2026-04-23T07:41:06.52651Z","steps":["trace[1033337288] 'process raft request' (duration: 577.022645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:06.526614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:05.948807Z","time spent":"577.775579ms","remote":"127.0.0.1:47424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T07:41:06.526748Z","caller":"traceutil/trace.go:171","msg":"trace[1647359756] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"577.829861ms","start":"2026-04-23T07:41:05.948907Z","end":"2026-04-23T07:41:06.526737Z","steps":["trace[1647359756] 'process raft request' (duration: 577.136339ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:06.526811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:05.948901Z","time spent":"577.886213ms","remote":"127.0.0.1:47424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T07:41:06.528652Z","caller":"traceutil/trace.go:171","msg":"trace[421073107] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"572.604781ms","start":"2026-04-23T07:41:05.95602Z","end":"2026-04-23T07:41:06.528625Z","steps":["trace[421073107] 'process raft request' (duration: 570.248223ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:06.52986Z","caller":"traceutil/trace.go:171","msg":"trace[1466497497] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"562.661864ms","start":"2026-04-23T07:41:05.967179Z","end":"2026-04-23T07:41:06.529841Z","steps":["trace[1466497497] 'process raft request' (duration: 559.899703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:06.530029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:05.967154Z","time spent":"562.842981ms","remote":"127.0.0.1:47424","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-23T07:41:06.531121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:05.956002Z","time spent":"572.739554ms","remote":"127.0.0.1:47424","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-23T07:41:06.532301Z","caller":"traceutil/trace.go:171","msg":"trace[1429216786] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"428.674828ms","start":"2026-04-23T07:41:06.103612Z","end":"2026-04-23T07:41:06.532287Z","steps":["trace[1429216786] 'process raft request' (duration: 428.365128ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:06.532356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:06.103593Z","time spent":"428.73745ms","remote":"127.0.0.1:47424","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-23T07:41:06.5326Z","caller":"traceutil/trace.go:171","msg":"trace[453045699] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"556.545603ms","start":"2026-04-23T07:41:05.976045Z","end":"2026-04-23T07:41:06.532591Z","steps":["trace[453045699] 'process raft request' (duration: 551.146317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:06.532642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:05.976022Z","time spent":"556.602995ms","remote":"127.0.0.1:47424","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-23T07:41:06.533152Z","caller":"traceutil/trace.go:171","msg":"trace[1755933794] linearizableReadLoop","detail":"{readStateIndex:556; appliedIndex:543; }","duration":"328.830612ms","start":"2026-04-23T07:41:06.204284Z","end":"2026-04-23T07:41:06.533115Z","steps":["trace[1755933794] 'read index received' (duration: 296.563933ms)","trace[1755933794] 'applied index is now lower than readState.Index' (duration: 32.265449ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T07:41:06.534084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.781973ms","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-23T07:41:06.534121Z","caller":"traceutil/trace.go:171","msg":"trace[1266744163] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:536; }","duration":"329.871196ms","start":"2026-04-23T07:41:06.204241Z","end":"2026-04-23T07:41:06.534113Z","steps":["trace[1266744163] 'agreement among raft nodes before linearized reading' (duration: 328.949206ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:06.534145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:06.204221Z","time spent":"329.918728ms","remote":"127.0.0.1:47614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-23T07:41:06.55067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.229293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-23T07:41:06.550782Z","caller":"traceutil/trace.go:171","msg":"trace[808396867] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:540; }","duration":"346.394388ms","start":"2026-04-23T07:41:06.204374Z","end":"2026-04-23T07:41:06.550769Z","steps":["trace[808396867] 'agreement among raft nodes before linearized reading' (duration: 346.104939ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:06.551155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:06.204346Z","time spent":"346.800562ms","remote":"127.0.0.1:47614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-23T07:41:09.804672Z","caller":"traceutil/trace.go:171","msg":"trace[1832184924] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"151.778372ms","start":"2026-04-23T07:41:09.652863Z","end":"2026-04-23T07:41:09.804642Z","steps":["trace[1832184924] 'process raft request' (duration: 151.467932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:13.438066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.750919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:13.4383Z","caller":"traceutil/trace.go:171","msg":"trace[1392384960] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"329.972728ms","start":"2026-04-23T07:41:13.108255Z","end":"2026-04-23T07:41:13.438228Z","steps":["trace[1392384960] 'range keys from in-memory index tree' (duration: 329.662826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:13.438432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.591311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T07:41:13.438406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:13.108245Z","time spent":"330.142253ms","remote":"127.0.0.1:47376","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-23T07:41:13.43849Z","caller":"traceutil/trace.go:171","msg":"trace[1776712002] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:634; }","duration":"401.686414ms","start":"2026-04-23T07:41:13.036787Z","end":"2026-04-23T07:41:13.438474Z","steps":["trace[1776712002] 'range keys from in-memory index tree' (duration: 401.532949ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:13.438525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:13.036768Z","time spent":"401.748156ms","remote":"127.0.0.1:47588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-04-23T07:41:13.906348Z","caller":"traceutil/trace.go:171","msg":"trace[1062080638] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:660; }","duration":"321.378534ms","start":"2026-04-23T07:41:13.584935Z","end":"2026-04-23T07:41:13.906314Z","steps":["trace[1062080638] 'read index received' (duration: 321.223559ms)","trace[1062080638] 'applied index is now lower than readState.Index' (duration: 153.945µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:41:13.906487Z","caller":"traceutil/trace.go:171","msg":"trace[711758702] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"324.549578ms","start":"2026-04-23T07:41:13.58187Z","end":"2026-04-23T07:41:13.906419Z","steps":["trace[711758702] 'process raft request' (duration: 324.219748ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:13.906641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.673304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-n75ff\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-23T07:41:13.906681Z","caller":"traceutil/trace.go:171","msg":"trace[2075009434] range","detail":"{range_begin:/registry/pods/kube-system/cilium-n75ff; range_end:; response_count:1; response_revision:635; }","duration":"321.770408ms","start":"2026-04-23T07:41:13.584899Z","end":"2026-04-23T07:41:13.906669Z","steps":["trace[2075009434] 'agreement among raft nodes before linearized reading' (duration: 321.54225ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:13.906722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:13.584885Z","time spent":"321.827309ms","remote":"127.0.0.1:47534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-n75ff\" "} {"level":"warn","ts":"2026-04-23T07:41:13.906777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:13.581857Z","time spent":"324.754966ms","remote":"127.0.0.1:47614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T07:41:14.136294Z","caller":"traceutil/trace.go:171","msg":"trace[1863428997] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"293.120895ms","start":"2026-04-23T07:41:13.843141Z","end":"2026-04-23T07:41:14.136262Z","steps":["trace[1863428997] 'process raft request' (duration: 291.344966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:14.985041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.460393ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T07:41:14.985181Z","caller":"traceutil/trace.go:171","msg":"trace[2092062342] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:661; }","duration":"875.282831ms","start":"2026-04-23T07:41:14.109879Z","end":"2026-04-23T07:41:14.985162Z","steps":["trace[2092062342] 'read index received' (duration: 24.417186ms)","trace[2092062342] 'applied index is now lower than readState.Index' (duration: 850.864555ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:41:14.985228Z","caller":"traceutil/trace.go:171","msg":"trace[903448162] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"1.060513825s","start":"2026-04-23T07:41:13.924676Z","end":"2026-04-23T07:41:14.98519Z","steps":["trace[903448162] 'process raft request' (duration: 460.794763ms)","trace[903448162] 'compare' (duration: 599.341599ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T07:41:14.985415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:13.924642Z","time spent":"1.0606739s","remote":"127.0.0.1:47534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T07:41:14.985272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"875.402415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:14.985603Z","caller":"traceutil/trace.go:171","msg":"trace[31997152] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"875.738775ms","start":"2026-04-23T07:41:14.109811Z","end":"2026-04-23T07:41:14.98555Z","steps":["trace[31997152] 'agreement among raft nodes before linearized reading' (duration: 875.424535ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:14.985811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:14.109783Z","time spent":"875.958553ms","remote":"127.0.0.1:47376","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-23T07:41:15.426621Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.041134326s","expected-duration":"1s"} {"level":"info","ts":"2026-04-23T07:41:15.473722Z","caller":"traceutil/trace.go:171","msg":"trace[2037575746] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:663; }","duration":"488.49446ms","start":"2026-04-23T07:41:14.98521Z","end":"2026-04-23T07:41:15.473704Z","steps":["trace[2037575746] 'read index received' (duration: 441.544219ms)","trace[2037575746] 'applied index is now lower than readState.Index' (duration: 46.949311ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:41:15.473793Z","caller":"traceutil/trace.go:171","msg":"trace[828797219] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"1.08968603s","start":"2026-04-23T07:41:14.384054Z","end":"2026-04-23T07:41:15.47374Z","steps":["trace[828797219] 'process raft request' (duration: 1.089596587s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:15.473946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"818.826657ms","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-23T07:41:15.474008Z","caller":"traceutil/trace.go:171","msg":"trace[353661375] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"1.269540968s","start":"2026-04-23T07:41:14.204393Z","end":"2026-04-23T07:41:15.473934Z","steps":["trace[353661375] 'process raft request' (duration: 1.222422202s)","trace[353661375] 'compare' (duration: 46.476386ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:41:15.473988Z","caller":"traceutil/trace.go:171","msg":"trace[1506378440] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:639; }","duration":"818.93752ms","start":"2026-04-23T07:41:14.655039Z","end":"2026-04-23T07:41:15.473977Z","steps":["trace[1506378440] 'agreement among raft nodes before linearized reading' (duration: 818.772825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:15.47401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:14.38402Z","time spent":"1.089884827s","remote":"127.0.0.1:47614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T07:41:15.474012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.053705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-23T07:41:15.474082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:14.655009Z","time spent":"819.058094ms","remote":"127.0.0.1:47614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-23T07:41:15.474122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.611887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T07:41:15.474127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:14.204364Z","time spent":"1.269696944s","remote":"127.0.0.1:47588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T07:41:15.474127Z","caller":"traceutil/trace.go:171","msg":"trace[410010003] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:639; }","duration":"551.178889ms","start":"2026-04-23T07:41:14.922916Z","end":"2026-04-23T07:41:15.474095Z","steps":["trace[410010003] 'agreement among raft nodes before linearized reading' (duration: 550.834047ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:15.474234Z","caller":"traceutil/trace.go:171","msg":"trace[1437066894] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:639; }","duration":"486.808074ms","start":"2026-04-23T07:41:14.987406Z","end":"2026-04-23T07:41:15.474214Z","steps":["trace[1437066894] 'agreement among raft nodes before linearized reading' (duration: 486.607297ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:15.474276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:14.987381Z","time spent":"486.887676ms","remote":"127.0.0.1:47382","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-23T07:41:15.474276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:14.922841Z","time spent":"551.416938ms","remote":"127.0.0.1:47614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-23T07:41:15.474302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.321425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-23T07:41:15.474407Z","caller":"traceutil/trace.go:171","msg":"trace[237829229] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:639; }","duration":"833.513831ms","start":"2026-04-23T07:41:14.64087Z","end":"2026-04-23T07:41:15.474384Z","steps":["trace[237829229] 'agreement among raft nodes before linearized reading' (duration: 833.16216ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:15.474452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:14.640835Z","time spent":"833.609784ms","remote":"127.0.0.1:47614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-23T07:41:27.671106Z","caller":"traceutil/trace.go:171","msg":"trace[1640975203] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"122.952924ms","start":"2026-04-23T07:41:27.548122Z","end":"2026-04-23T07:41:27.671075Z","steps":["trace[1640975203] 'process raft request' (duration: 120.526753ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:27.671415Z","caller":"traceutil/trace.go:171","msg":"trace[1384580178] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"122.86651ms","start":"2026-04-23T07:41:27.548496Z","end":"2026-04-23T07:41:27.671362Z","steps":["trace[1384580178] 'process raft request' (duration: 122.523059ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:27.790081Z","caller":"traceutil/trace.go:171","msg":"trace[2063123738] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"100.087402ms","start":"2026-04-23T07:41:27.689963Z","end":"2026-04-23T07:41:27.790051Z","steps":["trace[2063123738] 'process raft request' (duration: 89.091656ms)","trace[2063123738] 'compare' (duration: 10.835281ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:41:31.493099Z","caller":"traceutil/trace.go:171","msg":"trace[1115228808] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"128.320571ms","start":"2026-04-23T07:41:31.364749Z","end":"2026-04-23T07:41:31.493069Z","steps":["trace[1115228808] 'process raft request' (duration: 48.173297ms)","trace[1115228808] 'compare' (duration: 80.03161ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:41:32.548728Z","caller":"traceutil/trace.go:171","msg":"trace[2139983221] linearizableReadLoop","detail":"{readStateIndex:838; appliedIndex:837; }","duration":"440.234507ms","start":"2026-04-23T07:41:32.10846Z","end":"2026-04-23T07:41:32.548694Z","steps":["trace[2139983221] 'read index received' (duration: 439.967558ms)","trace[2139983221] 'applied index is now lower than readState.Index' (duration: 265.619µs)"],"step_count":2} {"level":"warn","ts":"2026-04-23T07:41:32.549473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.989202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:32.549563Z","caller":"traceutil/trace.go:171","msg":"trace[663391761] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:806; }","duration":"441.126346ms","start":"2026-04-23T07:41:32.108407Z","end":"2026-04-23T07:41:32.549533Z","steps":["trace[663391761] 'agreement among raft nodes before linearized reading' (duration: 440.824805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:32.549598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:32.108388Z","time spent":"441.203939ms","remote":"127.0.0.1:47376","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-23T07:41:32.548829Z","caller":"traceutil/trace.go:171","msg":"trace[414065347] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"486.671786ms","start":"2026-04-23T07:41:32.062127Z","end":"2026-04-23T07:41:32.548799Z","steps":["trace[414065347] 'process raft request' (duration: 486.339235ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:32.549877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:32.062101Z","time spent":"487.65317ms","remote":"127.0.0.1:47614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T07:41:32.69773Z","caller":"traceutil/trace.go:171","msg":"trace[56562541] linearizableReadLoop","detail":"{readStateIndex:839; appliedIndex:838; }","duration":"148.055832ms","start":"2026-04-23T07:41:32.549649Z","end":"2026-04-23T07:41:32.697705Z","steps":["trace[56562541] 'read index received' (duration: 147.724061ms)","trace[56562541] 'applied index is now lower than readState.Index' (duration: 330.131µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:41:32.69806Z","caller":"traceutil/trace.go:171","msg":"trace[966227876] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"174.096053ms","start":"2026-04-23T07:41:32.523895Z","end":"2026-04-23T07:41:32.697991Z","steps":["trace[966227876] 'process raft request' (duration: 173.147891ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:32.698342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.261627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:32.698991Z","caller":"traceutil/trace.go:171","msg":"trace[1394580117] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:807; }","duration":"144.908128ms","start":"2026-04-23T07:41:32.554003Z","end":"2026-04-23T07:41:32.698911Z","steps":["trace[1394580117] 'agreement among raft nodes before linearized reading' (duration: 144.143602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:32.698446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.203967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-23T07:41:32.699231Z","caller":"traceutil/trace.go:171","msg":"trace[1186821173] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:807; }","duration":"397.041284ms","start":"2026-04-23T07:41:32.302165Z","end":"2026-04-23T07:41:32.699207Z","steps":["trace[1186821173] 'agreement among raft nodes before linearized reading' (duration: 396.200237ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:32.69859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.685315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:32.69947Z","caller":"traceutil/trace.go:171","msg":"trace[2127235041] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:807; }","duration":"223.673987ms","start":"2026-04-23T07:41:32.475779Z","end":"2026-04-23T07:41:32.699453Z","steps":["trace[2127235041] 'agreement among raft nodes before linearized reading' (duration: 222.657463ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:32.700247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:32.30213Z","time spent":"397.142488ms","remote":"127.0.0.1:47894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":93,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-04-23T07:41:35.960727Z","caller":"traceutil/trace.go:171","msg":"trace[1232811103] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"107.234895ms","start":"2026-04-23T07:41:35.853449Z","end":"2026-04-23T07:41:35.960684Z","steps":["trace[1232811103] 'process raft request' (duration: 106.76991ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:36.209869Z","caller":"traceutil/trace.go:171","msg":"trace[2082982140] linearizableReadLoop","detail":"{readStateIndex:889; appliedIndex:888; }","duration":"249.485875ms","start":"2026-04-23T07:41:35.960352Z","end":"2026-04-23T07:41:36.209838Z","steps":["trace[2082982140] 'read index received' (duration: 249.378751ms)","trace[2082982140] 'applied index is now lower than readState.Index' (duration: 105.584µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:41:36.209991Z","caller":"traceutil/trace.go:171","msg":"trace[1547739216] transaction","detail":"{read_only:false; response_revision:857; number_of_response:1; }","duration":"279.472688ms","start":"2026-04-23T07:41:35.930509Z","end":"2026-04-23T07:41:36.209982Z","steps":["trace[1547739216] 'process raft request' (duration: 279.130686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.210507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.477743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:36.210553Z","caller":"traceutil/trace.go:171","msg":"trace[304576583] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:857; }","duration":"269.559126ms","start":"2026-04-23T07:41:35.940982Z","end":"2026-04-23T07:41:36.210541Z","steps":["trace[304576583] 'agreement among raft nodes before linearized reading' (duration: 269.444862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.210942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.043972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:36.210989Z","caller":"traceutil/trace.go:171","msg":"trace[287553705] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:857; }","duration":"270.135296ms","start":"2026-04-23T07:41:35.940844Z","end":"2026-04-23T07:41:36.210979Z","steps":["trace[287553705] 'agreement among raft nodes before linearized reading' (duration: 270.046133ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.211382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.86035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-oidc-hmac\" ","response":"range_response_count:1 size:452"} {"level":"info","ts":"2026-04-23T07:41:36.211417Z","caller":"traceutil/trace.go:171","msg":"trace[372156696] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-oidc-hmac; range_end:; response_count:1; response_revision:857; }","duration":"273.919612ms","start":"2026-04-23T07:41:35.93749Z","end":"2026-04-23T07:41:36.211409Z","steps":["trace[372156696] 'agreement among raft nodes before linearized reading' (duration: 273.798278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.211681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.347613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:36.211717Z","caller":"traceutil/trace.go:171","msg":"trace[906704710] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:857; }","duration":"279.421756ms","start":"2026-04-23T07:41:35.932287Z","end":"2026-04-23T07:41:36.211708Z","steps":["trace[906704710] 'agreement among raft nodes before linearized reading' (duration: 279.360474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.211837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.418749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:36.21187Z","caller":"traceutil/trace.go:171","msg":"trace[1699708388] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:857; }","duration":"280.45394ms","start":"2026-04-23T07:41:35.931408Z","end":"2026-04-23T07:41:36.211862Z","steps":["trace[1699708388] 'agreement among raft nodes before linearized reading' (duration: 280.407098ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.211928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.364385ms","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":"info","ts":"2026-04-23T07:41:36.212004Z","caller":"traceutil/trace.go:171","msg":"trace[1711966443] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:857; }","duration":"349.466088ms","start":"2026-04-23T07:41:35.862516Z","end":"2026-04-23T07:41:36.211982Z","steps":["trace[1711966443] 'agreement among raft nodes before linearized reading' (duration: 349.333213ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.212067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:35.862512Z","time spent":"349.54232ms","remote":"127.0.0.1:47574","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-23T07:41:36.212284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.895584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:36.212321Z","caller":"traceutil/trace.go:171","msg":"trace[1299739274] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:857; }","duration":"280.984068ms","start":"2026-04-23T07:41:35.931327Z","end":"2026-04-23T07:41:36.212311Z","steps":["trace[1299739274] 'agreement among raft nodes before linearized reading' (duration: 280.916695ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.212413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.848742ms","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-23T07:41:36.212449Z","caller":"traceutil/trace.go:171","msg":"trace[472287842] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:857; }","duration":"300.885063ms","start":"2026-04-23T07:41:35.911556Z","end":"2026-04-23T07:41:36.212441Z","steps":["trace[472287842] 'agreement among raft nodes before linearized reading' (duration: 300.831351ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.212481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:35.911503Z","time spent":"300.969216ms","remote":"127.0.0.1:47578","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":"warn","ts":"2026-04-23T07:41:36.212549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.10812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:36.212591Z","caller":"traceutil/trace.go:171","msg":"trace[426143241] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:857; }","duration":"301.173523ms","start":"2026-04-23T07:41:35.911408Z","end":"2026-04-23T07:41:36.212582Z","steps":["trace[426143241] 'agreement among raft nodes before linearized reading' (duration: 301.114201ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.212626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:35.911398Z","time spent":"301.218214ms","remote":"127.0.0.1:47574","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:500 "} {"level":"warn","ts":"2026-04-23T07:41:36.212816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.322667ms","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":"info","ts":"2026-04-23T07:41:36.212858Z","caller":"traceutil/trace.go:171","msg":"trace[1248744165] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:857; }","duration":"301.374669ms","start":"2026-04-23T07:41:35.911474Z","end":"2026-04-23T07:41:36.212849Z","steps":["trace[1248744165] 'agreement among raft nodes before linearized reading' (duration: 301.312957ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.212892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:35.91147Z","time spent":"301.414711ms","remote":"127.0.0.1:47578","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-23T07:41:36.441508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.476989ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-23T07:41:36.441807Z","caller":"traceutil/trace.go:171","msg":"trace[831660949] linearizableReadLoop","detail":"{readStateIndex:891; appliedIndex:889; }","duration":"231.842256ms","start":"2026-04-23T07:41:36.209946Z","end":"2026-04-23T07:41:36.441788Z","steps":["trace[831660949] 'read index received' (duration: 91.026616ms)","trace[831660949] 'applied index is now lower than readState.Index' (duration: 140.81333ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T07:41:36.441946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.079454ms","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-23T07:41:36.441983Z","caller":"traceutil/trace.go:171","msg":"trace[1100032297] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:858; }","duration":"354.148206ms","start":"2026-04-23T07:41:36.087825Z","end":"2026-04-23T07:41:36.441973Z","steps":["trace[1100032297] 'agreement among raft nodes before linearized reading' (duration: 354.057513ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.442021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:36.087807Z","time spent":"354.204979ms","remote":"127.0.0.1:47594","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-23T07:41:36.44201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.885887ms","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-23T07:41:36.442116Z","caller":"traceutil/trace.go:171","msg":"trace[996277493] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:858; }","duration":"351.033922ms","start":"2026-04-23T07:41:36.091059Z","end":"2026-04-23T07:41:36.442092Z","steps":["trace[996277493] 'agreement among raft nodes before linearized reading' (duration: 350.792104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.442188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:36.091052Z","time spent":"351.118785ms","remote":"127.0.0.1:47594","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-23T07:41:36.44239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.026078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:36.442437Z","caller":"traceutil/trace.go:171","msg":"trace[1971236632] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:858; }","duration":"228.092419ms","start":"2026-04-23T07:41:36.214332Z","end":"2026-04-23T07:41:36.442424Z","steps":["trace[1971236632] 'agreement among raft nodes before linearized reading' (duration: 228.025107ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.442895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.68961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:36.442977Z","caller":"traceutil/trace.go:171","msg":"trace[1217239081] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:858; }","duration":"199.813834ms","start":"2026-04-23T07:41:36.24315Z","end":"2026-04-23T07:41:36.442964Z","steps":["trace[1217239081] 'agreement among raft nodes before linearized reading' (duration: 199.69369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.443027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.861196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:36.443079Z","caller":"traceutil/trace.go:171","msg":"trace[836096489] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:858; }","duration":"211.919989ms","start":"2026-04-23T07:41:36.231143Z","end":"2026-04-23T07:41:36.443063Z","steps":["trace[836096489] 'agreement among raft nodes before linearized reading' (duration: 211.862457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.443296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.167578ms","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-23T07:41:36.443349Z","caller":"traceutil/trace.go:171","msg":"trace[1509720975] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:858; }","duration":"212.262461ms","start":"2026-04-23T07:41:36.231074Z","end":"2026-04-23T07:41:36.443337Z","steps":["trace[1509720975] 'agreement among raft nodes before linearized reading' (duration: 212.189587ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.443545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.095274ms","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":"warn","ts":"2026-04-23T07:41:36.443563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.914708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:36.443591Z","caller":"traceutil/trace.go:171","msg":"trace[1080940953] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:858; }","duration":"229.143046ms","start":"2026-04-23T07:41:36.214435Z","end":"2026-04-23T07:41:36.443578Z","steps":["trace[1080940953] 'agreement among raft nodes before linearized reading' (duration: 229.075553ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:36.443764Z","caller":"traceutil/trace.go:171","msg":"trace[1344804623] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:858; }","duration":"138.965249ms","start":"2026-04-23T07:41:36.304626Z","end":"2026-04-23T07:41:36.443591Z","steps":["trace[1344804623] 'agreement among raft nodes before linearized reading' (duration: 138.898547ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.443813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.388914ms","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-23T07:41:36.443861Z","caller":"traceutil/trace.go:171","msg":"trace[48675395] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:858; }","duration":"229.464927ms","start":"2026-04-23T07:41:36.214385Z","end":"2026-04-23T07:41:36.443849Z","steps":["trace[48675395] 'agreement among raft nodes before linearized reading' (duration: 229.392154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.44416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.050175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:36.444202Z","caller":"traceutil/trace.go:171","msg":"trace[1948717717] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:858; }","duration":"140.104677ms","start":"2026-04-23T07:41:36.304088Z","end":"2026-04-23T07:41:36.444193Z","steps":["trace[1948717717] 'agreement among raft nodes before linearized reading' (duration: 140.039255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.444491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.393346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:36.444564Z","caller":"traceutil/trace.go:171","msg":"trace[1116108813] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:858; }","duration":"140.48991ms","start":"2026-04-23T07:41:36.304057Z","end":"2026-04-23T07:41:36.444547Z","steps":["trace[1116108813] 'agreement among raft nodes before linearized reading' (duration: 140.338795ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.444564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.17454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T07:41:36.442979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.785184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:36.444794Z","caller":"traceutil/trace.go:171","msg":"trace[538801856] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:858; }","duration":"213.601725ms","start":"2026-04-23T07:41:36.231169Z","end":"2026-04-23T07:41:36.44477Z","steps":["trace[538801856] 'agreement among raft nodes before linearized reading' (duration: 211.752403ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.445029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.104963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T07:41:36.445007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.187836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T07:41:36.445068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.691604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:36.445121Z","caller":"traceutil/trace.go:171","msg":"trace[1034353256] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:858; }","duration":"201.79529ms","start":"2026-04-23T07:41:36.243317Z","end":"2026-04-23T07:41:36.445112Z","steps":["trace[1034353256] 'agreement among raft nodes before linearized reading' (duration: 201.121188ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:36.445125Z","caller":"traceutil/trace.go:171","msg":"trace[1283724498] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:858; }","duration":"200.764616ms","start":"2026-04-23T07:41:36.244347Z","end":"2026-04-23T07:41:36.445112Z","steps":["trace[1283724498] 'agreement among raft nodes before linearized reading' (duration: 200.680983ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:36.445087Z","caller":"traceutil/trace.go:171","msg":"trace[1892803351] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:858; }","duration":"168.180236ms","start":"2026-04-23T07:41:36.276878Z","end":"2026-04-23T07:41:36.445058Z","steps":["trace[1892803351] 'agreement among raft nodes before linearized reading' (duration: 168.115554ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:36.445095Z","caller":"traceutil/trace.go:171","msg":"trace[464788267] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:858; }","duration":"168.30246ms","start":"2026-04-23T07:41:36.276776Z","end":"2026-04-23T07:41:36.445078Z","steps":["trace[464788267] 'agreement among raft nodes before linearized reading' (duration: 168.186246ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:36.446004Z","caller":"traceutil/trace.go:171","msg":"trace[1333104397] transaction","detail":"{read_only:false; response_revision:858; number_of_response:1; }","duration":"387.286964ms","start":"2026-04-23T07:41:36.058647Z","end":"2026-04-23T07:41:36.445934Z","steps":["trace[1333104397] 'process raft request' (duration: 383.010902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:36.446361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:36.058624Z","time spent":"387.505213ms","remote":"127.0.0.1:47614","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-23T07:41:39.024559Z","caller":"traceutil/trace.go:171","msg":"trace[1220252456] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"124.79759ms","start":"2026-04-23T07:41:38.899733Z","end":"2026-04-23T07:41:39.024531Z","steps":["trace[1220252456] 'process raft request' (duration: 124.606093ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:43.109482Z","caller":"traceutil/trace.go:171","msg":"trace[334716209] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"112.533957ms","start":"2026-04-23T07:41:42.996914Z","end":"2026-04-23T07:41:43.109448Z","steps":["trace[334716209] 'process raft request' (duration: 112.250827ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:43.401146Z","caller":"traceutil/trace.go:171","msg":"trace[1348673605] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"123.501265ms","start":"2026-04-23T07:41:43.277611Z","end":"2026-04-23T07:41:43.401113Z","steps":["trace[1348673605] 'process raft request' (duration: 87.817727ms)","trace[1348673605] 'compare' (duration: 35.384868ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:41:45.834835Z","caller":"traceutil/trace.go:171","msg":"trace[82063044] linearizableReadLoop","detail":"{readStateIndex:997; appliedIndex:995; }","duration":"217.316351ms","start":"2026-04-23T07:41:45.617488Z","end":"2026-04-23T07:41:45.834804Z","steps":["trace[82063044] 'read index received' (duration: 216.972949ms)","trace[82063044] 'applied index is now lower than readState.Index' (duration: 342.242µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:41:45.835204Z","caller":"traceutil/trace.go:171","msg":"trace[988125838] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"439.386759ms","start":"2026-04-23T07:41:45.395769Z","end":"2026-04-23T07:41:45.835156Z","steps":["trace[988125838] 'process raft request' (duration: 438.950275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:45.835338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.272789ms","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-23T07:41:45.83533Z","caller":"traceutil/trace.go:171","msg":"trace[1994861754] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"442.456712ms","start":"2026-04-23T07:41:45.392813Z","end":"2026-04-23T07:41:45.83527Z","steps":["trace[1994861754] 'process raft request' (duration: 441.730498ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:45.835396Z","caller":"traceutil/trace.go:171","msg":"trace[1443125443] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:963; }","duration":"142.371643ms","start":"2026-04-23T07:41:45.69301Z","end":"2026-04-23T07:41:45.835382Z","steps":["trace[1443125443] 'agreement among raft nodes before linearized reading' (duration: 142.177816ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:45.83539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:45.39576Z","time spent":"439.494572ms","remote":"127.0.0.1:47860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5192,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T07:41:45.835581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:45.392779Z","time spent":"442.651458ms","remote":"127.0.0.1:47618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1628,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T07:41:45.835619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.097026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-23T07:41:45.835837Z","caller":"traceutil/trace.go:171","msg":"trace[711176873] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:963; }","duration":"218.393876ms","start":"2026-04-23T07:41:45.617418Z","end":"2026-04-23T07:41:45.835811Z","steps":["trace[711176873] 'agreement among raft nodes before linearized reading' (duration: 217.795126ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:46.149705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.593875ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T07:41:46.149909Z","caller":"traceutil/trace.go:171","msg":"trace[673220379] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"305.07116ms","start":"2026-04-23T07:41:45.844769Z","end":"2026-04-23T07:41:46.14984Z","steps":["trace[673220379] 'process raft request' (duration: 200.208827ms)","trace[673220379] 'compare' (duration: 104.457539ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T07:41:46.149984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:45.844745Z","time spent":"305.205274ms","remote":"127.0.0.1:47614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T07:41:46.161625Z","caller":"traceutil/trace.go:171","msg":"trace[240466344] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"316.67765ms","start":"2026-04-23T07:41:45.844916Z","end":"2026-04-23T07:41:46.161594Z","steps":["trace[240466344] 'process raft request' (duration: 316.557396ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:46.161708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:45.844883Z","time spent":"316.784513ms","remote":"127.0.0.1:47614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T07:41:46.161863Z","caller":"traceutil/trace.go:171","msg":"trace[888614096] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"315.105107ms","start":"2026-04-23T07:41:45.846732Z","end":"2026-04-23T07:41:46.161837Z","steps":["trace[888614096] 'process raft request' (duration: 314.813437ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:46.162042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T07:41:45.846717Z","time spent":"315.220281ms","remote":"127.0.0.1:47814","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5626,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T07:41:46.218386Z","caller":"traceutil/trace.go:171","msg":"trace[989790389] linearizableReadLoop","detail":"{readStateIndex:1001; appliedIndex:997; }","duration":"220.779929ms","start":"2026-04-23T07:41:45.997573Z","end":"2026-04-23T07:41:46.218353Z","steps":["trace[989790389] 'read index received' (duration: 47.431273ms)","trace[989790389] 'applied index is now lower than readState.Index' (duration: 173.346976ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T07:41:46.218645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.623164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:46.2187Z","caller":"traceutil/trace.go:171","msg":"trace[561849160] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:966; }","duration":"109.680666ms","start":"2026-04-23T07:41:46.109004Z","end":"2026-04-23T07:41:46.218685Z","steps":["trace[561849160] 'agreement among raft nodes before linearized reading' (duration: 109.590983ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:46.218727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.37175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-23T07:41:46.218722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.12048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-23T07:41:46.218771Z","caller":"traceutil/trace.go:171","msg":"trace[1560195499] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:966; }","duration":"202.472163ms","start":"2026-04-23T07:41:46.016286Z","end":"2026-04-23T07:41:46.218758Z","steps":["trace[1560195499] 'agreement among raft nodes before linearized reading' (duration: 202.258066ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:46.218806Z","caller":"traceutil/trace.go:171","msg":"trace[1658708008] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:966; }","duration":"221.276225ms","start":"2026-04-23T07:41:45.99751Z","end":"2026-04-23T07:41:46.218786Z","steps":["trace[1658708008] 'agreement among raft nodes before linearized reading' (duration: 220.981845ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:46.751319Z","caller":"traceutil/trace.go:171","msg":"trace[471440543] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"208.31326ms","start":"2026-04-23T07:41:46.542969Z","end":"2026-04-23T07:41:46.751283Z","steps":["trace[471440543] 'process raft request' (duration: 187.370667ms)","trace[471440543] 'compare' (duration: 20.803289ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:41:46.774515Z","caller":"traceutil/trace.go:171","msg":"trace[624258729] linearizableReadLoop","detail":"{readStateIndex:1007; appliedIndex:1005; }","duration":"121.046897ms","start":"2026-04-23T07:41:46.653436Z","end":"2026-04-23T07:41:46.774483Z","steps":["trace[624258729] 'read index received' (duration: 76.932516ms)","trace[624258729] 'applied index is now lower than readState.Index' (duration: 44.112701ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:41:46.774619Z","caller":"traceutil/trace.go:171","msg":"trace[14765079] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"177.294888ms","start":"2026-04-23T07:41:46.597286Z","end":"2026-04-23T07:41:46.774581Z","steps":["trace[14765079] 'process raft request' (duration: 176.996728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:46.774803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.332237ms","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-23T07:41:46.774856Z","caller":"traceutil/trace.go:171","msg":"trace[174400396] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:972; }","duration":"121.455821ms","start":"2026-04-23T07:41:46.653386Z","end":"2026-04-23T07:41:46.774842Z","steps":["trace[174400396] 'agreement among raft nodes before linearized reading' (duration: 121.225144ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:47.023863Z","caller":"traceutil/trace.go:171","msg":"trace[1056176447] linearizableReadLoop","detail":"{readStateIndex:1009; appliedIndex:1008; }","duration":"110.299027ms","start":"2026-04-23T07:41:46.913534Z","end":"2026-04-23T07:41:47.023833Z","steps":["trace[1056176447] 'read index received' (duration: 110.047759ms)","trace[1056176447] 'applied index is now lower than readState.Index' (duration: 250.288µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:41:47.02413Z","caller":"traceutil/trace.go:171","msg":"trace[384271535] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"187.335915ms","start":"2026-04-23T07:41:46.836761Z","end":"2026-04-23T07:41:47.024097Z","steps":["trace[384271535] 'process raft request' (duration: 186.908721ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:47.024308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.735463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-23T07:41:47.024688Z","caller":"traceutil/trace.go:171","msg":"trace[1365680579] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:974; }","duration":"111.163467ms","start":"2026-04-23T07:41:46.913499Z","end":"2026-04-23T07:41:47.024662Z","steps":["trace[1365680579] 'agreement among raft nodes before linearized reading' (duration: 110.656399ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:41:47.319261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.215577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T07:41:47.319366Z","caller":"traceutil/trace.go:171","msg":"trace[1129334832] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:975; }","duration":"116.430074ms","start":"2026-04-23T07:41:47.202914Z","end":"2026-04-23T07:41:47.319344Z","steps":["trace[1129334832] 'range keys from in-memory index tree' (duration: 116.114244ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:48.40021Z","caller":"traceutil/trace.go:171","msg":"trace[705725099] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"138.971944ms","start":"2026-04-23T07:41:48.261205Z","end":"2026-04-23T07:41:48.400177Z","steps":["trace[705725099] 'process raft request' (duration: 138.834189ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:41:48.400211Z","caller":"traceutil/trace.go:171","msg":"trace[338351135] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"141.872422ms","start":"2026-04-23T07:41:48.2583Z","end":"2026-04-23T07:41:48.400173Z","steps":["trace[338351135] 'process raft request' (duration: 126.867767ms)","trace[338351135] 'compare' (duration: 14.587021ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:41:49.487702Z","caller":"traceutil/trace.go:171","msg":"trace[299984283] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"161.548515ms","start":"2026-04-23T07:41:49.326125Z","end":"2026-04-23T07:41:49.487673Z","steps":["trace[299984283] 'process raft request' (duration: 161.365479ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:42:05.130644Z","caller":"traceutil/trace.go:171","msg":"trace[1650785742] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"114.3931ms","start":"2026-04-23T07:42:05.016194Z","end":"2026-04-23T07:42:05.130587Z","steps":["trace[1650785742] 'process raft request' (duration: 114.183693ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:42:22.669156Z","caller":"traceutil/trace.go:171","msg":"trace[711504137] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"129.227032ms","start":"2026-04-23T07:42:22.539903Z","end":"2026-04-23T07:42:22.66913Z","steps":["trace[711504137] 'process raft request' (duration: 129.091888ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:42:34.920224Z","caller":"traceutil/trace.go:171","msg":"trace[2128076085] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"166.749563ms","start":"2026-04-23T07:42:34.753437Z","end":"2026-04-23T07:42:34.920186Z","steps":["trace[2128076085] 'process raft request' (duration: 166.465873ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:42:43.495386Z","caller":"traceutil/trace.go:171","msg":"trace[1177884739] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"122.681835ms","start":"2026-04-23T07:42:43.372654Z","end":"2026-04-23T07:42:43.495335Z","steps":["trace[1177884739] 'process raft request' (duration: 122.438375ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:42:51.051849Z","caller":"traceutil/trace.go:171","msg":"trace[1975782868] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"172.550766ms","start":"2026-04-23T07:42:50.879259Z","end":"2026-04-23T07:42:51.05181Z","steps":["trace[1975782868] 'process raft request' (duration: 157.722119ms)","trace[1975782868] 'compare' (duration: 14.578246ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:43:27.31186Z","caller":"traceutil/trace.go:171","msg":"trace[148615105] transaction","detail":"{read_only:false; response_revision:1343; number_of_response:1; }","duration":"123.699093ms","start":"2026-04-23T07:43:27.188131Z","end":"2026-04-23T07:43:27.31183Z","steps":["trace[148615105] 'process raft request' (duration: 123.491131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:43:34.029072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.705517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2568"} {"level":"info","ts":"2026-04-23T07:43:34.029183Z","caller":"traceutil/trace.go:171","msg":"trace[133543250] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1370; }","duration":"184.867958ms","start":"2026-04-23T07:43:33.844288Z","end":"2026-04-23T07:43:34.029156Z","steps":["trace[133543250] 'range keys from in-memory index tree' (duration: 184.511214ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:43:43.560361Z","caller":"traceutil/trace.go:171","msg":"trace[1073206235] transaction","detail":"{read_only:false; response_revision:1407; number_of_response:1; }","duration":"140.756786ms","start":"2026-04-23T07:43:43.419565Z","end":"2026-04-23T07:43:43.560322Z","steps":["trace[1073206235] 'process raft request' (duration: 140.511703ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T07:44:09.956633Z","caller":"traceutil/trace.go:171","msg":"trace[396895448] linearizableReadLoop","detail":"{readStateIndex:1558; appliedIndex:1557; }","duration":"126.559681ms","start":"2026-04-23T07:44:09.83004Z","end":"2026-04-23T07:44:09.9566Z","steps":["trace[396895448] 'read index received' (duration: 126.308887ms)","trace[396895448] 'applied index is now lower than readState.Index' (duration: 249.164µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T07:44:09.956796Z","caller":"traceutil/trace.go:171","msg":"trace[717482511] transaction","detail":"{read_only:false; response_revision:1493; number_of_response:1; }","duration":"167.620338ms","start":"2026-04-23T07:44:09.789123Z","end":"2026-04-23T07:44:09.956743Z","steps":["trace[717482511] 'process raft request' (duration: 167.228702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T07:44:09.956972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.898236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-23T07:44:09.957086Z","caller":"traceutil/trace.go:171","msg":"trace[1830269915] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1493; }","duration":"127.060308ms","start":"2026-04-23T07:44:09.829997Z","end":"2026-04-23T07:44:09.957057Z","steps":["trace[1830269915] 'agreement among raft nodes before linearized reading' (duration: 126.732363ms)"],"step_count":1}