{"level":"warn","ts":"2026-06-30T08:57:04.596767Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-30T08:57:04.596849Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.23: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.23:2380","--initial-cluster=instance=https://199.19.213.23:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.23:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.23: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-06-30T08:57:04.596912Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-30T08:57:04.596928Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.23:2380"]} {"level":"info","ts":"2026-06-30T08:57:04.596982Z","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-06-30T08:57:04.597652Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.23:2379"]} {"level":"info","ts":"2026-06-30T08:57:04.597846Z","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.23:2380"],"listen-peer-urls":["https://199.19.213.23:2380"],"advertise-client-urls":["https://199.19.213.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.23: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-06-30T08:57:04.60196Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.78785ms"} {"level":"info","ts":"2026-06-30T08:57:04.606976Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1812db8446d3ac67","cluster-id":"57ff06cb872baa33"} {"level":"info","ts":"2026-06-30T08:57:04.607024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 switched to configuration voters=()"} {"level":"info","ts":"2026-06-30T08:57:04.607131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 became follower at term 0"} {"level":"info","ts":"2026-06-30T08:57:04.607156Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1812db8446d3ac67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-30T08:57:04.607164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 became follower at term 1"} {"level":"info","ts":"2026-06-30T08:57:04.607249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 switched to configuration voters=(1734690167661505639)"} {"level":"warn","ts":"2026-06-30T08:57:04.6214Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-30T08:57:04.625876Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-30T08:57:04.627802Z","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-06-30T08:57:04.62941Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1812db8446d3ac67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-30T08:57:04.629551Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1812db8446d3ac67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-30T08:57:04.629756Z","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-06-30T08:57:04.630536Z","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-06-30T08:57:04.630563Z","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-06-30T08:57:04.630767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 switched to configuration voters=(1734690167661505639)"} {"level":"info","ts":"2026-06-30T08:57:04.63094Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"57ff06cb872baa33","local-member-id":"1812db8446d3ac67","added-peer-id":"1812db8446d3ac67","added-peer-peer-urls":["https://199.19.213.23:2380"]} {"level":"info","ts":"2026-06-30T08:57:04.638397Z","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-06-30T08:57:04.638571Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1812db8446d3ac67","initial-advertise-peer-urls":["https://199.19.213.23:2380"],"listen-peer-urls":["https://199.19.213.23:2380"],"advertise-client-urls":["https://199.19.213.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-30T08:57:04.638602Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-30T08:57:04.63876Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.23:2380"} {"level":"info","ts":"2026-06-30T08:57:04.638778Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.23:2380"} {"level":"info","ts":"2026-06-30T08:57:05.508192Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 is starting a new election at term 1"} {"level":"info","ts":"2026-06-30T08:57:05.508268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-30T08:57:05.508322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 received MsgPreVoteResp from 1812db8446d3ac67 at term 1"} {"level":"info","ts":"2026-06-30T08:57:05.508471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 became candidate at term 2"} {"level":"info","ts":"2026-06-30T08:57:05.508505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 received MsgVoteResp from 1812db8446d3ac67 at term 2"} {"level":"info","ts":"2026-06-30T08:57:05.50863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 became leader at term 2"} {"level":"info","ts":"2026-06-30T08:57:05.508663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1812db8446d3ac67 elected leader 1812db8446d3ac67 at term 2"} {"level":"info","ts":"2026-06-30T08:57:05.509584Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T08:57:05.510517Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T08:57:05.510556Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T08:57:05.510468Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1812db8446d3ac67","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.23:2379]}","request-path":"/0/members/1812db8446d3ac67/attributes","cluster-id":"57ff06cb872baa33","publish-timeout":"7s"} {"level":"info","ts":"2026-06-30T08:57:05.511059Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"57ff06cb872baa33","local-member-id":"1812db8446d3ac67","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T08:57:05.511227Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T08:57:05.511284Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T08:57:05.511354Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-30T08:57:05.511369Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-30T08:57:05.514541Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-30T08:57:05.516285Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.23:2379"} {"level":"info","ts":"2026-06-30T08:57:09.05664Z","caller":"traceutil/trace.go:171","msg":"trace[949868350] transaction","detail":"{read_only:false; response_revision:197; number_of_response:1; }","duration":"268.821959ms","start":"2026-06-30T08:57:08.787796Z","end":"2026-06-30T08:57:09.056618Z","steps":["trace[949868350] 'process raft request' (duration: 268.687425ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:10.892283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.015948403s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-30T08:57:10.892434Z","caller":"traceutil/trace.go:171","msg":"trace[923110725] linearizableReadLoop","detail":"{readStateIndex:203; appliedIndex:202; }","duration":"1.08675304s","start":"2026-06-30T08:57:09.805662Z","end":"2026-06-30T08:57:10.892415Z","steps":["trace[923110725] 'read index received' (duration: 70.082726ms)","trace[923110725] 'applied index is now lower than readState.Index' (duration: 1.016668043s)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:57:10.892575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.145999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:57:10.89261Z","caller":"traceutil/trace.go:171","msg":"trace[1690655076] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:198; }","duration":"356.220261ms","start":"2026-06-30T08:57:10.53638Z","end":"2026-06-30T08:57:10.892601Z","steps":["trace[1690655076] 'agreement among raft nodes before linearized reading' (duration: 356.137398ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:10.892668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:10.536357Z","time spent":"356.302204ms","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-30T08:57:10.892755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.086998587s","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-06-30T08:57:10.892826Z","caller":"traceutil/trace.go:171","msg":"trace[490246410] transaction","detail":"{read_only:false; response_revision:198; number_of_response:1; }","duration":"1.832195602s","start":"2026-06-30T08:57:09.060433Z","end":"2026-06-30T08:57:10.892628Z","steps":["trace[490246410] 'process raft request' (duration: 815.368854ms)","trace[490246410] 'compare' (duration: 1.015794927s)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:57:10.8929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.09227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:57:10.892964Z","caller":"traceutil/trace.go:171","msg":"trace[1685444061] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:198; }","duration":"275.180192ms","start":"2026-06-30T08:57:10.617756Z","end":"2026-06-30T08:57:10.892936Z","steps":["trace[1685444061] 'agreement among raft nodes before linearized reading' (duration: 275.09912ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:10.892933Z","caller":"traceutil/trace.go:171","msg":"trace[874788853] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:198; }","duration":"1.087245754s","start":"2026-06-30T08:57:09.805656Z","end":"2026-06-30T08:57:10.892902Z","steps":["trace[874788853] 'agreement among raft nodes before linearized reading' (duration: 1.086815181s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:10.893085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:09.805599Z","time spent":"1.08742336s","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-30T08:57:10.893202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:09.060393Z","time spent":"1.832676166s","remote":"127.0.0.1:59456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":342,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:57:11.670662Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12423073021463191790,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T08:57:11.915071Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.017973154s","expected-duration":"1s"} {"level":"info","ts":"2026-06-30T08:57:11.915508Z","caller":"traceutil/trace.go:171","msg":"trace[1221756856] transaction","detail":"{read_only:false; response_revision:199; number_of_response:1; }","duration":"1.018483309s","start":"2026-06-30T08:57:10.897Z","end":"2026-06-30T08:57:11.915484Z","steps":["trace[1221756856] 'process raft request' (duration: 1.018251742s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:11.915761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:10.896978Z","time spent":"1.018584043s","remote":"127.0.0.1:59462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:57:11.916009Z","caller":"traceutil/trace.go:171","msg":"trace[95808741] linearizableReadLoop","detail":"{readStateIndex:207; appliedIndex:203; }","duration":"746.286748ms","start":"2026-06-30T08:57:11.169702Z","end":"2026-06-30T08:57:11.915989Z","steps":["trace[95808741] 'read index received' (duration: 745.564527ms)","trace[95808741] 'applied index is now lower than readState.Index' (duration: 721.291µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:57:11.916051Z","caller":"traceutil/trace.go:171","msg":"trace[1338638967] transaction","detail":"{read_only:false; response_revision:202; number_of_response:1; }","duration":"1.017913102s","start":"2026-06-30T08:57:10.898122Z","end":"2026-06-30T08:57:11.916035Z","steps":["trace[1338638967] 'process raft request' (duration: 1.01782251s)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:11.916043Z","caller":"traceutil/trace.go:171","msg":"trace[790863282] transaction","detail":"{read_only:false; response_revision:201; number_of_response:1; }","duration":"1.018788178s","start":"2026-06-30T08:57:10.897229Z","end":"2026-06-30T08:57:11.916017Z","steps":["trace[790863282] 'process raft request' (duration: 1.018643424s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:11.916103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:10.898106Z","time spent":"1.017971915s","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:57:11.916076Z","caller":"traceutil/trace.go:171","msg":"trace[2145322342] transaction","detail":"{read_only:false; response_revision:200; number_of_response:1; }","duration":"1.018944693s","start":"2026-06-30T08:57:10.897107Z","end":"2026-06-30T08:57:11.916051Z","steps":["trace[2145322342] 'process raft request' (duration: 1.018671945s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:11.916161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:10.897205Z","time spent":"1.018885741s","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:57:11.916232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:10.89709Z","time spent":"1.019110078s","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:57:11.91632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.542137ms","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-06-30T08:57:11.916445Z","caller":"traceutil/trace.go:171","msg":"trace[168851146] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:202; }","duration":"746.739733ms","start":"2026-06-30T08:57:11.169662Z","end":"2026-06-30T08:57:11.916402Z","steps":["trace[168851146] 'agreement among raft nodes before linearized reading' (duration: 746.399632ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:11.916523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:11.169642Z","time spent":"746.845675ms","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-30T08:57:22.864995Z","caller":"traceutil/trace.go:171","msg":"trace[1424407148] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"162.39385ms","start":"2026-06-30T08:57:22.702577Z","end":"2026-06-30T08:57:22.864971Z","steps":["trace[1424407148] 'process raft request' (duration: 162.268286ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:32.167691Z","caller":"traceutil/trace.go:171","msg":"trace[1773077889] linearizableReadLoop","detail":"{readStateIndex:409; appliedIndex:408; }","duration":"136.553409ms","start":"2026-06-30T08:57:32.031104Z","end":"2026-06-30T08:57:32.167657Z","steps":["trace[1773077889] 'read index received' (duration: 136.437075ms)","trace[1773077889] 'applied index is now lower than readState.Index' (duration: 115.304µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:57:32.167751Z","caller":"traceutil/trace.go:171","msg":"trace[1429040108] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"138.217532ms","start":"2026-06-30T08:57:32.029503Z","end":"2026-06-30T08:57:32.16772Z","steps":["trace[1429040108] 'process raft request' (duration: 138.023106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:32.167841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.26623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-30T08:57:32.167829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.713763ms","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-06-30T08:57:32.16787Z","caller":"traceutil/trace.go:171","msg":"trace[2126830959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:393; }","duration":"126.347412ms","start":"2026-06-30T08:57:32.041513Z","end":"2026-06-30T08:57:32.16786Z","steps":["trace[2126830959] 'agreement among raft nodes before linearized reading' (duration: 126.28329ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:32.167893Z","caller":"traceutil/trace.go:171","msg":"trace[340675127] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:393; }","duration":"136.826738ms","start":"2026-06-30T08:57:32.031051Z","end":"2026-06-30T08:57:32.167877Z","steps":["trace[340675127] 'agreement among raft nodes before linearized reading' (duration: 136.707094ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:32.792747Z","caller":"traceutil/trace.go:171","msg":"trace[1700765099] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"157.486666ms","start":"2026-06-30T08:57:32.635236Z","end":"2026-06-30T08:57:32.792723Z","steps":["trace[1700765099] 'process raft request' (duration: 157.345842ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:44.402742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.631673ms","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-06-30T08:57:44.40284Z","caller":"traceutil/trace.go:171","msg":"trace[610282064] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:449; }","duration":"109.773738ms","start":"2026-06-30T08:57:44.293046Z","end":"2026-06-30T08:57:44.402819Z","steps":["trace[610282064] 'range keys from in-memory index tree' (duration: 109.52962ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:44.786831Z","caller":"traceutil/trace.go:171","msg":"trace[1188266816] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"380.073348ms","start":"2026-06-30T08:57:44.406734Z","end":"2026-06-30T08:57:44.786808Z","steps":["trace[1188266816] 'process raft request' (duration: 379.881112ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:44.787186Z","caller":"traceutil/trace.go:171","msg":"trace[1643565233] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"380.388388ms","start":"2026-06-30T08:57:44.406762Z","end":"2026-06-30T08:57:44.78715Z","steps":["trace[1643565233] 'process raft request' (duration: 380.012716ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:44.787601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:44.40671Z","time spent":"380.198222ms","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T08:57:44.787788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:44.406734Z","time spent":"380.549364ms","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:57:44.869402Z","caller":"traceutil/trace.go:171","msg":"trace[2016326620] linearizableReadLoop","detail":"{readStateIndex:473; appliedIndex:470; }","duration":"440.50666ms","start":"2026-06-30T08:57:44.428869Z","end":"2026-06-30T08:57:44.869375Z","steps":["trace[2016326620] 'read index received' (duration: 357.740662ms)","trace[2016326620] 'applied index is now lower than readState.Index' (duration: 82.764498ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:57:44.869579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.052779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T08:57:44.869595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.713826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12673"} {"level":"info","ts":"2026-06-30T08:57:44.86962Z","caller":"traceutil/trace.go:171","msg":"trace[1191431164] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:452; }","duration":"202.139183ms","start":"2026-06-30T08:57:44.667468Z","end":"2026-06-30T08:57:44.869607Z","steps":["trace[1191431164] 'agreement among raft nodes before linearized reading' (duration: 202.069101ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:44.869674Z","caller":"traceutil/trace.go:171","msg":"trace[1085238405] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:452; }","duration":"440.84969ms","start":"2026-06-30T08:57:44.428807Z","end":"2026-06-30T08:57:44.869656Z","steps":["trace[1085238405] 'agreement among raft nodes before linearized reading' (duration: 440.680835ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:44.869726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:44.428788Z","time spent":"440.929272ms","remote":"127.0.0.1:59198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":3,"response size":12695,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"info","ts":"2026-06-30T08:57:44.870042Z","caller":"traceutil/trace.go:171","msg":"trace[1562204420] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"462.189685ms","start":"2026-06-30T08:57:44.407249Z","end":"2026-06-30T08:57:44.869439Z","steps":["trace[1562204420] 'process raft request' (duration: 438.745181ms)","trace[1562204420] 'compare' (duration: 23.271568ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:57:44.87027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:44.407235Z","time spent":"462.875037ms","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:57:45.80059Z","caller":"traceutil/trace.go:171","msg":"trace[1522328840] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"121.64735ms","start":"2026-06-30T08:57:45.678918Z","end":"2026-06-30T08:57:45.800566Z","steps":["trace[1522328840] 'process raft request' (duration: 121.265117ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:46.051102Z","caller":"traceutil/trace.go:171","msg":"trace[294031875] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"220.970475ms","start":"2026-06-30T08:57:45.830108Z","end":"2026-06-30T08:57:46.051078Z","steps":["trace[294031875] 'process raft request' (duration: 220.79761ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:46.066804Z","caller":"traceutil/trace.go:171","msg":"trace[1481779466] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"236.592642ms","start":"2026-06-30T08:57:45.830191Z","end":"2026-06-30T08:57:46.066784Z","steps":["trace[1481779466] 'process raft request' (duration: 236.494589ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:46.260785Z","caller":"traceutil/trace.go:171","msg":"trace[1171392097] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"189.849789ms","start":"2026-06-30T08:57:46.070913Z","end":"2026-06-30T08:57:46.260763Z","steps":["trace[1171392097] 'process raft request' (duration: 185.782684ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:46.449709Z","caller":"traceutil/trace.go:171","msg":"trace[815566198] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"110.303694ms","start":"2026-06-30T08:57:46.339371Z","end":"2026-06-30T08:57:46.449675Z","steps":["trace[815566198] 'process raft request' (duration: 83.916299ms)","trace[815566198] 'compare' (duration: 26.22682ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:57:46.480544Z","caller":"traceutil/trace.go:171","msg":"trace[174082800] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"126.850522ms","start":"2026-06-30T08:57:46.353641Z","end":"2026-06-30T08:57:46.480492Z","steps":["trace[174082800] 'process raft request' (duration: 126.605804ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:47.046648Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12423073021463192372,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T08:57:47.252457Z","caller":"traceutil/trace.go:171","msg":"trace[1810206362] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"710.61889ms","start":"2026-06-30T08:57:46.541812Z","end":"2026-06-30T08:57:47.252431Z","steps":["trace[1810206362] 'process raft request' (duration: 705.183799ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:47.252612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:46.541793Z","time spent":"710.750284ms","remote":"127.0.0.1:59280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3622,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:57:47.253185Z","caller":"traceutil/trace.go:171","msg":"trace[88977379] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"706.99058ms","start":"2026-06-30T08:57:46.546184Z","end":"2026-06-30T08:57:47.253174Z","steps":["trace[88977379] 'process raft request' (duration: 706.905228ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:47.253225Z","caller":"traceutil/trace.go:171","msg":"trace[100405092] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"707.100324ms","start":"2026-06-30T08:57:46.546118Z","end":"2026-06-30T08:57:47.253218Z","steps":["trace[100405092] 'process raft request' (duration: 706.844996ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:47.253259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:46.546171Z","time spent":"707.052752ms","remote":"127.0.0.1:59170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":736,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:57:47.253474Z","caller":"traceutil/trace.go:171","msg":"trace[696881621] linearizableReadLoop","detail":"{readStateIndex:499; appliedIndex:493; }","duration":"707.423223ms","start":"2026-06-30T08:57:46.546038Z","end":"2026-06-30T08:57:47.253462Z","steps":["trace[696881621] 'read index received' (duration: 700.98229ms)","trace[696881621] 'applied index is now lower than readState.Index' (duration: 6.440443ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:57:47.253544Z","caller":"traceutil/trace.go:171","msg":"trace[1048571887] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"704.230659ms","start":"2026-06-30T08:57:46.549306Z","end":"2026-06-30T08:57:47.253536Z","steps":["trace[1048571887] 'process raft request' (duration: 703.991091ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:47.253615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:46.549297Z","time spent":"704.28945ms","remote":"127.0.0.1:59616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14448,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T08:57:47.253783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.742404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4335"} {"level":"info","ts":"2026-06-30T08:57:47.253811Z","caller":"traceutil/trace.go:171","msg":"trace[911671747] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:478; }","duration":"707.795726ms","start":"2026-06-30T08:57:46.546007Z","end":"2026-06-30T08:57:47.253803Z","steps":["trace[911671747] 'agreement among raft nodes before linearized reading' (duration: 707.692373ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:47.253817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.616725ms","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-06-30T08:57:47.253832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:46.54598Z","time spent":"707.847178ms","remote":"127.0.0.1:59606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":4357,"request content":"key:\"/registry/deployments/kube-system/cilium-operator\" "} {"level":"info","ts":"2026-06-30T08:57:47.253873Z","caller":"traceutil/trace.go:171","msg":"trace[1304427290] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:478; }","duration":"462.699468ms","start":"2026-06-30T08:57:46.79116Z","end":"2026-06-30T08:57:47.253859Z","steps":["trace[1304427290] 'agreement among raft nodes before linearized reading' (duration: 462.593975ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:47.253901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.756339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-30T08:57:47.253914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:46.791151Z","time spent":"462.7539ms","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-30T08:57:47.253948Z","caller":"traceutil/trace.go:171","msg":"trace[344006997] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:478; }","duration":"462.850112ms","start":"2026-06-30T08:57:46.791083Z","end":"2026-06-30T08:57:47.253933Z","steps":["trace[344006997] 'agreement among raft nodes before linearized reading' (duration: 462.77366ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:47.254033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:46.79106Z","time spent":"462.921005ms","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-30T08:57:47.253276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:46.546108Z","time spent":"707.144705ms","remote":"127.0.0.1:59170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":653,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:57:47.254113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.866262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329956"} {"level":"warn","ts":"2026-06-30T08:57:47.254147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.437616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:57:47.254196Z","caller":"traceutil/trace.go:171","msg":"trace[1279627711] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:478; }","duration":"586.518529ms","start":"2026-06-30T08:57:46.66767Z","end":"2026-06-30T08:57:47.254189Z","steps":["trace[1279627711] 'agreement among raft nodes before linearized reading' (duration: 586.455927ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:47.254197Z","caller":"traceutil/trace.go:171","msg":"trace[168742980] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:478; }","duration":"689.958555ms","start":"2026-06-30T08:57:46.564215Z","end":"2026-06-30T08:57:47.254174Z","steps":["trace[168742980] 'agreement among raft nodes before linearized reading' (duration: 689.542632ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:47.253446Z","caller":"traceutil/trace.go:171","msg":"trace[819248840] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"706.407241ms","start":"2026-06-30T08:57:46.547007Z","end":"2026-06-30T08:57:47.253415Z","steps":["trace[819248840] 'process raft request' (duration: 706.113002ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:47.254255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:46.564207Z","time spent":"690.025078ms","remote":"127.0.0.1:59198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":4,"response size":329978,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"warn","ts":"2026-06-30T08:57:47.254368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:46.546997Z","time spent":"707.276469ms","remote":"127.0.0.1:59622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4294,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:57:47.253185Z","caller":"traceutil/trace.go:171","msg":"trace[1607768808] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"707.028101ms","start":"2026-06-30T08:57:46.546144Z","end":"2026-06-30T08:57:47.253172Z","steps":["trace[1607768808] 'process raft request' (duration: 706.888677ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:47.254351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.824602ms","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-06-30T08:57:47.254681Z","caller":"traceutil/trace.go:171","msg":"trace[1716306361] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:478; }","duration":"380.228326ms","start":"2026-06-30T08:57:46.874436Z","end":"2026-06-30T08:57:47.254664Z","steps":["trace[1716306361] 'agreement among raft nodes before linearized reading' (duration: 379.75682ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:47.254732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:46.874415Z","time spent":"380.302998ms","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-30T08:57:47.254878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:46.546127Z","time spent":"708.427777ms","remote":"127.0.0.1:59280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15061,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T08:57:47.254243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:46.667653Z","time spent":"586.583551ms","remote":"127.0.0.1:59084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-30T08:57:48.422316Z","caller":"traceutil/trace.go:171","msg":"trace[366858331] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"147.302454ms","start":"2026-06-30T08:57:48.274992Z","end":"2026-06-30T08:57:48.422294Z","steps":["trace[366858331] 'process raft request' (duration: 147.146719ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:49.330856Z","caller":"traceutil/trace.go:171","msg":"trace[1410025910] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"366.149624ms","start":"2026-06-30T08:57:48.96467Z","end":"2026-06-30T08:57:49.33082Z","steps":["trace[1410025910] 'process raft request' (duration: 365.902556ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:49.331181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:48.964652Z","time spent":"366.374782ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:57:49.337211Z","caller":"traceutil/trace.go:171","msg":"trace[1610006756] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"365.629428ms","start":"2026-06-30T08:57:48.971567Z","end":"2026-06-30T08:57:49.337197Z","steps":["trace[1610006756] 'process raft request' (duration: 365.08137ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:49.337277Z","caller":"traceutil/trace.go:171","msg":"trace[535047087] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"353.234735ms","start":"2026-06-30T08:57:48.984036Z","end":"2026-06-30T08:57:49.337271Z","steps":["trace[535047087] 'process raft request' (duration: 352.746638ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:49.337264Z","caller":"traceutil/trace.go:171","msg":"trace[1451948414] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"346.540772ms","start":"2026-06-30T08:57:48.990689Z","end":"2026-06-30T08:57:49.33723Z","steps":["trace[1451948414] 'process raft request' (duration: 346.236151ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:49.337363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:48.984027Z","time spent":"353.289577ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:57:49.33739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:48.990678Z","time spent":"346.652766ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:57:49.337374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:48.971558Z","time spent":"365.744442ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:57:49.33721Z","caller":"traceutil/trace.go:171","msg":"trace[532284750] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"351.023682ms","start":"2026-06-30T08:57:48.986158Z","end":"2026-06-30T08:57:49.337182Z","steps":["trace[532284750] 'process raft request' (duration: 350.69138ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:49.337519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:48.986148Z","time spent":"351.350672ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:57:49.337567Z","caller":"traceutil/trace.go:171","msg":"trace[1765767970] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"349.098497ms","start":"2026-06-30T08:57:48.988457Z","end":"2026-06-30T08:57:49.337556Z","steps":["trace[1765767970] 'process raft request' (duration: 348.426394ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:49.337617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:48.988436Z","time spent":"349.160839ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:57:49.337252Z","caller":"traceutil/trace.go:171","msg":"trace[1864313422] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"355.681176ms","start":"2026-06-30T08:57:48.981561Z","end":"2026-06-30T08:57:49.337242Z","steps":["trace[1864313422] 'process raft request' (duration: 355.165528ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:49.337665Z","caller":"traceutil/trace.go:171","msg":"trace[1627323861] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"366.519646ms","start":"2026-06-30T08:57:48.971135Z","end":"2026-06-30T08:57:49.337654Z","steps":["trace[1627323861] 'process raft request' (duration: 365.4323ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:49.337714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:48.981542Z","time spent":"356.155811ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:57:49.33783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:48.971123Z","time spent":"366.675312ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:57:49.337897Z","caller":"traceutil/trace.go:171","msg":"trace[372609133] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"345.543119ms","start":"2026-06-30T08:57:48.992342Z","end":"2026-06-30T08:57:49.337885Z","steps":["trace[372609133] 'process raft request' (duration: 344.624218ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:49.337914Z","caller":"traceutil/trace.go:171","msg":"trace[1524388653] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"340.051186ms","start":"2026-06-30T08:57:48.997852Z","end":"2026-06-30T08:57:49.337903Z","steps":["trace[1524388653] 'process raft request' (duration: 339.152775ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:49.33795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:48.992333Z","time spent":"345.593351ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:57:49.33797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:48.997838Z","time spent":"340.104198ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:57:49.338124Z","caller":"traceutil/trace.go:171","msg":"trace[1629462666] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"298.740579ms","start":"2026-06-30T08:57:49.039371Z","end":"2026-06-30T08:57:49.338111Z","steps":["trace[1629462666] 'process raft request' (duration: 297.683463ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:49.338183Z","caller":"traceutil/trace.go:171","msg":"trace[597618498] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"181.272189ms","start":"2026-06-30T08:57:49.156899Z","end":"2026-06-30T08:57:49.338171Z","steps":["trace[597618498] 'process raft request' (duration: 180.213283ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:49.935153Z","caller":"traceutil/trace.go:171","msg":"trace[918000138] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"581.445032ms","start":"2026-06-30T08:57:49.353633Z","end":"2026-06-30T08:57:49.935078Z","steps":["trace[918000138] 'process raft request' (duration: 581.259765ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:49.935178Z","caller":"traceutil/trace.go:171","msg":"trace[76342551] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"581.568216ms","start":"2026-06-30T08:57:49.35358Z","end":"2026-06-30T08:57:49.935148Z","steps":["trace[76342551] 'process raft request' (duration: 569.866545ms)","trace[76342551] 'compare' (duration: 11.357549ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:57:49.935301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:49.353628Z","time spent":"581.590407ms","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T08:57:49.935307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:49.353566Z","time spent":"581.67198ms","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:57:49.935352Z","caller":"traceutil/trace.go:171","msg":"trace[1281937825] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"579.639602ms","start":"2026-06-30T08:57:49.355685Z","end":"2026-06-30T08:57:49.935324Z","steps":["trace[1281937825] 'process raft request' (duration: 579.30954ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:49.935459Z","caller":"traceutil/trace.go:171","msg":"trace[1771359037] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"579.59462ms","start":"2026-06-30T08:57:49.355641Z","end":"2026-06-30T08:57:49.935236Z","steps":["trace[1771359037] 'process raft request' (duration: 579.289889ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:49.935787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:49.35568Z","time spent":"579.763195ms","remote":"127.0.0.1:59654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:57:49.935993Z","caller":"traceutil/trace.go:171","msg":"trace[746458777] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"580.267252ms","start":"2026-06-30T08:57:49.355709Z","end":"2026-06-30T08:57:49.935976Z","steps":["trace[746458777] 'process raft request' (duration: 579.334182ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:49.936104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:49.35569Z","time spent":"580.382817ms","remote":"127.0.0.1:59654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:57:49.936002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:49.355632Z","time spent":"580.244762ms","remote":"127.0.0.1:59654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:57:49.937063Z","caller":"traceutil/trace.go:171","msg":"trace[298448135] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"580.645905ms","start":"2026-06-30T08:57:49.356402Z","end":"2026-06-30T08:57:49.937048Z","steps":["trace[298448135] 'process raft request' (duration: 579.427105ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:49.937152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:49.356397Z","time spent":"580.708327ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:57:49.937223Z","caller":"traceutil/trace.go:171","msg":"trace[335209165] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"576.497127ms","start":"2026-06-30T08:57:49.360706Z","end":"2026-06-30T08:57:49.937203Z","steps":["trace[335209165] 'process raft request' (duration: 576.162165ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:49.937381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:49.360692Z","time spent":"576.620371ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:57:49.937641Z","caller":"traceutil/trace.go:171","msg":"trace[251052862] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"576.804727ms","start":"2026-06-30T08:57:49.360825Z","end":"2026-06-30T08:57:49.93763Z","steps":["trace[251052862] 'process raft request' (duration: 576.146735ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:49.937892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:49.36082Z","time spent":"577.045286ms","remote":"127.0.0.1:59654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:57:49.938021Z","caller":"traceutil/trace.go:171","msg":"trace[2027720451] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"576.205056ms","start":"2026-06-30T08:57:49.361774Z","end":"2026-06-30T08:57:49.937979Z","steps":["trace[2027720451] 'process raft request' (duration: 575.71979ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:49.938164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:49.361767Z","time spent":"576.355732ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:57:49.938291Z","caller":"traceutil/trace.go:171","msg":"trace[1197207526] transaction","detail":"{read_only:false; number_of_response:1; response_revision:517; }","duration":"564.528477ms","start":"2026-06-30T08:57:49.373751Z","end":"2026-06-30T08:57:49.93828Z","steps":["trace[1197207526] 'process raft request' (duration: 564.152765ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:49.938356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:49.373733Z","time spent":"564.590138ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":101,"response count":0,"response size":10111,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:57:49.938377Z","caller":"traceutil/trace.go:171","msg":"trace[493046007] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"562.628153ms","start":"2026-06-30T08:57:49.375736Z","end":"2026-06-30T08:57:49.938364Z","steps":["trace[493046007] 'process raft request' (duration: 562.209589ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:49.938448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:49.375717Z","time spent":"562.684775ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:57:49.938527Z","caller":"traceutil/trace.go:171","msg":"trace[610572281] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"562.768278ms","start":"2026-06-30T08:57:49.375747Z","end":"2026-06-30T08:57:49.938515Z","steps":["trace[610572281] 'process raft request' (duration: 562.494849ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:49.938567Z","caller":"traceutil/trace.go:171","msg":"trace[130584399] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"536.840794ms","start":"2026-06-30T08:57:49.401718Z","end":"2026-06-30T08:57:49.938559Z","steps":["trace[130584399] 'process raft request' (duration: 536.605645ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:49.938606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.047386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T08:57:49.938614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:49.401679Z","time spent":"536.910506ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:57:49.93864Z","caller":"traceutil/trace.go:171","msg":"trace[1935764084] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:520; }","duration":"271.147198ms","start":"2026-06-30T08:57:49.667486Z","end":"2026-06-30T08:57:49.938633Z","steps":["trace[1935764084] 'agreement among raft nodes before linearized reading' (duration: 271.064076ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:49.938663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:49.375737Z","time spent":"562.82224ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:57:49.938527Z","caller":"traceutil/trace.go:171","msg":"trace[411406979] linearizableReadLoop","detail":"{readStateIndex:544; appliedIndex:531; }","duration":"270.951781ms","start":"2026-06-30T08:57:49.667544Z","end":"2026-06-30T08:57:49.938495Z","steps":["trace[411406979] 'read index received' (duration: 255.93389ms)","trace[411406979] 'applied index is now lower than readState.Index' (duration: 15.017251ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:57:57.155807Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12423073021463192599,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T08:57:57.214713Z","caller":"traceutil/trace.go:171","msg":"trace[1345507788] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"559.469659ms","start":"2026-06-30T08:57:56.655219Z","end":"2026-06-30T08:57:57.214688Z","steps":["trace[1345507788] 'read index received' (duration: 558.898949ms)","trace[1345507788] 'applied index is now lower than readState.Index' (duration: 569.76µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:57:57.214823Z","caller":"traceutil/trace.go:171","msg":"trace[202666375] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"577.338724ms","start":"2026-06-30T08:57:56.637474Z","end":"2026-06-30T08:57:57.214813Z","steps":["trace[202666375] 'process raft request' (duration: 576.740073ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:57.214918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.163081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:57:57.214995Z","caller":"traceutil/trace.go:171","msg":"trace[8067938] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:605; }","duration":"547.279775ms","start":"2026-06-30T08:57:56.667697Z","end":"2026-06-30T08:57:57.214977Z","steps":["trace[8067938] 'agreement among raft nodes before linearized reading' (duration: 547.149061ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:57.215009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:56.637449Z","time spent":"577.446517ms","remote":"127.0.0.1:59198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T08:57:57.215049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:56.667684Z","time spent":"547.352577ms","remote":"127.0.0.1:59070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-30T08:57:57.215383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.14418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tgb2p\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-30T08:57:57.215469Z","caller":"traceutil/trace.go:171","msg":"trace[2091804519] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tgb2p; range_end:; response_count:1; response_revision:605; }","duration":"560.273915ms","start":"2026-06-30T08:57:56.65517Z","end":"2026-06-30T08:57:57.215444Z","steps":["trace[2091804519] 'agreement among raft nodes before linearized reading' (duration: 560.006146ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:57.215512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:56.655147Z","time spent":"560.356518ms","remote":"127.0.0.1:59280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-tgb2p\" "} {"level":"warn","ts":"2026-06-30T08:57:57.892493Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12423073021463192607,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T08:57:58.169226Z","caller":"traceutil/trace.go:171","msg":"trace[262717012] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"826.673448ms","start":"2026-06-30T08:57:57.342498Z","end":"2026-06-30T08:57:58.169171Z","steps":["trace[262717012] 'process raft request' (duration: 754.995896ms)","trace[262717012] 'compare' (duration: 71.34843ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:57:58.169379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:57.342475Z","time spent":"826.838793ms","remote":"127.0.0.1:59280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:57:58.169522Z","caller":"traceutil/trace.go:171","msg":"trace[2105136729] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"777.304359ms","start":"2026-06-30T08:57:57.392155Z","end":"2026-06-30T08:57:58.169459Z","steps":["trace[2105136729] 'read index received' (duration: 705.317307ms)","trace[2105136729] 'applied index is now lower than readState.Index' (duration: 71.982162ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:57:58.169685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.530158ms","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-06-30T08:57:58.169727Z","caller":"traceutil/trace.go:171","msg":"trace[1995366329] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:609; }","duration":"777.61282ms","start":"2026-06-30T08:57:57.3921Z","end":"2026-06-30T08:57:58.169713Z","steps":["trace[1995366329] 'agreement among raft nodes before linearized reading' (duration: 777.491455ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:58.169756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:57.39208Z","time spent":"777.669463ms","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-30T08:57:58.169778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.352769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:57:58.16983Z","caller":"traceutil/trace.go:171","msg":"trace[1147926872] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"503.454213ms","start":"2026-06-30T08:57:57.666358Z","end":"2026-06-30T08:57:58.169813Z","steps":["trace[1147926872] 'agreement among raft nodes before linearized reading' (duration: 503.37559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:58.169839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.030205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-30T08:57:58.169919Z","caller":"traceutil/trace.go:171","msg":"trace[1123864825] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:609; }","duration":"186.160819ms","start":"2026-06-30T08:57:57.983737Z","end":"2026-06-30T08:57:58.169898Z","steps":["trace[1123864825] 'agreement among raft nodes before linearized reading' (duration: 185.989144ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:58.169868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:57.666332Z","time spent":"503.527275ms","remote":"127.0.0.1:59084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-30T08:57:58.170091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.329174ms","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-06-30T08:57:58.170136Z","caller":"traceutil/trace.go:171","msg":"trace[570828135] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:609; }","duration":"191.436098ms","start":"2026-06-30T08:57:57.978687Z","end":"2026-06-30T08:57:58.170123Z","steps":["trace[570828135] 'agreement among raft nodes before linearized reading' (duration: 191.20537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:58.97569Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12423073021463192612,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T08:57:59.337973Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.146745694s","expected-duration":"1s"} {"level":"info","ts":"2026-06-30T08:57:59.385191Z","caller":"traceutil/trace.go:171","msg":"trace[1155201071] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:635; }","duration":"909.925922ms","start":"2026-06-30T08:57:58.475238Z","end":"2026-06-30T08:57:59.385164Z","steps":["trace[1155201071] 'read index received' (duration: 862.916297ms)","trace[1155201071] 'applied index is now lower than readState.Index' (duration: 47.008395ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:57:59.385395Z","caller":"traceutil/trace.go:171","msg":"trace[1064530330] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"1.211149441s","start":"2026-06-30T08:57:58.174167Z","end":"2026-06-30T08:57:59.385316Z","steps":["trace[1064530330] 'process raft request' (duration: 1.164064843s)","trace[1064530330] 'compare' (duration: 46.548349ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:57:59.385534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:58.174154Z","time spent":"1.211277105s","remote":"127.0.0.1:59170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:57:59.385765Z","caller":"traceutil/trace.go:171","msg":"trace[1756899261] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"1.210012033s","start":"2026-06-30T08:57:58.175718Z","end":"2026-06-30T08:57:59.38573Z","steps":["trace[1756899261] 'process raft request' (duration: 1.209359601s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:59.385967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:58.17566Z","time spent":"1.210219029s","remote":"127.0.0.1:59170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:57:59.386472Z","caller":"traceutil/trace.go:171","msg":"trace[1759446978] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"1.21082674s","start":"2026-06-30T08:57:58.175607Z","end":"2026-06-30T08:57:59.386434Z","steps":["trace[1759446978] 'process raft request' (duration: 1.209436923s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:59.386958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:58.175597Z","time spent":"1.211272635s","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T08:57:59.386529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.306496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.23\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-30T08:57:59.387823Z","caller":"traceutil/trace.go:171","msg":"trace[1925317394] range","detail":"{range_begin:/registry/masterleases/199.19.213.23; range_end:; response_count:1; response_revision:616; }","duration":"749.650062ms","start":"2026-06-30T08:57:58.638153Z","end":"2026-06-30T08:57:59.387803Z","steps":["trace[1925317394] 'agreement among raft nodes before linearized reading' (duration: 748.240784ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:59.386541Z","caller":"traceutil/trace.go:171","msg":"trace[1269848687] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"1.210923873s","start":"2026-06-30T08:57:58.175546Z","end":"2026-06-30T08:57:59.38647Z","steps":["trace[1269848687] 'process raft request' (duration: 1.209456223s)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:57:59.386564Z","caller":"traceutil/trace.go:171","msg":"trace[551506181] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"1.211091459s","start":"2026-06-30T08:57:58.175453Z","end":"2026-06-30T08:57:59.386544Z","steps":["trace[551506181] 'process raft request' (duration: 1.209471453s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:59.386606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"719.718753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:57:59.386627Z","caller":"traceutil/trace.go:171","msg":"trace[708691834] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"1.209016388s","start":"2026-06-30T08:57:58.177592Z","end":"2026-06-30T08:57:59.386609Z","steps":["trace[708691834] 'process raft request' (duration: 1.207519247s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:59.386635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.387591ms","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-06-30T08:57:59.388029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:58.638135Z","time spent":"749.87291ms","remote":"127.0.0.1:59116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.19.213.23\" "} {"level":"warn","ts":"2026-06-30T08:57:59.388961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:58.175538Z","time spent":"1.213384007s","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:57:59.389107Z","caller":"traceutil/trace.go:171","msg":"trace[1356330249] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:616; }","duration":"913.884476ms","start":"2026-06-30T08:57:58.475199Z","end":"2026-06-30T08:57:59.389084Z","steps":["trace[1356330249] 'agreement among raft nodes before linearized reading' (duration: 911.305019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:59.389172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:58.475181Z","time spent":"913.977229ms","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-30T08:57:59.389201Z","caller":"traceutil/trace.go:171","msg":"trace[313260510] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"722.331282ms","start":"2026-06-30T08:57:58.666852Z","end":"2026-06-30T08:57:59.389183Z","steps":["trace[313260510] 'agreement among raft nodes before linearized reading' (duration: 719.733343ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:57:59.389265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:58.666835Z","time spent":"722.414474ms","remote":"127.0.0.1:59084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-30T08:57:59.388863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:58.175443Z","time spent":"1.213319835s","remote":"127.0.0.1:59350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T08:57:59.389218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:57:58.177581Z","time spent":"1.211514033s","remote":"127.0.0.1:59280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:58:00.883815Z","caller":"traceutil/trace.go:171","msg":"trace[471409830] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"142.133192ms","start":"2026-06-30T08:58:00.741659Z","end":"2026-06-30T08:58:00.883792Z","steps":["trace[471409830] 'read index received' (duration: 141.595004ms)","trace[471409830] 'applied index is now lower than readState.Index' (duration: 537.558µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:58:00.883945Z","caller":"traceutil/trace.go:171","msg":"trace[163941619] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"147.459755ms","start":"2026-06-30T08:58:00.736453Z","end":"2026-06-30T08:58:00.883913Z","steps":["trace[163941619] 'process raft request' (duration: 146.792032ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:58:00.884163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.418082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:58:00.884201Z","caller":"traceutil/trace.go:171","msg":"trace[1006254896] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:633; }","duration":"142.559007ms","start":"2026-06-30T08:58:00.74163Z","end":"2026-06-30T08:58:00.884189Z","steps":["trace[1006254896] 'agreement among raft nodes before linearized reading' (duration: 142.265556ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:00.97148Z","caller":"traceutil/trace.go:171","msg":"trace[669193301] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"229.796052ms","start":"2026-06-30T08:58:00.741638Z","end":"2026-06-30T08:58:00.971434Z","steps":["trace[669193301] 'process raft request' (duration: 229.492361ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:58:00.971572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.798261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:58:00.971628Z","caller":"traceutil/trace.go:171","msg":"trace[696881745] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:635; }","duration":"229.901755ms","start":"2026-06-30T08:58:00.741711Z","end":"2026-06-30T08:58:00.971613Z","steps":["trace[696881745] 'agreement among raft nodes before linearized reading' (duration: 229.786881ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:00.971645Z","caller":"traceutil/trace.go:171","msg":"trace[1286720481] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"225.312168ms","start":"2026-06-30T08:58:00.746301Z","end":"2026-06-30T08:58:00.971614Z","steps":["trace[1286720481] 'process raft request' (duration: 225.074279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:58:01.402975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.086576ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-30T08:58:01.403084Z","caller":"traceutil/trace.go:171","msg":"trace[2064431379] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"473.742765ms","start":"2026-06-30T08:58:00.929307Z","end":"2026-06-30T08:58:01.403049Z","steps":["trace[2064431379] 'process raft request' (duration: 108.507535ms)","trace[2064431379] 'compare' (duration: 364.981002ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:58:01.403137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:58:00.929279Z","time spent":"473.836658ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:58:01.407669Z","caller":"traceutil/trace.go:171","msg":"trace[995240] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"435.035152ms","start":"2026-06-30T08:58:00.972595Z","end":"2026-06-30T08:58:01.407631Z","steps":["trace[995240] 'process raft request' (duration: 434.895816ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:01.407745Z","caller":"traceutil/trace.go:171","msg":"trace[1432528348] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"432.223136ms","start":"2026-06-30T08:58:00.975497Z","end":"2026-06-30T08:58:01.40772Z","steps":["trace[1432528348] 'process raft request' (duration: 432.091621ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:01.407762Z","caller":"traceutil/trace.go:171","msg":"trace[677385491] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"432.023348ms","start":"2026-06-30T08:58:00.975717Z","end":"2026-06-30T08:58:01.407741Z","steps":["trace[677385491] 'process raft request' (duration: 431.954106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:58:01.407859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:58:00.97256Z","time spent":"435.209537ms","remote":"127.0.0.1:59170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":722,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:58:01.407906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:58:00.975709Z","time spent":"432.112691ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4059,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T08:58:01.408112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:58:00.975482Z","time spent":"432.366071ms","remote":"127.0.0.1:59654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:58:01.411124Z","caller":"traceutil/trace.go:171","msg":"trace[445406093] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"272.447781ms","start":"2026-06-30T08:58:01.138652Z","end":"2026-06-30T08:58:01.4111Z","steps":["trace[445406093] 'process raft request' (duration: 271.969754ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:04.56543Z","caller":"traceutil/trace.go:171","msg":"trace[68366690] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"209.343882ms","start":"2026-06-30T08:58:04.356061Z","end":"2026-06-30T08:58:04.565405Z","steps":["trace[68366690] 'process raft request' (duration: 209.142295ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:04.646645Z","caller":"traceutil/trace.go:171","msg":"trace[2000852704] linearizableReadLoop","detail":"{readStateIndex:720; appliedIndex:718; }","duration":"119.216032ms","start":"2026-06-30T08:58:04.527401Z","end":"2026-06-30T08:58:04.646617Z","steps":["trace[2000852704] 'read index received' (duration: 37.69206ms)","trace[2000852704] 'applied index is now lower than readState.Index' (duration: 81.522732ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:58:04.646923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.503251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-06-30T08:58:04.64699Z","caller":"traceutil/trace.go:171","msg":"trace[595175623] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:692; }","duration":"119.622147ms","start":"2026-06-30T08:58:04.527348Z","end":"2026-06-30T08:58:04.64697Z","steps":["trace[595175623] 'agreement among raft nodes before linearized reading' (duration: 119.380848ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:04.647309Z","caller":"traceutil/trace.go:171","msg":"trace[1184454644] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"231.549328ms","start":"2026-06-30T08:58:04.415718Z","end":"2026-06-30T08:58:04.647268Z","steps":["trace[1184454644] 'process raft request' (duration: 230.75458ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:04.948461Z","caller":"traceutil/trace.go:171","msg":"trace[1827618073] linearizableReadLoop","detail":"{readStateIndex:721; appliedIndex:720; }","duration":"228.066557ms","start":"2026-06-30T08:58:04.720366Z","end":"2026-06-30T08:58:04.948432Z","steps":["trace[1827618073] 'read index received' (duration: 227.516828ms)","trace[1827618073] 'applied index is now lower than readState.Index' (duration: 548.479µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:58:04.948607Z","caller":"traceutil/trace.go:171","msg":"trace[328016634] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"300.740083ms","start":"2026-06-30T08:58:04.647817Z","end":"2026-06-30T08:58:04.948557Z","steps":["trace[328016634] 'process raft request' (duration: 300.174565ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:58:04.948713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.341418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tgb2p\" ","response":"range_response_count:1 size:18333"} {"level":"info","ts":"2026-06-30T08:58:04.948769Z","caller":"traceutil/trace.go:171","msg":"trace[137258470] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tgb2p; range_end:; response_count:1; response_revision:693; }","duration":"229.00285ms","start":"2026-06-30T08:58:04.719747Z","end":"2026-06-30T08:58:04.948749Z","steps":["trace[137258470] 'agreement among raft nodes before linearized reading' (duration: 228.823713ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:58:04.948839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:58:04.647794Z","time spent":"300.917591ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188228,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:58:05.075207Z","caller":"traceutil/trace.go:171","msg":"trace[1701200097] linearizableReadLoop","detail":"{readStateIndex:722; appliedIndex:721; }","duration":"126.645304ms","start":"2026-06-30T08:58:04.948539Z","end":"2026-06-30T08:58:05.075184Z","steps":["trace[1701200097] 'read index received' (duration: 124.474089ms)","trace[1701200097] 'applied index is now lower than readState.Index' (duration: 2.170325ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:58:05.07546Z","caller":"traceutil/trace.go:171","msg":"trace[331056564] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"352.864057ms","start":"2026-06-30T08:58:04.722381Z","end":"2026-06-30T08:58:05.075245Z","steps":["trace[331056564] 'process raft request' (duration: 350.546867ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:58:05.075649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.670182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-06-30T08:58:05.075681Z","caller":"traceutil/trace.go:171","msg":"trace[1739937466] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:694; }","duration":"348.743195ms","start":"2026-06-30T08:58:04.72693Z","end":"2026-06-30T08:58:05.075673Z","steps":["trace[1739937466] 'agreement among raft nodes before linearized reading' (duration: 348.567119ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:58:05.075692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:58:04.722358Z","time spent":"353.278992ms","remote":"127.0.0.1:59170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":761,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:58:05.075708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:58:04.726921Z","time spent":"348.780827ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":10399,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"warn","ts":"2026-06-30T08:58:05.07575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.821796ms","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":"warn","ts":"2026-06-30T08:58:05.075776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.131375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-06-30T08:58:05.075814Z","caller":"traceutil/trace.go:171","msg":"trace[494352948] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:694; }","duration":"174.919669ms","start":"2026-06-30T08:58:04.900875Z","end":"2026-06-30T08:58:05.075795Z","steps":["trace[494352948] 'agreement among raft nodes before linearized reading' (duration: 174.609749ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:05.0759Z","caller":"traceutil/trace.go:171","msg":"trace[1516683166] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:694; }","duration":"148.320381ms","start":"2026-06-30T08:58:04.927551Z","end":"2026-06-30T08:58:05.075871Z","steps":["trace[1516683166] 'agreement among raft nodes before linearized reading' (duration: 147.660269ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:05.166383Z","caller":"traceutil/trace.go:171","msg":"trace[225589970] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"203.596044ms","start":"2026-06-30T08:58:04.962758Z","end":"2026-06-30T08:58:05.166354Z","steps":["trace[225589970] 'process raft request' (duration: 203.339305ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:05.166718Z","caller":"traceutil/trace.go:171","msg":"trace[467223197] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"131.758614ms","start":"2026-06-30T08:58:05.034951Z","end":"2026-06-30T08:58:05.16671Z","steps":["trace[467223197] 'process raft request' (duration: 131.35803ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:05.305275Z","caller":"traceutil/trace.go:171","msg":"trace[162424625] linearizableReadLoop","detail":"{readStateIndex:725; appliedIndex:722; }","duration":"177.762575ms","start":"2026-06-30T08:58:05.127484Z","end":"2026-06-30T08:58:05.305247Z","steps":["trace[162424625] 'read index received' (duration: 38.706678ms)","trace[162424625] 'applied index is now lower than readState.Index' (duration: 139.054637ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:58:05.305315Z","caller":"traceutil/trace.go:171","msg":"trace[1666677143] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"225.38334ms","start":"2026-06-30T08:58:05.079889Z","end":"2026-06-30T08:58:05.305272Z","steps":["trace[1666677143] 'process raft request' (duration: 163.48973ms)","trace[1666677143] 'compare' (duration: 61.736935ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:58:05.305687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.181999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188495"} {"level":"info","ts":"2026-06-30T08:58:05.305776Z","caller":"traceutil/trace.go:171","msg":"trace[736002195] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:697; }","duration":"178.323514ms","start":"2026-06-30T08:58:05.127428Z","end":"2026-06-30T08:58:05.305752Z","steps":["trace[736002195] 'agreement among raft nodes before linearized reading' (duration: 177.94313ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:05.608516Z","caller":"traceutil/trace.go:171","msg":"trace[467800802] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"107.35772ms","start":"2026-06-30T08:58:05.501141Z","end":"2026-06-30T08:58:05.608498Z","steps":["trace[467800802] 'process raft request' (duration: 107.225846ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:05.609255Z","caller":"traceutil/trace.go:171","msg":"trace[1391533338] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"107.794676ms","start":"2026-06-30T08:58:05.501447Z","end":"2026-06-30T08:58:05.609242Z","steps":["trace[1391533338] 'process raft request' (duration: 107.561998ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:05.609594Z","caller":"traceutil/trace.go:171","msg":"trace[1902588930] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"108.111827ms","start":"2026-06-30T08:58:05.501472Z","end":"2026-06-30T08:58:05.609583Z","steps":["trace[1902588930] 'process raft request' (duration: 107.596409ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:58:15.664653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.928175ms","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-06-30T08:58:15.664855Z","caller":"traceutil/trace.go:171","msg":"trace[926250686] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:773; }","duration":"322.144943ms","start":"2026-06-30T08:58:15.342655Z","end":"2026-06-30T08:58:15.6648Z","steps":["trace[926250686] 'range keys from in-memory index tree' (duration: 321.781811ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:58:15.664925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:58:15.342637Z","time spent":"322.263827ms","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-30T08:58:15.861679Z","caller":"traceutil/trace.go:171","msg":"trace[237917779] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"193.471908ms","start":"2026-06-30T08:58:15.668182Z","end":"2026-06-30T08:58:15.861654Z","steps":["trace[237917779] 'process raft request' (duration: 193.191938ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:15.861858Z","caller":"traceutil/trace.go:171","msg":"trace[1019657081] linearizableReadLoop","detail":"{readStateIndex:806; appliedIndex:805; }","duration":"192.67124ms","start":"2026-06-30T08:58:15.66892Z","end":"2026-06-30T08:58:15.861591Z","steps":["trace[1019657081] 'read index received' (duration: 192.332498ms)","trace[1019657081] 'applied index is now lower than readState.Index' (duration: 337.722µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:58:15.861877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.93899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:58:15.861952Z","caller":"traceutil/trace.go:171","msg":"trace[1161137603] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:774; }","duration":"193.032983ms","start":"2026-06-30T08:58:15.668897Z","end":"2026-06-30T08:58:15.86193Z","steps":["trace[1161137603] 'agreement among raft nodes before linearized reading' (duration: 192.920038ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:15.870176Z","caller":"traceutil/trace.go:171","msg":"trace[924705707] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"201.073426ms","start":"2026-06-30T08:58:15.669074Z","end":"2026-06-30T08:58:15.870147Z","steps":["trace[924705707] 'process raft request' (duration: 200.728444ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:15.870434Z","caller":"traceutil/trace.go:171","msg":"trace[256665783] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"201.270973ms","start":"2026-06-30T08:58:15.669151Z","end":"2026-06-30T08:58:15.870422Z","steps":["trace[256665783] 'process raft request' (duration: 200.91047ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:15.870498Z","caller":"traceutil/trace.go:171","msg":"trace[571021928] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"199.763511ms","start":"2026-06-30T08:58:15.670707Z","end":"2026-06-30T08:58:15.87047Z","steps":["trace[571021928] 'process raft request' (duration: 199.384887ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:35.069695Z","caller":"traceutil/trace.go:171","msg":"trace[2039827684] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"155.031435ms","start":"2026-06-30T08:58:34.914646Z","end":"2026-06-30T08:58:35.069678Z","steps":["trace[2039827684] 'process raft request' (duration: 154.913441ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:36.298417Z","caller":"traceutil/trace.go:171","msg":"trace[80393574] linearizableReadLoop","detail":"{readStateIndex:1004; appliedIndex:1003; }","duration":"246.486358ms","start":"2026-06-30T08:58:36.051905Z","end":"2026-06-30T08:58:36.298392Z","steps":["trace[80393574] 'read index received' (duration: 246.281961ms)","trace[80393574] 'applied index is now lower than readState.Index' (duration: 203.437µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:58:36.29855Z","caller":"traceutil/trace.go:171","msg":"trace[1500603947] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"252.224008ms","start":"2026-06-30T08:58:36.046292Z","end":"2026-06-30T08:58:36.298516Z","steps":["trace[1500603947] 'process raft request' (duration: 251.942367ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:58:36.298721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.799579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-30T08:58:36.298776Z","caller":"traceutil/trace.go:171","msg":"trace[1427560659] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:968; }","duration":"246.902914ms","start":"2026-06-30T08:58:36.051858Z","end":"2026-06-30T08:58:36.298761Z","steps":["trace[1427560659] 'agreement among raft nodes before linearized reading' (duration: 246.672156ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:58:36.298866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.201482ms","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-06-30T08:58:36.298975Z","caller":"traceutil/trace.go:171","msg":"trace[1619768543] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:968; }","duration":"193.362277ms","start":"2026-06-30T08:58:36.105593Z","end":"2026-06-30T08:58:36.298956Z","steps":["trace[1619768543] 'agreement among raft nodes before linearized reading' (duration: 193.064427ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:58:36.29912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.41319ms","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-06-30T08:58:36.299255Z","caller":"traceutil/trace.go:171","msg":"trace[1087827690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:968; }","duration":"193.579296ms","start":"2026-06-30T08:58:36.105655Z","end":"2026-06-30T08:58:36.299234Z","steps":["trace[1087827690] 'agreement among raft nodes before linearized reading' (duration: 193.082698ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:58:53.944029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.05584ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-30T08:58:54.499373Z","caller":"traceutil/trace.go:171","msg":"trace[377590873] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"100.155128ms","start":"2026-06-30T08:58:54.399155Z","end":"2026-06-30T08:58:54.49931Z","steps":["trace[377590873] 'process raft request' (duration: 99.993552ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:54.619911Z","caller":"traceutil/trace.go:171","msg":"trace[975613959] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"220.40916ms","start":"2026-06-30T08:58:54.399482Z","end":"2026-06-30T08:58:54.619891Z","steps":["trace[975613959] 'process raft request' (duration: 217.950158ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:58:54.62007Z","caller":"traceutil/trace.go:171","msg":"trace[755473429] linearizableReadLoop","detail":"{readStateIndex:1075; appliedIndex:1073; }","duration":"219.492674ms","start":"2026-06-30T08:58:54.400551Z","end":"2026-06-30T08:58:54.620043Z","steps":["trace[755473429] 'read index received' (duration: 98.742006ms)","trace[755473429] 'applied index is now lower than readState.Index' (duration: 120.749118ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:58:54.620167Z","caller":"traceutil/trace.go:171","msg":"trace[414461247] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"220.519344ms","start":"2026-06-30T08:58:54.399621Z","end":"2026-06-30T08:58:54.62014Z","steps":["trace[414461247] 'process raft request' (duration: 220.202052ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:58:54.620262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.690292ms","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-06-30T08:58:54.620307Z","caller":"traceutil/trace.go:171","msg":"trace[579048541] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1034; }","duration":"219.769775ms","start":"2026-06-30T08:58:54.400526Z","end":"2026-06-30T08:58:54.620296Z","steps":["trace[579048541] 'agreement among raft nodes before linearized reading' (duration: 219.633469ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:58:54.620356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.938697ms","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-06-30T08:58:54.620387Z","caller":"traceutil/trace.go:171","msg":"trace[1123015206] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1034; }","duration":"101.00655ms","start":"2026-06-30T08:58:54.519371Z","end":"2026-06-30T08:58:54.620377Z","steps":["trace[1123015206] 'agreement among raft nodes before linearized reading' (duration: 100.915917ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:59:04.019644Z","caller":"traceutil/trace.go:171","msg":"trace[503211636] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"787.254741ms","start":"2026-06-30T08:59:03.232365Z","end":"2026-06-30T08:59:04.019619Z","steps":["trace[503211636] 'process raft request' (duration: 787.120917ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:59:04.019726Z","caller":"traceutil/trace.go:171","msg":"trace[413300309] linearizableReadLoop","detail":"{readStateIndex:1106; appliedIndex:1106; }","duration":"350.829456ms","start":"2026-06-30T08:59:03.668872Z","end":"2026-06-30T08:59:04.019702Z","steps":["trace[413300309] 'read index received' (duration: 350.820946ms)","trace[413300309] 'applied index is now lower than readState.Index' (duration: 7.19µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:59:04.019802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:59:03.232331Z","time spent":"787.385006ms","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T08:59:04.019867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.971623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:59:04.019901Z","caller":"traceutil/trace.go:171","msg":"trace[740287031] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1064; }","duration":"351.058215ms","start":"2026-06-30T08:59:03.668835Z","end":"2026-06-30T08:59:04.019894Z","steps":["trace[740287031] 'agreement among raft nodes before linearized reading' (duration: 350.941531ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:59:04.019931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:59:03.668822Z","time spent":"351.099407ms","remote":"127.0.0.1:59084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-30T08:59:26.854652Z","caller":"traceutil/trace.go:171","msg":"trace[1549076475] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"192.647031ms","start":"2026-06-30T08:59:26.66199Z","end":"2026-06-30T08:59:26.854637Z","steps":["trace[1549076475] 'process raft request' (duration: 192.547668ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T09:00:07.278374Z","caller":"traceutil/trace.go:171","msg":"trace[374596137] linearizableReadLoop","detail":"{readStateIndex:1361; appliedIndex:1359; }","duration":"108.464988ms","start":"2026-06-30T09:00:07.169876Z","end":"2026-06-30T09:00:07.278341Z","steps":["trace[374596137] 'read index received' (duration: 39.080726ms)","trace[374596137] 'applied index is now lower than readState.Index' (duration: 69.382582ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T09:00:07.278491Z","caller":"traceutil/trace.go:171","msg":"trace[1654235397] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"110.777551ms","start":"2026-06-30T09:00:07.167671Z","end":"2026-06-30T09:00:07.278448Z","steps":["trace[1654235397] 'process raft request' (duration: 41.238033ms)","trace[1654235397] 'compare' (duration: 67.188353ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T09:00:07.278671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.77214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-30T09:00:07.278716Z","caller":"traceutil/trace.go:171","msg":"trace[1592804869] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1305; }","duration":"108.918647ms","start":"2026-06-30T09:00:07.169785Z","end":"2026-06-30T09:00:07.278703Z","steps":["trace[1592804869] 'agreement among raft nodes before linearized reading' (duration: 108.696468ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T09:00:07.278723Z","caller":"traceutil/trace.go:171","msg":"trace[524472780] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"111.010871ms","start":"2026-06-30T09:00:07.167684Z","end":"2026-06-30T09:00:07.278695Z","steps":["trace[524472780] 'process raft request' (duration: 108.672787ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T09:00:15.447837Z","caller":"traceutil/trace.go:171","msg":"trace[855617093] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"107.624546ms","start":"2026-06-30T09:00:15.340182Z","end":"2026-06-30T09:00:15.447806Z","steps":["trace[855617093] 'process raft request' (duration: 55.511956ms)","trace[855617093] 'compare' (duration: 52.003596ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T09:00:15.705651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.622882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T09:00:15.705732Z","caller":"traceutil/trace.go:171","msg":"trace[133100291] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1339; }","duration":"156.716835ms","start":"2026-06-30T09:00:15.548998Z","end":"2026-06-30T09:00:15.705715Z","steps":["trace[133100291] 'count revisions from in-memory index tree' (duration: 156.538008ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T09:00:17.015203Z","caller":"traceutil/trace.go:171","msg":"trace[431590411] transaction","detail":"{read_only:false; response_revision:1345; number_of_response:1; }","duration":"112.85644ms","start":"2026-06-30T09:00:16.902315Z","end":"2026-06-30T09:00:17.015171Z","steps":["trace[431590411] 'process raft request' (duration: 112.669853ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T09:00:19.683769Z","caller":"traceutil/trace.go:171","msg":"trace[1878910067] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"208.044954ms","start":"2026-06-30T09:00:19.475702Z","end":"2026-06-30T09:00:19.683747Z","steps":["trace[1878910067] 'process raft request' (duration: 207.779414ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T09:00:21.797528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.15309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T09:00:21.797617Z","caller":"traceutil/trace.go:171","msg":"trace[982999326] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1364; }","duration":"122.301616ms","start":"2026-06-30T09:00:21.675298Z","end":"2026-06-30T09:00:21.797599Z","steps":["trace[982999326] 'range keys from in-memory index tree' (duration: 122.034175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T09:00:21.797838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.565472ms","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-06-30T09:00:21.798029Z","caller":"traceutil/trace.go:171","msg":"trace[1145565767] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1364; }","duration":"110.774281ms","start":"2026-06-30T09:00:21.687197Z","end":"2026-06-30T09:00:21.797971Z","steps":["trace[1145565767] 'range keys from in-memory index tree' (duration: 110.361143ms)"],"step_count":1}