{"level":"warn","ts":"2026-04-17T08:37:55.920984Z","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-17T08:37:55.921102Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.231: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.231:2380","--initial-cluster=instance=https://199.19.213.231:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.231:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.231: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-17T08:37:55.921197Z","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-17T08:37:55.921211Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.231:2380"]} {"level":"info","ts":"2026-04-17T08:37:55.921233Z","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-17T08:37:55.921903Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.231:2379"]} {"level":"info","ts":"2026-04-17T08:37:55.922036Z","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.231:2380"],"listen-peer-urls":["https://199.19.213.231:2380"],"advertise-client-urls":["https://199.19.213.231:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.231:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.231: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-17T08:37:55.928551Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.247416ms"} {"level":"info","ts":"2026-04-17T08:37:55.936889Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8bb149ac537fafcb","cluster-id":"6a60f8f1d4e49112"} {"level":"info","ts":"2026-04-17T08:37:55.937012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb switched to configuration voters=()"} {"level":"info","ts":"2026-04-17T08:37:55.937042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb became follower at term 0"} {"level":"info","ts":"2026-04-17T08:37:55.937055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8bb149ac537fafcb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-17T08:37:55.937097Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb became follower at term 1"} {"level":"info","ts":"2026-04-17T08:37:55.937171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb switched to configuration voters=(10065907646633848779)"} {"level":"warn","ts":"2026-04-17T08:37:55.946072Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-17T08:37:55.949461Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-17T08:37:55.951205Z","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-17T08:37:55.957629Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8bb149ac537fafcb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-17T08:37:55.970012Z","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-17T08:37:55.970083Z","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-17T08:37:55.970091Z","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-17T08:37:55.969992Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8bb149ac537fafcb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-17T08:37:55.971011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb switched to configuration voters=(10065907646633848779)"} {"level":"info","ts":"2026-04-17T08:37:55.971084Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6a60f8f1d4e49112","local-member-id":"8bb149ac537fafcb","added-peer-id":"8bb149ac537fafcb","added-peer-peer-urls":["https://199.19.213.231:2380"]} {"level":"info","ts":"2026-04-17T08:37:55.971506Z","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-17T08:37:55.971589Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.231:2380"} {"level":"info","ts":"2026-04-17T08:37:55.971805Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.231:2380"} {"level":"info","ts":"2026-04-17T08:37:55.973659Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-17T08:37:55.973606Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8bb149ac537fafcb","initial-advertise-peer-urls":["https://199.19.213.231:2380"],"listen-peer-urls":["https://199.19.213.231:2380"],"advertise-client-urls":["https://199.19.213.231:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.231:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-17T08:37:56.937448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb is starting a new election at term 1"} {"level":"info","ts":"2026-04-17T08:37:56.9375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb became pre-candidate at term 1"} {"level":"info","ts":"2026-04-17T08:37:56.937518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb received MsgPreVoteResp from 8bb149ac537fafcb at term 1"} {"level":"info","ts":"2026-04-17T08:37:56.937531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb became candidate at term 2"} {"level":"info","ts":"2026-04-17T08:37:56.937537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb received MsgVoteResp from 8bb149ac537fafcb at term 2"} {"level":"info","ts":"2026-04-17T08:37:56.937548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb became leader at term 2"} {"level":"info","ts":"2026-04-17T08:37:56.937556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8bb149ac537fafcb elected leader 8bb149ac537fafcb at term 2"} {"level":"info","ts":"2026-04-17T08:37:56.938536Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8bb149ac537fafcb","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.231:2379]}","request-path":"/0/members/8bb149ac537fafcb/attributes","cluster-id":"6a60f8f1d4e49112","publish-timeout":"7s"} {"level":"info","ts":"2026-04-17T08:37:56.938566Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T08:37:56.938633Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T08:37:56.938753Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T08:37:56.939182Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-17T08:37:56.93931Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-17T08:37:56.939744Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6a60f8f1d4e49112","local-member-id":"8bb149ac537fafcb","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T08:37:56.93989Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T08:37:56.939925Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T08:37:56.941469Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.231:2379"} {"level":"info","ts":"2026-04-17T08:37:56.942086Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-17T08:38:01.338564Z","caller":"traceutil/trace.go:171","msg":"trace[2100667529] transaction","detail":"{read_only:false; response_revision:250; number_of_response:1; }","duration":"442.43883ms","start":"2026-04-17T08:38:00.896086Z","end":"2026-04-17T08:38:01.338524Z","steps":["trace[2100667529] 'process raft request' (duration: 442.228284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:01.339487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:00.896042Z","time spent":"442.710627ms","remote":"127.0.0.1:38914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3695,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T08:38:01.496557Z","caller":"traceutil/trace.go:171","msg":"trace[1971166598] linearizableReadLoop","detail":"{readStateIndex:257; appliedIndex:256; }","duration":"152.447208ms","start":"2026-04-17T08:38:01.344079Z","end":"2026-04-17T08:38:01.496526Z","steps":["trace[1971166598] 'read index received' (duration: 130.109978ms)","trace[1971166598] 'applied index is now lower than readState.Index' (duration: 22.33563ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T08:38:01.49665Z","caller":"traceutil/trace.go:171","msg":"trace[1884146433] transaction","detail":"{read_only:false; response_revision:251; number_of_response:1; }","duration":"586.738413ms","start":"2026-04-17T08:38:00.909863Z","end":"2026-04-17T08:38:01.496601Z","steps":["trace[1884146433] 'process raft request' (duration: 564.309331ms)","trace[1884146433] 'compare' (duration: 22.158393ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T08:38:01.496718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.620452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-hnoo5f\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T08:38:01.496782Z","caller":"traceutil/trace.go:171","msg":"trace[327486950] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-hnoo5f; range_end:; response_count:0; response_revision:251; }","duration":"152.754946ms","start":"2026-04-17T08:38:01.344014Z","end":"2026-04-17T08:38:01.496769Z","steps":["trace[327486950] 'agreement among raft nodes before linearized reading' (duration: 152.617942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:01.496825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:00.909838Z","time spent":"586.909828ms","remote":"127.0.0.1:38926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T08:38:02.091134Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12667391664192381760,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T08:38:05.056515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.677812267s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-17T08:38:05.056634Z","caller":"traceutil/trace.go:171","msg":"trace[1229391808] linearizableReadLoop","detail":"{readStateIndex:258; appliedIndex:257; }","duration":"3.466557241s","start":"2026-04-17T08:38:01.590058Z","end":"2026-04-17T08:38:05.056615Z","steps":["trace[1229391808] 'read index received' (duration: 788.317212ms)","trace[1229391808] 'applied index is now lower than readState.Index' (duration: 2.678238629s)"],"step_count":2} {"level":"info","ts":"2026-04-17T08:38:05.056752Z","caller":"traceutil/trace.go:171","msg":"trace[413061074] transaction","detail":"{read_only:false; response_revision:252; number_of_response:1; }","duration":"3.554967774s","start":"2026-04-17T08:38:01.501724Z","end":"2026-04-17T08:38:05.056691Z","steps":["trace[413061074] 'process raft request' (duration: 876.748356ms)","trace[413061074] 'compare' (duration: 2.677459977s)"],"step_count":2} {"level":"warn","ts":"2026-04-17T08:38:05.056828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.466766107s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T08:38:05.056864Z","caller":"traceutil/trace.go:171","msg":"trace[535406878] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:252; }","duration":"3.466849419s","start":"2026-04-17T08:38:01.590004Z","end":"2026-04-17T08:38:05.056853Z","steps":["trace[535406878] 'agreement among raft nodes before linearized reading' (duration: 3.466714395s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:05.056904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:01.589986Z","time spent":"3.46690632s","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-17T08:38:05.056947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:01.501701Z","time spent":"3.555152178s","remote":"127.0.0.1:38850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":525,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T08:38:05.056992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.670931975s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-17T08:38:05.057099Z","caller":"traceutil/trace.go:171","msg":"trace[1708390322] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:252; }","duration":"2.671136961s","start":"2026-04-17T08:38:02.385928Z","end":"2026-04-17T08:38:05.057065Z","steps":["trace[1708390322] 'agreement among raft nodes before linearized reading' (duration: 2.670913844s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:05.057196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:02.385899Z","time spent":"2.671285714s","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-17T08:38:05.057444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.457679619s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T08:38:05.057482Z","caller":"traceutil/trace.go:171","msg":"trace[502216732] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:252; }","duration":"2.457762551s","start":"2026-04-17T08:38:02.599709Z","end":"2026-04-17T08:38:05.057471Z","steps":["trace[502216732] 'agreement among raft nodes before linearized reading' (duration: 2.457704479s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:05.057512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:02.599681Z","time spent":"2.457823663s","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-17T08:38:05.057515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.636807202s","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-17T08:38:05.057516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.197682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"} {"level":"info","ts":"2026-04-17T08:38:05.057557Z","caller":"traceutil/trace.go:171","msg":"trace[137788139] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:252; }","duration":"2.636876574s","start":"2026-04-17T08:38:02.42067Z","end":"2026-04-17T08:38:05.057546Z","steps":["trace[137788139] 'agreement among raft nodes before linearized reading' (duration: 2.636806472s)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:05.057571Z","caller":"traceutil/trace.go:171","msg":"trace[1679201614] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:252; }","duration":"704.289345ms","start":"2026-04-17T08:38:04.353265Z","end":"2026-04-17T08:38:05.057555Z","steps":["trace[1679201614] 'agreement among raft nodes before linearized reading' (duration: 704.156671ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:05.057586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:02.420655Z","time spent":"2.636923995s","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-17T08:38:05.057607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:04.353224Z","time spent":"704.376317ms","remote":"127.0.0.1:38926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":3489,"request content":"key:\"/registry/pods/kube-system/kube-vip-instance\" "} {"level":"warn","ts":"2026-04-17T08:38:05.565792Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12667391664192381763,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-17T08:38:05.881709Z","caller":"traceutil/trace.go:171","msg":"trace[1747375714] transaction","detail":"{read_only:false; response_revision:253; number_of_response:1; }","duration":"819.503697ms","start":"2026-04-17T08:38:05.062168Z","end":"2026-04-17T08:38:05.881672Z","steps":["trace[1747375714] 'process raft request' (duration: 807.673335ms)","trace[1747375714] 'compare' (duration: 11.502593ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T08:38:05.881897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:05.062132Z","time spent":"819.680212ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T08:38:05.881889Z","caller":"traceutil/trace.go:171","msg":"trace[1039482063] linearizableReadLoop","detail":"{readStateIndex:263; appliedIndex:258; }","duration":"816.33663ms","start":"2026-04-17T08:38:05.06552Z","end":"2026-04-17T08:38:05.881857Z","steps":["trace[1039482063] 'read index received' (duration: 804.990431ms)","trace[1039482063] 'applied index is now lower than readState.Index' (duration: 11.344589ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T08:38:05.882045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"816.500175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-hnoo5f\" ","response":"range_response_count:1 size:540"} {"level":"info","ts":"2026-04-17T08:38:05.882082Z","caller":"traceutil/trace.go:171","msg":"trace[1424397020] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-hnoo5f; range_end:; response_count:1; response_revision:258; }","duration":"816.602928ms","start":"2026-04-17T08:38:05.065466Z","end":"2026-04-17T08:38:05.882069Z","steps":["trace[1424397020] 'agreement among raft nodes before linearized reading' (duration: 816.499255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:05.882128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:05.065447Z","time spent":"816.667549ms","remote":"127.0.0.1:38850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":563,"request content":"key:\"/registry/secrets/kube-system/bootstrap-token-hnoo5f\" "} {"level":"info","ts":"2026-04-17T08:38:05.882332Z","caller":"traceutil/trace.go:171","msg":"trace[1728318066] transaction","detail":"{read_only:false; response_revision:255; number_of_response:1; }","duration":"817.03096ms","start":"2026-04-17T08:38:05.065285Z","end":"2026-04-17T08:38:05.882316Z","steps":["trace[1728318066] 'process raft request' (duration: 816.311011ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:05.882304Z","caller":"traceutil/trace.go:171","msg":"trace[2111094822] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"805.221028ms","start":"2026-04-17T08:38:05.07705Z","end":"2026-04-17T08:38:05.882271Z","steps":["trace[2111094822] 'process raft request' (duration: 804.668243ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:05.88174Z","caller":"traceutil/trace.go:171","msg":"trace[1636359905] transaction","detail":"{read_only:false; response_revision:254; number_of_response:1; }","duration":"817.557174ms","start":"2026-04-17T08:38:05.064144Z","end":"2026-04-17T08:38:05.881701Z","steps":["trace[1636359905] 'process raft request' (duration: 817.40041ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:05.882458Z","caller":"traceutil/trace.go:171","msg":"trace[796068788] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"817.06044ms","start":"2026-04-17T08:38:05.065388Z","end":"2026-04-17T08:38:05.882448Z","steps":["trace[796068788] 'process raft request' (duration: 816.268849ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:05.882499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:05.07703Z","time spent":"805.363092ms","remote":"127.0.0.1:38926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4649,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T08:38:05.882584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:05.06537Z","time spent":"817.122592ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T08:38:05.882724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:05.064081Z","time spent":"818.435468ms","remote":"127.0.0.1:38998","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-17T08:38:05.882761Z","caller":"traceutil/trace.go:171","msg":"trace[1772412451] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"174.212356ms","start":"2026-04-17T08:38:05.708532Z","end":"2026-04-17T08:38:05.882744Z","steps":["trace[1772412451] 'process raft request' (duration: 173.278401ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:05.882414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:05.065279Z","time spent":"817.083722ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T08:38:08.043106Z","caller":"traceutil/trace.go:171","msg":"trace[1698013997] transaction","detail":"{read_only:false; number_of_response:0; response_revision:324; }","duration":"102.765035ms","start":"2026-04-17T08:38:07.940295Z","end":"2026-04-17T08:38:08.04306Z","steps":["trace[1698013997] 'process raft request' (duration: 84.05168ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:08.043162Z","caller":"traceutil/trace.go:171","msg":"trace[1599861667] transaction","detail":"{read_only:false; number_of_response:0; response_revision:324; }","duration":"102.651492ms","start":"2026-04-17T08:38:07.940447Z","end":"2026-04-17T08:38:08.043099Z","steps":["trace[1599861667] 'process raft request' (duration: 102.440526ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:08.043204Z","caller":"traceutil/trace.go:171","msg":"trace[68296330] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"102.456826ms","start":"2026-04-17T08:38:07.940693Z","end":"2026-04-17T08:38:08.04315Z","steps":["trace[68296330] 'process raft request' (duration: 102.243031ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:08.78043Z","caller":"traceutil/trace.go:171","msg":"trace[1183432702] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"115.335374ms","start":"2026-04-17T08:38:08.665053Z","end":"2026-04-17T08:38:08.780388Z","steps":["trace[1183432702] 'process raft request' (duration: 104.705793ms)","trace[1183432702] 'compare' (duration: 10.334664ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T08:38:29.879175Z","caller":"traceutil/trace.go:171","msg":"trace[421723877] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"174.867385ms","start":"2026-04-17T08:38:29.704278Z","end":"2026-04-17T08:38:29.879145Z","steps":["trace[421723877] 'process raft request' (duration: 128.329226ms)","trace[421723877] 'compare' (duration: 46.424247ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T08:38:29.879915Z","caller":"traceutil/trace.go:171","msg":"trace[786007298] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"169.325871ms","start":"2026-04-17T08:38:29.710571Z","end":"2026-04-17T08:38:29.879897Z","steps":["trace[786007298] 'process raft request' (duration: 168.930342ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:29.879929Z","caller":"traceutil/trace.go:171","msg":"trace[965729762] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"158.628702ms","start":"2026-04-17T08:38:29.721264Z","end":"2026-04-17T08:38:29.879893Z","steps":["trace[965729762] 'process raft request' (duration: 158.509369ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:31.400011Z","caller":"traceutil/trace.go:171","msg":"trace[216672125] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:625; }","duration":"130.330747ms","start":"2026-04-17T08:38:31.269651Z","end":"2026-04-17T08:38:31.399982Z","steps":["trace[216672125] 'read index received' (duration: 39.56139ms)","trace[216672125] 'applied index is now lower than readState.Index' (duration: 90.768057ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T08:38:31.400473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.783847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570105"} {"level":"info","ts":"2026-04-17T08:38:31.400521Z","caller":"traceutil/trace.go:171","msg":"trace[542476103] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:599; }","duration":"130.875609ms","start":"2026-04-17T08:38:31.269631Z","end":"2026-04-17T08:38:31.400506Z","steps":["trace[542476103] 'agreement among raft nodes before linearized reading' (duration: 130.484391ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:31.400528Z","caller":"traceutil/trace.go:171","msg":"trace[669810078] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"135.352437ms","start":"2026-04-17T08:38:31.265113Z","end":"2026-04-17T08:38:31.400465Z","steps":["trace[669810078] 'process raft request' (duration: 44.292505ms)","trace[669810078] 'compare' (duration: 90.382568ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T08:38:36.183794Z","caller":"traceutil/trace.go:171","msg":"trace[1296106471] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"140.638395ms","start":"2026-04-17T08:38:36.043126Z","end":"2026-04-17T08:38:36.183764Z","steps":["trace[1296106471] 'read index received' (duration: 139.649774ms)","trace[1296106471] 'applied index is now lower than readState.Index' (duration: 987.441µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T08:38:36.185893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.701829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9tn9b\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-17T08:38:36.186127Z","caller":"traceutil/trace.go:171","msg":"trace[836440908] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9tn9b; range_end:; response_count:1; response_revision:623; }","duration":"142.974825ms","start":"2026-04-17T08:38:36.043072Z","end":"2026-04-17T08:38:36.186047Z","steps":["trace[836440908] 'agreement among raft nodes before linearized reading' (duration: 140.755448ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:36.186208Z","caller":"traceutil/trace.go:171","msg":"trace[745806431] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"680.88126ms","start":"2026-04-17T08:38:35.505008Z","end":"2026-04-17T08:38:36.185889Z","steps":["trace[745806431] 'process raft request' (duration: 678.104711ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:36.186428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:35.504973Z","time spent":"681.329339ms","remote":"127.0.0.1:38850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T08:38:36.187153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.866825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-17T08:38:36.187271Z","caller":"traceutil/trace.go:171","msg":"trace[1990034269] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:623; }","duration":"112.015668ms","start":"2026-04-17T08:38:36.07522Z","end":"2026-04-17T08:38:36.187235Z","steps":["trace[1990034269] 'agreement among raft nodes before linearized reading' (duration: 111.295433ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:36.187336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.558797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-17T08:38:36.187427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.511447ms","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-17T08:38:36.187502Z","caller":"traceutil/trace.go:171","msg":"trace[1111258024] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:623; }","duration":"103.63782ms","start":"2026-04-17T08:38:36.083848Z","end":"2026-04-17T08:38:36.187486Z","steps":["trace[1111258024] 'agreement among raft nodes before linearized reading' (duration: 103.455926ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:36.187449Z","caller":"traceutil/trace.go:171","msg":"trace[2071850515] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:623; }","duration":"102.789283ms","start":"2026-04-17T08:38:36.08464Z","end":"2026-04-17T08:38:36.187429Z","steps":["trace[2071850515] 'agreement among raft nodes before linearized reading' (duration: 102.478416ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:36.187697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.823854ms","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-17T08:38:36.18775Z","caller":"traceutil/trace.go:171","msg":"trace[466677111] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:623; }","duration":"103.882415ms","start":"2026-04-17T08:38:36.083844Z","end":"2026-04-17T08:38:36.187726Z","steps":["trace[466677111] 'agreement among raft nodes before linearized reading' (duration: 103.774103ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:37.238228Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.015646535s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-17T08:38:37.960889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.270785ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T08:38:37.961155Z","caller":"traceutil/trace.go:171","msg":"trace[747944435] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:652; }","duration":"1.164239562s","start":"2026-04-17T08:38:36.796902Z","end":"2026-04-17T08:38:37.961142Z","steps":["trace[747944435] 'read index received' (duration: 441.603969ms)","trace[747944435] 'applied index is now lower than readState.Index' (duration: 722.634223ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T08:38:37.961434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.164530059s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T08:38:37.961454Z","caller":"traceutil/trace.go:171","msg":"trace[2084145222] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"1.164590939s","start":"2026-04-17T08:38:36.796855Z","end":"2026-04-17T08:38:37.961446Z","steps":["trace[2084145222] 'agreement among raft nodes before linearized reading' (duration: 1.164319173s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:37.961474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:36.79684Z","time spent":"1.164629881s","remote":"127.0.0.1:38754","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-17T08:38:37.961602Z","caller":"traceutil/trace.go:171","msg":"trace[505924597] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"1.759363755s","start":"2026-04-17T08:38:36.202233Z","end":"2026-04-17T08:38:37.961596Z","steps":["trace[505924597] 'process raft request' (duration: 1.758828134s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:37.961639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:36.202209Z","time spent":"1.759413327s","remote":"127.0.0.1:38926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T08:38:37.961734Z","caller":"traceutil/trace.go:171","msg":"trace[1459588160] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"1.721880929s","start":"2026-04-17T08:38:36.239848Z","end":"2026-04-17T08:38:37.961729Z","steps":["trace[1459588160] 'process raft request' (duration: 1.721252436s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:37.961758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:36.239814Z","time spent":"1.72193195s","remote":"127.0.0.1:39082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T08:38:37.961841Z","caller":"traceutil/trace.go:171","msg":"trace[2022272143] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"1.76712642s","start":"2026-04-17T08:38:36.194678Z","end":"2026-04-17T08:38:37.961804Z","steps":["trace[2022272143] 'process raft request' (duration: 1.043873164s)","trace[2022272143] 'compare' (duration: 722.141092ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T08:38:37.962001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:36.194663Z","time spent":"1.767258193s","remote":"127.0.0.1:38998","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-17T08:38:37.962099Z","caller":"traceutil/trace.go:171","msg":"trace[1258597428] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"1.766749302s","start":"2026-04-17T08:38:36.195341Z","end":"2026-04-17T08:38:37.962091Z","steps":["trace[1258597428] 'process raft request' (duration: 1.765653979s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:37.962136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:36.195333Z","time spent":"1.766787373s","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T08:38:37.962124Z","caller":"traceutil/trace.go:171","msg":"trace[1375805084] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"1.764809421s","start":"2026-04-17T08:38:36.19728Z","end":"2026-04-17T08:38:37.96209Z","steps":["trace[1375805084] 'process raft request' (duration: 1.763756649s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:37.962296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:36.197256Z","time spent":"1.764963964s","remote":"127.0.0.1:38998","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-17T08:38:37.979085Z","caller":"traceutil/trace.go:171","msg":"trace[348988596] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"618.13128ms","start":"2026-04-17T08:38:37.36093Z","end":"2026-04-17T08:38:37.979061Z","steps":["trace[348988596] 'process raft request' (duration: 618.014278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:37.979256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:37.360893Z","time spent":"618.270453ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T08:38:38.102913Z","caller":"traceutil/trace.go:171","msg":"trace[1899647296] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:657; }","duration":"139.17864ms","start":"2026-04-17T08:38:37.963701Z","end":"2026-04-17T08:38:38.102879Z","steps":["trace[1899647296] 'read index received' (duration: 15.315853ms)","trace[1899647296] 'applied index is now lower than readState.Index' (duration: 123.861507ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T08:38:38.103057Z","caller":"traceutil/trace.go:171","msg":"trace[843960381] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"144.187465ms","start":"2026-04-17T08:38:37.958817Z","end":"2026-04-17T08:38:38.103004Z","steps":["trace[843960381] 'process raft request' (duration: 109.566331ms)","trace[843960381] 'compare' (duration: 34.353529ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T08:38:38.103135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.402144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T08:38:38.103192Z","caller":"traceutil/trace.go:171","msg":"trace[404165872] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"139.531217ms","start":"2026-04-17T08:38:37.963646Z","end":"2026-04-17T08:38:38.103178Z","steps":["trace[404165872] 'agreement among raft nodes before linearized reading' (duration: 139.414515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:38.103289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.369331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T08:38:38.103344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.817697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9tn9b\" ","response":"range_response_count:1 size:17149"} {"level":"info","ts":"2026-04-17T08:38:38.103393Z","caller":"traceutil/trace.go:171","msg":"trace[1463906870] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:631; }","duration":"128.506025ms","start":"2026-04-17T08:38:37.974861Z","end":"2026-04-17T08:38:38.103367Z","steps":["trace[1463906870] 'agreement among raft nodes before linearized reading' (duration: 128.354812ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:38.103405Z","caller":"traceutil/trace.go:171","msg":"trace[1537050673] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9tn9b; range_end:; response_count:1; response_revision:631; }","duration":"133.914798ms","start":"2026-04-17T08:38:37.969474Z","end":"2026-04-17T08:38:38.103389Z","steps":["trace[1537050673] 'agreement among raft nodes before linearized reading' (duration: 133.714264ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:38.624165Z","caller":"traceutil/trace.go:171","msg":"trace[1731113380] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"113.65047ms","start":"2026-04-17T08:38:38.510481Z","end":"2026-04-17T08:38:38.624131Z","steps":["trace[1731113380] 'process raft request' (duration: 105.210763ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:40.493273Z","caller":"traceutil/trace.go:171","msg":"trace[1615304869] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"211.14973ms","start":"2026-04-17T08:38:40.282079Z","end":"2026-04-17T08:38:40.493229Z","steps":["trace[1615304869] 'process raft request' (duration: 210.098578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:40.495478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.977706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T08:38:40.495593Z","caller":"traceutil/trace.go:171","msg":"trace[1612631234] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:671; }","duration":"102.15424ms","start":"2026-04-17T08:38:40.393408Z","end":"2026-04-17T08:38:40.495563Z","steps":["trace[1612631234] 'agreement among raft nodes before linearized reading' (duration: 101.946906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:40.495724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.602278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T08:38:40.495793Z","caller":"traceutil/trace.go:171","msg":"trace[416006542] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:671; }","duration":"101.765581ms","start":"2026-04-17T08:38:40.393994Z","end":"2026-04-17T08:38:40.495759Z","steps":["trace[416006542] 'agreement among raft nodes before linearized reading' (duration: 101.579607ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:50.329053Z","caller":"traceutil/trace.go:171","msg":"trace[278934178] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"109.310846ms","start":"2026-04-17T08:38:50.219712Z","end":"2026-04-17T08:38:50.329023Z","steps":["trace[278934178] 'process raft request' (duration: 109.01274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:50.559687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.655481ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T08:38:50.560277Z","caller":"traceutil/trace.go:171","msg":"trace[1721654132] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"225.978614ms","start":"2026-04-17T08:38:50.334232Z","end":"2026-04-17T08:38:50.560211Z","steps":["trace[1721654132] 'process raft request' (duration: 67.722211ms)","trace[1721654132] 'compare' (duration: 157.522718ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T08:38:50.56101Z","caller":"traceutil/trace.go:171","msg":"trace[1560014804] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"225.430863ms","start":"2026-04-17T08:38:50.335543Z","end":"2026-04-17T08:38:50.560974Z","steps":["trace[1560014804] 'process raft request' (duration: 225.242999ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:50.561005Z","caller":"traceutil/trace.go:171","msg":"trace[1528702118] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"225.546046ms","start":"2026-04-17T08:38:50.335422Z","end":"2026-04-17T08:38:50.560968Z","steps":["trace[1528702118] 'process raft request' (duration: 224.402264ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:50.561192Z","caller":"traceutil/trace.go:171","msg":"trace[699367597] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"219.382146ms","start":"2026-04-17T08:38:50.341792Z","end":"2026-04-17T08:38:50.561174Z","steps":["trace[699367597] 'process raft request' (duration: 219.108531ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:54.211852Z","caller":"traceutil/trace.go:171","msg":"trace[1536648762] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"155.343583ms","start":"2026-04-17T08:38:54.056476Z","end":"2026-04-17T08:38:54.21182Z","steps":["trace[1536648762] 'process raft request' (duration: 155.13422ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:54.729722Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12667391664192382879,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-17T08:38:54.764778Z","caller":"traceutil/trace.go:171","msg":"trace[2047681790] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"706.266153ms","start":"2026-04-17T08:38:54.058489Z","end":"2026-04-17T08:38:54.764755Z","steps":["trace[2047681790] 'process raft request' (duration: 706.07362ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:54.764922Z","caller":"traceutil/trace.go:171","msg":"trace[1481203278] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"706.079119ms","start":"2026-04-17T08:38:54.058785Z","end":"2026-04-17T08:38:54.764864Z","steps":["trace[1481203278] 'process raft request' (duration: 705.923496ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:54.765014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.668899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-j7dtx\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-17T08:38:54.764774Z","caller":"traceutil/trace.go:171","msg":"trace[199158650] linearizableReadLoop","detail":"{readStateIndex:830; appliedIndex:828; }","duration":"536.434995ms","start":"2026-04-17T08:38:54.228304Z","end":"2026-04-17T08:38:54.764739Z","steps":["trace[199158650] 'read index received' (duration: 536.247402ms)","trace[199158650] 'applied index is now lower than readState.Index' (duration: 186.543µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T08:38:54.765107Z","caller":"traceutil/trace.go:171","msg":"trace[1599542834] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-j7dtx; range_end:; response_count:1; response_revision:798; }","duration":"536.833482ms","start":"2026-04-17T08:38:54.228257Z","end":"2026-04-17T08:38:54.765091Z","steps":["trace[1599542834] 'agreement among raft nodes before linearized reading' (duration: 536.592488ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:54.765156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:54.05877Z","time spent":"706.257432ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T08:38:54.765263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:54.058471Z","time spent":"706.515569ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T08:38:54.765421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.105493ms","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":"warn","ts":"2026-04-17T08:38:54.765472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.540641ms","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-17T08:38:54.765512Z","caller":"traceutil/trace.go:171","msg":"trace[1173635621] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:798; }","duration":"189.250266ms","start":"2026-04-17T08:38:54.576243Z","end":"2026-04-17T08:38:54.765493Z","steps":["trace[1173635621] 'agreement among raft nodes before linearized reading' (duration: 189.007171ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:54.765557Z","caller":"traceutil/trace.go:171","msg":"trace[1326527245] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:798; }","duration":"108.637333ms","start":"2026-04-17T08:38:54.656898Z","end":"2026-04-17T08:38:54.765535Z","steps":["trace[1326527245] 'agreement among raft nodes before linearized reading' (duration: 108.366118ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:38:54.766007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:38:54.228229Z","time spent":"536.944674ms","remote":"127.0.0.1:38926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-j7dtx\" "} {"level":"info","ts":"2026-04-17T08:38:56.97619Z","caller":"traceutil/trace.go:171","msg":"trace[1577221033] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"135.019031ms","start":"2026-04-17T08:38:56.841147Z","end":"2026-04-17T08:38:56.976166Z","steps":["trace[1577221033] 'process raft request' (duration: 134.849038ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:56.980716Z","caller":"traceutil/trace.go:171","msg":"trace[155808764] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"138.100019ms","start":"2026-04-17T08:38:56.842599Z","end":"2026-04-17T08:38:56.980699Z","steps":["trace[155808764] 'process raft request' (duration: 138.048598ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:56.98075Z","caller":"traceutil/trace.go:171","msg":"trace[473161673] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"139.342162ms","start":"2026-04-17T08:38:56.841373Z","end":"2026-04-17T08:38:56.980715Z","steps":["trace[473161673] 'process raft request' (duration: 139.174119ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:38:56.981223Z","caller":"traceutil/trace.go:171","msg":"trace[636392063] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"138.561048ms","start":"2026-04-17T08:38:56.842646Z","end":"2026-04-17T08:38:56.981207Z","steps":["trace[636392063] 'process raft request' (duration: 138.030508ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:39:09.390999Z","caller":"traceutil/trace.go:171","msg":"trace[1194869471] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"153.364038ms","start":"2026-04-17T08:39:09.237598Z","end":"2026-04-17T08:39:09.390962Z","steps":["trace[1194869471] 'process raft request' (duration: 153.141074ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:39:19.318115Z","caller":"traceutil/trace.go:171","msg":"trace[1311224008] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"141.26688ms","start":"2026-04-17T08:39:19.176811Z","end":"2026-04-17T08:39:19.318078Z","steps":["trace[1311224008] 'process raft request' (duration: 141.066417ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:39:19.702391Z","caller":"traceutil/trace.go:171","msg":"trace[243630820] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"525.120624ms","start":"2026-04-17T08:39:19.177235Z","end":"2026-04-17T08:39:19.702355Z","steps":["trace[243630820] 'process raft request' (duration: 491.675029ms)","trace[243630820] 'compare' (duration: 32.742172ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T08:39:19.702649Z","caller":"traceutil/trace.go:171","msg":"trace[1153369445] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"525.157814ms","start":"2026-04-17T08:39:19.177467Z","end":"2026-04-17T08:39:19.702625Z","steps":["trace[1153369445] 'process raft request' (duration: 524.735267ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:39:19.702815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:39:19.177457Z","time spent":"525.269066ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T08:39:19.703031Z","caller":"traceutil/trace.go:171","msg":"trace[1884170541] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"524.640705ms","start":"2026-04-17T08:39:19.178338Z","end":"2026-04-17T08:39:19.702979Z","steps":["trace[1884170541] 'process raft request' (duration: 524.215288ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:39:19.703033Z","caller":"traceutil/trace.go:171","msg":"trace[1360516863] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"270.544124ms","start":"2026-04-17T08:39:19.432457Z","end":"2026-04-17T08:39:19.703001Z","steps":["trace[1360516863] 'process raft request' (duration: 270.429492ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:39:19.703087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:39:19.177197Z","time spent":"525.320396ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T08:39:19.703241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:39:19.178317Z","time spent":"524.817627ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T08:39:29.331142Z","caller":"traceutil/trace.go:171","msg":"trace[1496798874] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"114.102752ms","start":"2026-04-17T08:39:29.217004Z","end":"2026-04-17T08:39:29.331107Z","steps":["trace[1496798874] 'process raft request' (duration: 113.904748ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:39:31.814036Z","caller":"traceutil/trace.go:171","msg":"trace[1838533727] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"430.469938ms","start":"2026-04-17T08:39:31.383534Z","end":"2026-04-17T08:39:31.814004Z","steps":["trace[1838533727] 'process raft request' (duration: 430.049982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:39:31.81423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:39:31.383518Z","time spent":"430.6037ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T08:40:00.725044Z","caller":"traceutil/trace.go:171","msg":"trace[1969282217] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"115.191975ms","start":"2026-04-17T08:40:00.609826Z","end":"2026-04-17T08:40:00.725018Z","steps":["trace[1969282217] 'process raft request' (duration: 115.060356ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:40:01.514582Z","caller":"traceutil/trace.go:171","msg":"trace[1052848614] transaction","detail":"{read_only:false; response_revision:1114; number_of_response:1; }","duration":"160.112604ms","start":"2026-04-17T08:40:01.354444Z","end":"2026-04-17T08:40:01.514557Z","steps":["trace[1052848614] 'process raft request' (duration: 159.973052ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:40:02.024836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.210604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T08:40:02.024904Z","caller":"traceutil/trace.go:171","msg":"trace[1465146206] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1114; }","duration":"227.340335ms","start":"2026-04-17T08:40:01.797549Z","end":"2026-04-17T08:40:02.024889Z","steps":["trace[1465146206] 'range keys from in-memory index tree' (duration: 227.091652ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:40:22.320142Z","caller":"traceutil/trace.go:171","msg":"trace[300167697] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"180.659786ms","start":"2026-04-17T08:40:22.139434Z","end":"2026-04-17T08:40:22.320094Z","steps":["trace[300167697] 'process raft request' (duration: 165.544148ms)","trace[300167697] 'compare' (duration: 14.635922ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T08:40:22.320123Z","caller":"traceutil/trace.go:171","msg":"trace[585578653] linearizableReadLoop","detail":"{readStateIndex:1232; appliedIndex:1231; }","duration":"100.302781ms","start":"2026-04-17T08:40:22.219785Z","end":"2026-04-17T08:40:22.320088Z","steps":["trace[585578653] 'read index received' (duration: 85.099591ms)","trace[585578653] 'applied index is now lower than readState.Index' (duration: 15.20086ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T08:40:22.320494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.684355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-17T08:40:22.320581Z","caller":"traceutil/trace.go:171","msg":"trace[1105449695] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1181; }","duration":"100.841206ms","start":"2026-04-17T08:40:22.219716Z","end":"2026-04-17T08:40:22.320557Z","steps":["trace[1105449695] 'agreement among raft nodes before linearized reading' (duration: 100.559813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:40:23.139508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.212977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T08:40:23.139635Z","caller":"traceutil/trace.go:171","msg":"trace[147590761] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1186; }","duration":"167.484441ms","start":"2026-04-17T08:40:22.97212Z","end":"2026-04-17T08:40:23.139605Z","steps":["trace[147590761] 'count revisions from in-memory index tree' (duration: 167.038295ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:40:24.462754Z","caller":"traceutil/trace.go:171","msg":"trace[2095245923] linearizableReadLoop","detail":"{readStateIndex:1238; appliedIndex:1237; }","duration":"115.010683ms","start":"2026-04-17T08:40:24.347713Z","end":"2026-04-17T08:40:24.462724Z","steps":["trace[2095245923] 'read index received' (duration: 114.689978ms)","trace[2095245923] 'applied index is now lower than readState.Index' (duration: 319.455µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T08:40:24.462829Z","caller":"traceutil/trace.go:171","msg":"trace[1729327474] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"132.114646ms","start":"2026-04-17T08:40:24.33068Z","end":"2026-04-17T08:40:24.462795Z","steps":["trace[1729327474] 'process raft request' (duration: 131.792012ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:40:24.463483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.755471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-17T08:40:24.463604Z","caller":"traceutil/trace.go:171","msg":"trace[1457687587] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1187; }","duration":"115.911233ms","start":"2026-04-17T08:40:24.347645Z","end":"2026-04-17T08:40:24.463557Z","steps":["trace[1457687587] 'agreement among raft nodes before linearized reading' (duration: 115.232706ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:40:24.719884Z","caller":"traceutil/trace.go:171","msg":"trace[1491873847] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"250.511777ms","start":"2026-04-17T08:40:24.46933Z","end":"2026-04-17T08:40:24.719842Z","steps":["trace[1491873847] 'process raft request' (duration: 250.401586ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:40:24.719919Z","caller":"traceutil/trace.go:171","msg":"trace[1401079996] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"250.374946ms","start":"2026-04-17T08:40:24.469516Z","end":"2026-04-17T08:40:24.719891Z","steps":["trace[1401079996] 'process raft request' (duration: 250.281865ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:40:24.719891Z","caller":"traceutil/trace.go:171","msg":"trace[811965179] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"250.595507ms","start":"2026-04-17T08:40:24.469268Z","end":"2026-04-17T08:40:24.719864Z","steps":["trace[811965179] 'process raft request' (duration: 239.251344ms)","trace[811965179] 'compare' (duration: 10.911218ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T08:45:17.271886Z","caller":"traceutil/trace.go:171","msg":"trace[445327396] transaction","detail":"{read_only:false; response_revision:2202; number_of_response:1; }","duration":"161.153521ms","start":"2026-04-17T08:45:17.110703Z","end":"2026-04-17T08:45:17.271857Z","steps":["trace[445327396] 'process raft request' (duration: 160.961447ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:36.410414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.792618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T08:45:36.410633Z","caller":"traceutil/trace.go:171","msg":"trace[1455299730] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:2305; }","duration":"112.097046ms","start":"2026-04-17T08:45:36.29851Z","end":"2026-04-17T08:45:36.410607Z","steps":["trace[1455299730] 'range keys from in-memory index tree' (duration: 111.558652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:36.410617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.744158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-17T08:45:36.410746Z","caller":"traceutil/trace.go:171","msg":"trace[1125416032] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2305; }","duration":"113.912312ms","start":"2026-04-17T08:45:36.296782Z","end":"2026-04-17T08:45:36.410694Z","steps":["trace[1125416032] 'range keys from in-memory index tree' (duration: 113.45598ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:45:36.549003Z","caller":"traceutil/trace.go:171","msg":"trace[979262424] transaction","detail":"{read_only:false; response_revision:2306; number_of_response:1; }","duration":"132.87034ms","start":"2026-04-17T08:45:36.416107Z","end":"2026-04-17T08:45:36.548977Z","steps":["trace[979262424] 'process raft request' (duration: 132.710637ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:45:36.795945Z","caller":"traceutil/trace.go:171","msg":"trace[1835543744] linearizableReadLoop","detail":"{readStateIndex:2424; appliedIndex:2421; }","duration":"310.374037ms","start":"2026-04-17T08:45:36.485542Z","end":"2026-04-17T08:45:36.795916Z","steps":["trace[1835543744] 'read index received' (duration: 63.36442ms)","trace[1835543744] 'applied index is now lower than readState.Index' (duration: 247.008307ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T08:45:36.796184Z","caller":"traceutil/trace.go:171","msg":"trace[1327812358] transaction","detail":"{read_only:false; response_revision:2308; number_of_response:1; }","duration":"364.922358ms","start":"2026-04-17T08:45:36.431213Z","end":"2026-04-17T08:45:36.796135Z","steps":["trace[1327812358] 'process raft request' (duration: 364.645041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:36.796368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.812748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-17T08:45:36.796379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:36.431184Z","time spent":"365.095972ms","remote":"127.0.0.1:38826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T08:45:36.796424Z","caller":"traceutil/trace.go:171","msg":"trace[1138246547] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2308; }","duration":"310.938121ms","start":"2026-04-17T08:45:36.485472Z","end":"2026-04-17T08:45:36.79641Z","steps":["trace[1138246547] 'agreement among raft nodes before linearized reading' (duration: 310.748757ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:36.796469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:36.485448Z","time spent":"311.012433ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-17T08:45:36.796683Z","caller":"traceutil/trace.go:171","msg":"trace[1771151444] transaction","detail":"{read_only:false; response_revision:2307; number_of_response:1; }","duration":"379.341675ms","start":"2026-04-17T08:45:36.417326Z","end":"2026-04-17T08:45:36.796668Z","steps":["trace[1771151444] 'process raft request' (duration: 378.34901ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:36.796766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:36.417315Z","time spent":"379.401706ms","remote":"127.0.0.1:38998","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-17T08:45:36.825987Z","caller":"traceutil/trace.go:171","msg":"trace[552528746] transaction","detail":"{read_only:false; response_revision:2309; number_of_response:1; }","duration":"269.441022ms","start":"2026-04-17T08:45:36.55652Z","end":"2026-04-17T08:45:36.825961Z","steps":["trace[552528746] 'process raft request' (duration: 269.32497ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:36.826216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.778891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-04-17T08:45:36.826278Z","caller":"traceutil/trace.go:171","msg":"trace[1366206897] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2309; }","duration":"271.898714ms","start":"2026-04-17T08:45:36.554363Z","end":"2026-04-17T08:45:36.826261Z","steps":["trace[1366206897] 'agreement among raft nodes before linearized reading' (duration: 271.716649ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:36.82647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.074339ms","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-17T08:45:36.826524Z","caller":"traceutil/trace.go:171","msg":"trace[1320866310] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:2309; }","duration":"140.147701ms","start":"2026-04-17T08:45:36.686363Z","end":"2026-04-17T08:45:36.82651Z","steps":["trace[1320866310] 'agreement among raft nodes before linearized reading' (duration: 140.012518ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:36.82656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.81483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-17T08:45:36.826605Z","caller":"traceutil/trace.go:171","msg":"trace[1594282407] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2309; }","duration":"239.891712ms","start":"2026-04-17T08:45:36.586703Z","end":"2026-04-17T08:45:36.826595Z","steps":["trace[1594282407] 'agreement among raft nodes before linearized reading' (duration: 239.758429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:36.826785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.311577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-17T08:45:36.826815Z","caller":"traceutil/trace.go:171","msg":"trace[2049579736] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2309; }","duration":"340.373759ms","start":"2026-04-17T08:45:36.486433Z","end":"2026-04-17T08:45:36.826807Z","steps":["trace[2049579736] 'agreement among raft nodes before linearized reading' (duration: 340.284827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:36.826837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:36.486418Z","time spent":"340.412991ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-17T08:45:36.827545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.604711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-17T08:45:36.827621Z","caller":"traceutil/trace.go:171","msg":"trace[75963650] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2309; }","duration":"335.700434ms","start":"2026-04-17T08:45:36.491903Z","end":"2026-04-17T08:45:36.827603Z","steps":["trace[75963650] 'agreement among raft nodes before linearized reading' (duration: 334.183507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:36.827817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:36.49189Z","time spent":"335.913038ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-17T08:45:37.92782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.826576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T08:45:37.928381Z","caller":"traceutil/trace.go:171","msg":"trace[1392724155] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2316; }","duration":"130.03969ms","start":"2026-04-17T08:45:37.797929Z","end":"2026-04-17T08:45:37.927969Z","steps":["trace[1392724155] 'range keys from in-memory index tree' (duration: 129.753613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:57.392755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.974026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-17T08:45:57.392785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.329795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-17T08:45:57.392857Z","caller":"traceutil/trace.go:171","msg":"trace[1289313653] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2440; }","duration":"417.116051ms","start":"2026-04-17T08:45:56.975718Z","end":"2026-04-17T08:45:57.392835Z","steps":["trace[1289313653] 'range keys from in-memory index tree' (duration: 416.780881ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:45:57.392882Z","caller":"traceutil/trace.go:171","msg":"trace[1914332096] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2440; }","duration":"501.468279ms","start":"2026-04-17T08:45:56.89138Z","end":"2026-04-17T08:45:57.392849Z","steps":["trace[1914332096] 'range keys from in-memory index tree' (duration: 501.13847ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:57.392908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:56.975707Z","time spent":"417.190822ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-17T08:45:57.392931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:56.891355Z","time spent":"501.566493ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-17T08:45:57.393041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.057028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T08:45:57.393079Z","caller":"traceutil/trace.go:171","msg":"trace[356168930] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2440; }","duration":"595.13949ms","start":"2026-04-17T08:45:56.797928Z","end":"2026-04-17T08:45:57.393068Z","steps":["trace[356168930] 'range keys from in-memory index tree' (duration: 594.950286ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:57.3931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:56.7979Z","time spent":"595.195211ms","remote":"127.0.0.1:38754","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-17T08:45:57.393229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.97646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-17T08:45:57.393266Z","caller":"traceutil/trace.go:171","msg":"trace[1450137876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2440; }","duration":"407.036061ms","start":"2026-04-17T08:45:56.986219Z","end":"2026-04-17T08:45:57.393255Z","steps":["trace[1450137876] 'range keys from in-memory index tree' (duration: 406.863117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:57.3933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:56.986209Z","time spent":"407.084263ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-17T08:45:57.393474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.768314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-04-17T08:45:57.393496Z","caller":"traceutil/trace.go:171","msg":"trace[1707747027] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2440; }","duration":"108.835406ms","start":"2026-04-17T08:45:57.284654Z","end":"2026-04-17T08:45:57.393489Z","steps":["trace[1707747027] 'range keys from in-memory index tree' (duration: 108.642021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:57.393583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.052434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-04-17T08:45:57.393599Z","caller":"traceutil/trace.go:171","msg":"trace[210400051] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2440; }","duration":"481.124136ms","start":"2026-04-17T08:45:56.912469Z","end":"2026-04-17T08:45:57.393593Z","steps":["trace[210400051] 'range keys from in-memory index tree' (duration: 480.88224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:57.393616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:56.912439Z","time spent":"481.172687ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":558,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-17T08:45:57.39363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.767391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-17T08:45:57.393665Z","caller":"traceutil/trace.go:171","msg":"trace[10811527] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2440; }","duration":"401.825912ms","start":"2026-04-17T08:45:56.991829Z","end":"2026-04-17T08:45:57.393655Z","steps":["trace[10811527] 'range keys from in-memory index tree' (duration: 401.665999ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:57.393693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:56.991819Z","time spent":"401.868154ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-17T08:45:57.393709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.436299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-17T08:45:57.393755Z","caller":"traceutil/trace.go:171","msg":"trace[538304735] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2440; }","duration":"457.542861ms","start":"2026-04-17T08:45:56.936201Z","end":"2026-04-17T08:45:57.393744Z","steps":["trace[538304735] 'range keys from in-memory index tree' (duration: 457.276584ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:57.393787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:56.936175Z","time spent":"457.604974ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-17T08:45:57.39343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.349821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T08:45:57.394228Z","caller":"traceutil/trace.go:171","msg":"trace[549724683] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:2440; }","duration":"442.210162ms","start":"2026-04-17T08:45:56.951992Z","end":"2026-04-17T08:45:57.394202Z","steps":["trace[549724683] 'range keys from in-memory index tree' (duration: 441.216538ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:57.394336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:56.951971Z","time spent":"442.345965ms","remote":"127.0.0.1:38896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"info","ts":"2026-04-17T08:45:57.915539Z","caller":"traceutil/trace.go:171","msg":"trace[756909288] transaction","detail":"{read_only:false; response_revision:2441; number_of_response:1; }","duration":"516.573313ms","start":"2026-04-17T08:45:57.398936Z","end":"2026-04-17T08:45:57.915509Z","steps":["trace[756909288] 'process raft request' (duration: 516.410699ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:57.915719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:57.398913Z","time spent":"516.701756ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T08:45:58.456869Z","caller":"traceutil/trace.go:171","msg":"trace[1295383267] transaction","detail":"{read_only:false; response_revision:2442; number_of_response:1; }","duration":"1.057782306s","start":"2026-04-17T08:45:57.399028Z","end":"2026-04-17T08:45:58.45681Z","steps":["trace[1295383267] 'process raft request' (duration: 1.057302805s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:58.457076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:57.399004Z","time spent":"1.057959141s","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T08:45:58.457596Z","caller":"traceutil/trace.go:171","msg":"trace[88535821] transaction","detail":"{read_only:false; response_revision:2443; number_of_response:1; }","duration":"1.058497335s","start":"2026-04-17T08:45:57.399072Z","end":"2026-04-17T08:45:58.45757Z","steps":["trace[88535821] 'process raft request' (duration: 1.057617692s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:58.458347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:57.399039Z","time spent":"1.059230743s","remote":"127.0.0.1:38998","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-17T08:45:58.458635Z","caller":"traceutil/trace.go:171","msg":"trace[1785634072] transaction","detail":"{read_only:false; response_revision:2444; number_of_response:1; }","duration":"1.058827913s","start":"2026-04-17T08:45:57.399741Z","end":"2026-04-17T08:45:58.458569Z","steps":["trace[1785634072] 'process raft request' (duration: 1.057667955s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:58.458921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:57.399733Z","time spent":"1.059018058s","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T08:45:58.460616Z","caller":"traceutil/trace.go:171","msg":"trace[1524667739] transaction","detail":"{read_only:false; response_revision:2445; number_of_response:1; }","duration":"1.060779892s","start":"2026-04-17T08:45:57.399805Z","end":"2026-04-17T08:45:58.460585Z","steps":["trace[1524667739] 'process raft request' (duration: 1.057742526s)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:45:58.461056Z","caller":"traceutil/trace.go:171","msg":"trace[1946113986] transaction","detail":"{read_only:false; response_revision:2448; number_of_response:1; }","duration":"603.540858ms","start":"2026-04-17T08:45:57.857491Z","end":"2026-04-17T08:45:58.461031Z","steps":["trace[1946113986] 'process raft request' (duration: 603.474756ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:45:58.461184Z","caller":"traceutil/trace.go:171","msg":"trace[1081486756] transaction","detail":"{read_only:false; response_revision:2446; number_of_response:1; }","duration":"1.061259353s","start":"2026-04-17T08:45:57.399886Z","end":"2026-04-17T08:45:58.461146Z","steps":["trace[1081486756] 'process raft request' (duration: 1.060602037s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:58.461211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:57.857439Z","time spent":"603.721813ms","remote":"127.0.0.1:38998","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-17T08:45:58.461343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:57.399854Z","time spent":"1.061389557s","remote":"127.0.0.1:38998","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-17T08:45:58.461473Z","caller":"traceutil/trace.go:171","msg":"trace[1852846641] transaction","detail":"{read_only:false; response_revision:2447; number_of_response:1; }","duration":"1.061331295s","start":"2026-04-17T08:45:57.400125Z","end":"2026-04-17T08:45:58.461457Z","steps":["trace[1852846641] 'process raft request' (duration: 1.060757671s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:58.461521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:57.400116Z","time spent":"1.061378676s","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T08:45:58.460713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:57.399795Z","time spent":"1.060868554s","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":516,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T08:45:58.596649Z","caller":"traceutil/trace.go:171","msg":"trace[352249362] linearizableReadLoop","detail":"{readStateIndex:2569; appliedIndex:2561; }","duration":"212.449661ms","start":"2026-04-17T08:45:58.384136Z","end":"2026-04-17T08:45:58.596586Z","steps":["trace[352249362] 'read index received' (duration: 72.29126ms)","trace[352249362] 'applied index is now lower than readState.Index' (duration: 140.157071ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T08:45:58.596715Z","caller":"traceutil/trace.go:171","msg":"trace[611098683] transaction","detail":"{read_only:false; response_revision:2449; number_of_response:1; }","duration":"596.047583ms","start":"2026-04-17T08:45:58.00059Z","end":"2026-04-17T08:45:58.596637Z","steps":["trace[611098683] 'process raft request' (duration: 510.32649ms)","trace[611098683] 'compare' (duration: 85.554909ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T08:45:58.596969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.631996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T08:45:58.597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:58.000562Z","time spent":"596.313588ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T08:45:58.597028Z","caller":"traceutil/trace.go:171","msg":"trace[545300950] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:2449; }","duration":"212.956014ms","start":"2026-04-17T08:45:58.384058Z","end":"2026-04-17T08:45:58.597014Z","steps":["trace[545300950] 'agreement among raft nodes before linearized reading' (duration: 212.650176ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:45:59.385563Z","caller":"traceutil/trace.go:171","msg":"trace[804279840] transaction","detail":"{read_only:false; response_revision:2451; number_of_response:1; }","duration":"309.67002ms","start":"2026-04-17T08:45:59.075854Z","end":"2026-04-17T08:45:59.385524Z","steps":["trace[804279840] 'process raft request' (duration: 309.457855ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T08:45:59.385726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T08:45:59.075824Z","time spent":"309.811914ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T08:45:59.385771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.144559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:524"} {"level":"info","ts":"2026-04-17T08:45:59.385848Z","caller":"traceutil/trace.go:171","msg":"trace[1822498366] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2451; }","duration":"297.285512ms","start":"2026-04-17T08:45:59.088545Z","end":"2026-04-17T08:45:59.385831Z","steps":["trace[1822498366] 'agreement among raft nodes before linearized reading' (duration: 297.062237ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:45:59.385553Z","caller":"traceutil/trace.go:171","msg":"trace[861000520] linearizableReadLoop","detail":"{readStateIndex:2571; appliedIndex:2570; }","duration":"296.877412ms","start":"2026-04-17T08:45:59.088612Z","end":"2026-04-17T08:45:59.385489Z","steps":["trace[861000520] 'read index received' (duration: 296.579165ms)","trace[861000520] 'applied index is now lower than readState.Index' (duration: 296.757µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T08:45:59.38622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.255861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T08:45:59.386273Z","caller":"traceutil/trace.go:171","msg":"trace[540366459] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:2451; }","duration":"211.363304ms","start":"2026-04-17T08:45:59.174895Z","end":"2026-04-17T08:45:59.386258Z","steps":["trace[540366459] 'agreement among raft nodes before linearized reading' (duration: 211.277462ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T08:45:59.537175Z","caller":"traceutil/trace.go:171","msg":"trace[1140217073] transaction","detail":"{read_only:false; response_revision:2452; number_of_response:1; }","duration":"146.208701ms","start":"2026-04-17T08:45:59.390899Z","end":"2026-04-17T08:45:59.537107Z","steps":["trace[1140217073] 'process raft request' (duration: 91.522796ms)","trace[1140217073] 'compare' (duration: 54.518931ms)"],"step_count":2}