{"level":"warn","ts":"2026-06-19T22:58:05.002088Z","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-19T22:58:05.002209Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.129:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.129:2380","--initial-cluster=instance=https://199.204.45.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.129: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-19T22:58:05.002299Z","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-19T22:58:05.002317Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-06-19T22:58:05.002343Z","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-19T22:58:05.003181Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"]} {"level":"info","ts":"2026-06-19T22:58:05.003279Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.129: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-19T22:58:05.007634Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.090328ms"} {"level":"info","ts":"2026-06-19T22:58:05.013315Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cec112083e8d3ff","cluster-id":"3f68255a3b440659"} {"level":"info","ts":"2026-06-19T22:58:05.013425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=()"} {"level":"info","ts":"2026-06-19T22:58:05.013447Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 0"} {"level":"info","ts":"2026-06-19T22:58:05.013466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cec112083e8d3ff [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-19T22:58:05.013479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 1"} {"level":"info","ts":"2026-06-19T22:58:05.013536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"warn","ts":"2026-06-19T22:58:05.020513Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-19T22:58:05.021979Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-19T22:58:05.022977Z","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-19T22:58:05.025266Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cec112083e8d3ff","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-19T22:58:05.02564Z","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-19T22:58:05.025729Z","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-19T22:58:05.02575Z","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-19T22:58:05.025884Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cec112083e8d3ff","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-19T22:58:05.02894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"info","ts":"2026-06-19T22:58:05.029317Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","added-peer-id":"3cec112083e8d3ff","added-peer-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-06-19T22:58:05.031516Z","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-19T22:58:05.031618Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-06-19T22:58:05.031645Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-06-19T22:58:05.031886Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cec112083e8d3ff","initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-19T22:58:05.031968Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-19T22:58:05.814647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff is starting a new election at term 1"} {"level":"info","ts":"2026-06-19T22:58:05.814715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became pre-candidate at term 1"} {"level":"info","ts":"2026-06-19T22:58:05.814759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgPreVoteResp from 3cec112083e8d3ff at term 1"} {"level":"info","ts":"2026-06-19T22:58:05.814779Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became candidate at term 2"} {"level":"info","ts":"2026-06-19T22:58:05.81484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgVoteResp from 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-06-19T22:58:05.814857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became leader at term 2"} {"level":"info","ts":"2026-06-19T22:58:05.814875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cec112083e8d3ff elected leader 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-06-19T22:58:05.816033Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cec112083e8d3ff","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.129:2379]}","request-path":"/0/members/3cec112083e8d3ff/attributes","cluster-id":"3f68255a3b440659","publish-timeout":"7s"} {"level":"info","ts":"2026-06-19T22:58:05.816057Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-19T22:58:05.816103Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-19T22:58:05.816061Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-19T22:58:05.817555Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-19T22:58:05.817624Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-19T22:58:05.818583Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","cluster-version":"3.5"} {"level":"info","ts":"2026-06-19T22:58:05.818716Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-19T22:58:05.818754Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-19T22:58:05.819219Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.129:2379"} {"level":"info","ts":"2026-06-19T22:58:05.820569Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-19T22:58:09.575621Z","caller":"traceutil/trace.go:171","msg":"trace[368214908] transaction","detail":"{read_only:false; response_revision:204; number_of_response:1; }","duration":"258.313281ms","start":"2026-06-19T22:58:09.317277Z","end":"2026-06-19T22:58:09.57559Z","steps":["trace[368214908] 'process raft request' (duration: 258.144106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:10.672013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.123046ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-19T22:58:10.672177Z","caller":"traceutil/trace.go:171","msg":"trace[687566605] transaction","detail":"{read_only:false; response_revision:206; number_of_response:1; }","duration":"498.856601ms","start":"2026-06-19T22:58:10.17328Z","end":"2026-06-19T22:58:10.672136Z","steps":["trace[687566605] 'process raft request' (duration: 498.82164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:10.672215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:10.173257Z","time spent":"498.943904ms","remote":"127.0.0.1:42876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-19T22:58:10.672628Z","caller":"traceutil/trace.go:171","msg":"trace[950683191] transaction","detail":"{read_only:false; response_revision:205; number_of_response:1; }","duration":"1.088742591s","start":"2026-06-19T22:58:09.583878Z","end":"2026-06-19T22:58:10.67262Z","steps":["trace[950683191] 'process raft request' (duration: 765.576637ms)","trace[950683191] 'compare' (duration: 322.002793ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T22:58:10.672657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:09.583862Z","time spent":"1.088782292s","remote":"127.0.0.1:42766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":525,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-19T22:58:10.672437Z","caller":"traceutil/trace.go:171","msg":"trace[205439866] linearizableReadLoop","detail":"{readStateIndex:209; appliedIndex:208; }","duration":"774.019541ms","start":"2026-06-19T22:58:09.898178Z","end":"2026-06-19T22:58:10.672198Z","steps":["trace[205439866] 'read index received' (duration: 451.36704ms)","trace[205439866] 'applied index is now lower than readState.Index' (duration: 322.648901ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T22:58:10.672901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"774.704919ms","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-19T22:58:10.673827Z","caller":"traceutil/trace.go:171","msg":"trace[1749622965] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:206; }","duration":"775.679865ms","start":"2026-06-19T22:58:09.898129Z","end":"2026-06-19T22:58:10.673809Z","steps":["trace[1749622965] 'agreement among raft nodes before linearized reading' (duration: 774.647047ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:10.673938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:09.898108Z","time spent":"775.811329ms","remote":"127.0.0.1:42954","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-19T22:58:10.673333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.163584ms","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-19T22:58:10.674158Z","caller":"traceutil/trace.go:171","msg":"trace[1260383792] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:206; }","duration":"173.014675ms","start":"2026-06-19T22:58:10.501116Z","end":"2026-06-19T22:58:10.674131Z","steps":["trace[1260383792] 'agreement among raft nodes before linearized reading' (duration: 172.169813ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:11.732392Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276103155017864953,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-19T22:58:11.886267Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.209045074s","expected-duration":"1s"} {"level":"info","ts":"2026-06-19T22:58:11.950864Z","caller":"traceutil/trace.go:171","msg":"trace[1504852050] linearizableReadLoop","detail":"{readStateIndex:214; appliedIndex:210; }","duration":"719.084291ms","start":"2026-06-19T22:58:11.231759Z","end":"2026-06-19T22:58:11.950843Z","steps":["trace[1504852050] 'read index received' (duration: 654.848094ms)","trace[1504852050] 'applied index is now lower than readState.Index' (duration: 64.235377ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T22:58:11.950902Z","caller":"traceutil/trace.go:171","msg":"trace[1839050008] transaction","detail":"{read_only:false; response_revision:208; number_of_response:1; }","duration":"1.273562098s","start":"2026-06-19T22:58:10.677308Z","end":"2026-06-19T22:58:11.95087Z","steps":["trace[1839050008] 'process raft request' (duration: 1.273400733s)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:58:11.951011Z","caller":"traceutil/trace.go:171","msg":"trace[781354093] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"676.11957ms","start":"2026-06-19T22:58:11.274865Z","end":"2026-06-19T22:58:11.950985Z","steps":["trace[781354093] 'process raft request' (duration: 675.946295ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:58:11.951012Z","caller":"traceutil/trace.go:171","msg":"trace[84780136] transaction","detail":"{read_only:false; response_revision:209; number_of_response:1; }","duration":"1.271970376s","start":"2026-06-19T22:58:10.679022Z","end":"2026-06-19T22:58:11.950992Z","steps":["trace[84780136] 'process raft request' (duration: 1.27175288s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:11.951053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:10.677303Z","time spent":"1.273684801s","remote":"127.0.0.1:42954","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-19T22:58:11.951104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"719.329637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-19T22:58:11.951127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:11.274849Z","time spent":"676.220792ms","remote":"127.0.0.1:42876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-19T22:58:11.951126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:10.678999Z","time spent":"1.272074268s","remote":"127.0.0.1:42766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11436,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-19T22:58:11.951144Z","caller":"traceutil/trace.go:171","msg":"trace[1776734800] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:210; }","duration":"719.40843ms","start":"2026-06-19T22:58:11.231724Z","end":"2026-06-19T22:58:11.951133Z","steps":["trace[1776734800] 'agreement among raft nodes before linearized reading' (duration: 719.323827ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:11.951179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:11.231707Z","time spent":"719.465031ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-19T22:58:11.951224Z","caller":"traceutil/trace.go:171","msg":"trace[1541006228] transaction","detail":"{read_only:false; response_revision:207; number_of_response:1; }","duration":"1.27402498s","start":"2026-06-19T22:58:10.677163Z","end":"2026-06-19T22:58:11.951187Z","steps":["trace[1541006228] 'process raft request' (duration: 1.209280289s)","trace[1541006228] 'compare' (duration: 62.82404ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T22:58:11.951302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:10.677153Z","time spent":"1.274114092s","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-19T22:58:11.951393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.552901ms","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-19T22:58:11.951452Z","caller":"traceutil/trace.go:171","msg":"trace[1879957127] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:210; }","duration":"548.654884ms","start":"2026-06-19T22:58:11.402781Z","end":"2026-06-19T22:58:11.951436Z","steps":["trace[1879957127] 'agreement among raft nodes before linearized reading' (duration: 548.547661ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:11.951495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:11.402766Z","time spent":"548.721105ms","remote":"127.0.0.1:42954","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-19T22:58:14.148363Z","caller":"traceutil/trace.go:171","msg":"trace[469091007] transaction","detail":"{read_only:false; number_of_response:0; response_revision:272; }","duration":"198.720588ms","start":"2026-06-19T22:58:13.94962Z","end":"2026-06-19T22:58:14.14834Z","steps":["trace[469091007] 'process raft request' (duration: 198.506312ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:58:14.148414Z","caller":"traceutil/trace.go:171","msg":"trace[2122498626] linearizableReadLoop","detail":"{readStateIndex:284; appliedIndex:281; }","duration":"182.441195ms","start":"2026-06-19T22:58:13.965957Z","end":"2026-06-19T22:58:14.148398Z","steps":["trace[2122498626] 'read index received' (duration: 42.628402ms)","trace[2122498626] 'applied index is now lower than readState.Index' (duration: 139.811603ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T22:58:14.148624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.013912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"} {"level":"warn","ts":"2026-06-19T22:58:14.148632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.373524ms","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-19T22:58:14.148659Z","caller":"traceutil/trace.go:171","msg":"trace[2065519360] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:274; }","duration":"139.082814ms","start":"2026-06-19T22:58:14.009568Z","end":"2026-06-19T22:58:14.148651Z","steps":["trace[2065519360] 'agreement among raft nodes before linearized reading' (duration: 139.000032ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:58:14.1486Z","caller":"traceutil/trace.go:171","msg":"trace[530496669] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"192.803281ms","start":"2026-06-19T22:58:13.955758Z","end":"2026-06-19T22:58:14.148561Z","steps":["trace[530496669] 'process raft request' (duration: 192.487092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:14.148769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.238347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-19T22:58:14.148796Z","caller":"traceutil/trace.go:171","msg":"trace[1611033622] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:274; }","duration":"180.285149ms","start":"2026-06-19T22:58:13.968504Z","end":"2026-06-19T22:58:14.148789Z","steps":["trace[1611033622] 'agreement among raft nodes before linearized reading' (duration: 180.201696ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:58:14.148506Z","caller":"traceutil/trace.go:171","msg":"trace[1276791803] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"181.82338ms","start":"2026-06-19T22:58:13.966671Z","end":"2026-06-19T22:58:14.148494Z","steps":["trace[1276791803] 'process raft request' (duration: 181.675986ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:14.149782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.815173ms","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-19T22:58:14.148684Z","caller":"traceutil/trace.go:171","msg":"trace[586562417] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:274; }","duration":"182.443706ms","start":"2026-06-19T22:58:13.966224Z","end":"2026-06-19T22:58:14.148668Z","steps":["trace[586562417] 'agreement among raft nodes before linearized reading' (duration: 182.341373ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:58:14.149965Z","caller":"traceutil/trace.go:171","msg":"trace[1360980480] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:274; }","duration":"183.957586ms","start":"2026-06-19T22:58:13.965927Z","end":"2026-06-19T22:58:14.149885Z","steps":["trace[1360980480] 'agreement among raft nodes before linearized reading' (duration: 182.669922ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:14.15057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.894045ms","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-19T22:58:14.150665Z","caller":"traceutil/trace.go:171","msg":"trace[1356301647] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:274; }","duration":"181.004898ms","start":"2026-06-19T22:58:13.969632Z","end":"2026-06-19T22:58:14.150637Z","steps":["trace[1356301647] 'agreement among raft nodes before linearized reading' (duration: 179.024615ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:14.531673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.478264ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-19T22:58:14.531942Z","caller":"traceutil/trace.go:171","msg":"trace[918920574] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"330.254772ms","start":"2026-06-19T22:58:14.20166Z","end":"2026-06-19T22:58:14.531915Z","steps":["trace[918920574] 'process raft request' (duration: 155.335046ms)","trace[918920574] 'compare' (duration: 174.364101ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T22:58:14.532051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:14.201645Z","time spent":"330.352754ms","remote":"127.0.0.1:42876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4311,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T22:58:14.531854Z","caller":"traceutil/trace.go:171","msg":"trace[1214229153] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"330.047036ms","start":"2026-06-19T22:58:14.201789Z","end":"2026-06-19T22:58:14.531836Z","steps":["trace[1214229153] 'process raft request' (duration: 329.995705ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:14.532595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:14.201762Z","time spent":"330.798396ms","remote":"127.0.0.1:42906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-19T22:58:14.809283Z","caller":"traceutil/trace.go:171","msg":"trace[586041022] linearizableReadLoop","detail":"{readStateIndex:293; appliedIndex:292; }","duration":"194.292231ms","start":"2026-06-19T22:58:14.614971Z","end":"2026-06-19T22:58:14.809263Z","steps":["trace[586041022] 'read index received' (duration: 144.056607ms)","trace[586041022] 'applied index is now lower than readState.Index' (duration: 50.234934ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T22:58:14.80948Z","caller":"traceutil/trace.go:171","msg":"trace[1351492883] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"267.692451ms","start":"2026-06-19T22:58:14.541749Z","end":"2026-06-19T22:58:14.809442Z","steps":["trace[1351492883] 'process raft request' (duration: 217.349824ms)","trace[1351492883] 'compare' (duration: 50.061809ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T22:58:14.809706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.420614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-06-19T22:58:14.809851Z","caller":"traceutil/trace.go:171","msg":"trace[2080133119] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:282; }","duration":"194.915497ms","start":"2026-06-19T22:58:14.614923Z","end":"2026-06-19T22:58:14.809838Z","steps":["trace[2080133119] 'agreement among raft nodes before linearized reading' (duration: 194.414164ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:58:20.455209Z","caller":"traceutil/trace.go:171","msg":"trace[1328504035] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"176.812747ms","start":"2026-06-19T22:58:20.27837Z","end":"2026-06-19T22:58:20.455182Z","steps":["trace[1328504035] 'process raft request' (duration: 167.989542ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:44.430947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.501222ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-19T22:58:44.431114Z","caller":"traceutil/trace.go:171","msg":"trace[1416253919] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"910.530124ms","start":"2026-06-19T22:58:43.520566Z","end":"2026-06-19T22:58:44.431096Z","steps":["trace[1416253919] 'process raft request' (duration: 771.773015ms)","trace[1416253919] 'compare' (duration: 138.284427ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T22:58:44.431237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:43.520544Z","time spent":"910.637497ms","remote":"127.0.0.1:42736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31121,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T22:58:44.444644Z","caller":"traceutil/trace.go:171","msg":"trace[671973408] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"919.614317ms","start":"2026-06-19T22:58:43.52501Z","end":"2026-06-19T22:58:44.444624Z","steps":["trace[671973408] 'process raft request' (duration: 919.397492ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:44.444794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:43.524991Z","time spent":"919.72467ms","remote":"127.0.0.1:42736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T22:58:44.44466Z","caller":"traceutil/trace.go:171","msg":"trace[1761350085] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"839.673873ms","start":"2026-06-19T22:58:43.604969Z","end":"2026-06-19T22:58:44.444643Z","steps":["trace[1761350085] 'process raft request' (duration: 839.557631ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:44.444939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:43.604925Z","time spent":"839.94914ms","remote":"127.0.0.1:42736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-19T22:58:44.477999Z","caller":"traceutil/trace.go:171","msg":"trace[835099347] linearizableReadLoop","detail":"{readStateIndex:535; appliedIndex:532; }","duration":"613.273782ms","start":"2026-06-19T22:58:43.864696Z","end":"2026-06-19T22:58:44.47797Z","steps":["trace[835099347] 'read index received' (duration: 427.731505ms)","trace[835099347] 'applied index is now lower than readState.Index' (duration: 185.539257ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T22:58:44.478252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.552479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T22:58:44.478316Z","caller":"traceutil/trace.go:171","msg":"trace[1811655106] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:518; }","duration":"613.680762ms","start":"2026-06-19T22:58:43.864624Z","end":"2026-06-19T22:58:44.478305Z","steps":["trace[1811655106] 'agreement among raft nodes before linearized reading' (duration: 613.500528ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:44.4784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:43.864604Z","time spent":"613.788705ms","remote":"127.0.0.1:42688","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-19T22:58:44.482188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.678594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-19T22:58:44.482249Z","caller":"traceutil/trace.go:171","msg":"trace[283669696] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:519; }","duration":"166.778847ms","start":"2026-06-19T22:58:44.315455Z","end":"2026-06-19T22:58:44.482234Z","steps":["trace[283669696] 'agreement among raft nodes before linearized reading' (duration: 166.694235ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:48.785672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.090825ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-19T22:58:48.786081Z","caller":"traceutil/trace.go:171","msg":"trace[883486574] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"464.561301ms","start":"2026-06-19T22:58:48.321375Z","end":"2026-06-19T22:58:48.785936Z","steps":["trace[883486574] 'process raft request' (duration: 332.127318ms)","trace[883486574] 'compare' (duration: 131.890669ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T22:58:48.786559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:48.32135Z","time spent":"464.94736ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T22:58:48.787144Z","caller":"traceutil/trace.go:171","msg":"trace[1675478615] linearizableReadLoop","detail":"{readStateIndex:591; appliedIndex:589; }","duration":"272.793021ms","start":"2026-06-19T22:58:48.514328Z","end":"2026-06-19T22:58:48.787121Z","steps":["trace[1675478615] 'read index received' (duration: 139.22078ms)","trace[1675478615] 'applied index is now lower than readState.Index' (duration: 133.571191ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T22:58:48.787402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.037697ms","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-19T22:58:48.787537Z","caller":"traceutil/trace.go:171","msg":"trace[1796899241] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:572; }","duration":"273.237881ms","start":"2026-06-19T22:58:48.514281Z","end":"2026-06-19T22:58:48.787519Z","steps":["trace[1796899241] 'agreement among raft nodes before linearized reading' (duration: 272.965635ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:48.787545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.399636ms","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-19T22:58:48.78764Z","caller":"traceutil/trace.go:171","msg":"trace[209305842] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:572; }","duration":"168.523469ms","start":"2026-06-19T22:58:48.619095Z","end":"2026-06-19T22:58:48.787618Z","steps":["trace[209305842] 'agreement among raft nodes before linearized reading' (duration: 168.307184ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:48.787533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.050828ms","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-19T22:58:48.787763Z","caller":"traceutil/trace.go:171","msg":"trace[209459979] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:572; }","duration":"271.342155ms","start":"2026-06-19T22:58:48.5164Z","end":"2026-06-19T22:58:48.787742Z","steps":["trace[209459979] 'agreement among raft nodes before linearized reading' (duration: 270.919565ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:48.787884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.509366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-19T22:58:48.787527Z","caller":"traceutil/trace.go:171","msg":"trace[1022792242] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"400.426666ms","start":"2026-06-19T22:58:48.386818Z","end":"2026-06-19T22:58:48.787244Z","steps":["trace[1022792242] 'process raft request' (duration: 399.525924ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:48.788425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:48.38679Z","time spent":"401.402009ms","remote":"127.0.0.1:42766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036157,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T22:58:48.788571Z","caller":"traceutil/trace.go:171","msg":"trace[348191205] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:572; }","duration":"268.808113ms","start":"2026-06-19T22:58:48.519329Z","end":"2026-06-19T22:58:48.788137Z","steps":["trace[348191205] 'agreement among raft nodes before linearized reading' (duration: 268.096025ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:58:51.193342Z","caller":"traceutil/trace.go:171","msg":"trace[12537677] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"146.414937ms","start":"2026-06-19T22:58:51.046895Z","end":"2026-06-19T22:58:51.19331Z","steps":["trace[12537677] 'process raft request' (duration: 146.189671ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:52.00436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.915729ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-19T22:58:52.005053Z","caller":"traceutil/trace.go:171","msg":"trace[1842599503] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:615; }","duration":"139.178959ms","start":"2026-06-19T22:58:51.86529Z","end":"2026-06-19T22:58:52.004468Z","steps":["trace[1842599503] 'read index received' (duration: 59.372µs)","trace[1842599503] 'applied index is now lower than readState.Index' (duration: 139.118167ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T22:58:52.005296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.971118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T22:58:52.00535Z","caller":"traceutil/trace.go:171","msg":"trace[1796409923] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:596; }","duration":"140.106101ms","start":"2026-06-19T22:58:51.865228Z","end":"2026-06-19T22:58:52.005334Z","steps":["trace[1796409923] 'agreement among raft nodes before linearized reading' (duration: 139.916096ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:58:52.005561Z","caller":"traceutil/trace.go:171","msg":"trace[47060881] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"478.210446ms","start":"2026-06-19T22:58:51.52731Z","end":"2026-06-19T22:58:52.00552Z","steps":["trace[47060881] 'process raft request' (duration: 308.053887ms)","trace[47060881] 'compare' (duration: 168.653182ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T22:58:52.005678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:51.527291Z","time spent":"478.329489ms","remote":"127.0.0.1:42940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-19T22:58:52.232027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.517357ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-19T22:58:52.232409Z","caller":"traceutil/trace.go:171","msg":"trace[2070309996] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"185.947567ms","start":"2026-06-19T22:58:52.046416Z","end":"2026-06-19T22:58:52.232363Z","steps":["trace[2070309996] 'process raft request' (duration: 185.779303ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:58:52.2325Z","caller":"traceutil/trace.go:171","msg":"trace[1188129948] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"185.880395ms","start":"2026-06-19T22:58:52.046609Z","end":"2026-06-19T22:58:52.232489Z","steps":["trace[1188129948] 'process raft request' (duration: 185.67476ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:58:52.232442Z","caller":"traceutil/trace.go:171","msg":"trace[1831008761] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"186.674495ms","start":"2026-06-19T22:58:52.045615Z","end":"2026-06-19T22:58:52.23229Z","steps":["trace[1831008761] 'process raft request' (duration: 59.82711ms)","trace[1831008761] 'compare' (duration: 125.855231ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T22:58:53.710468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"898.732475ms","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-19T22:58:53.71055Z","caller":"traceutil/trace.go:171","msg":"trace[1206052420] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:601; }","duration":"898.852618ms","start":"2026-06-19T22:58:52.811678Z","end":"2026-06-19T22:58:53.710531Z","steps":["trace[1206052420] 'range keys from in-memory index tree' (duration: 898.570371ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:53.710589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:52.81166Z","time spent":"898.92021ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-19T22:58:53.710724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"897.550436ms","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-19T22:58:53.710821Z","caller":"traceutil/trace.go:171","msg":"trace[1458299782] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:601; }","duration":"897.662669ms","start":"2026-06-19T22:58:52.813113Z","end":"2026-06-19T22:58:53.710776Z","steps":["trace[1458299782] 'range keys from in-memory index tree' (duration: 897.388812ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:53.710851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:52.813092Z","time spent":"897.752671ms","remote":"127.0.0.1:42954","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-19T22:58:53.710965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.09685ms","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-19T22:58:53.710988Z","caller":"traceutil/trace.go:171","msg":"trace[554571002] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:601; }","duration":"896.131791ms","start":"2026-06-19T22:58:52.81485Z","end":"2026-06-19T22:58:53.710982Z","steps":["trace[554571002] 'range keys from in-memory index tree' (duration: 896.039459ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:53.711004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:52.814843Z","time spent":"896.157511ms","remote":"127.0.0.1:42954","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-19T22:58:53.711042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"897.553256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-19T22:58:53.711196Z","caller":"traceutil/trace.go:171","msg":"trace[1819186643] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:601; }","duration":"897.652199ms","start":"2026-06-19T22:58:52.813448Z","end":"2026-06-19T22:58:53.7111Z","steps":["trace[1819186643] 'range keys from in-memory index tree' (duration: 897.402032ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:53.711258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:52.813441Z","time spent":"897.796402ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-19T22:58:53.726318Z","caller":"traceutil/trace.go:171","msg":"trace[763885630] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"157.469838ms","start":"2026-06-19T22:58:53.568828Z","end":"2026-06-19T22:58:53.726298Z","steps":["trace[763885630] 'process raft request' (duration: 157.268523ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:58:56.616087Z","caller":"traceutil/trace.go:171","msg":"trace[1137639440] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"235.044393ms","start":"2026-06-19T22:58:56.381016Z","end":"2026-06-19T22:58:56.61606Z","steps":["trace[1137639440] 'process raft request' (duration: 234.876489ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:58:56.700674Z","caller":"traceutil/trace.go:171","msg":"trace[1469815447] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"155.657553ms","start":"2026-06-19T22:58:56.544996Z","end":"2026-06-19T22:58:56.700653Z","steps":["trace[1469815447] 'process raft request' (duration: 155.618002ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:58:56.70083Z","caller":"traceutil/trace.go:171","msg":"trace[969361070] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"304.285164ms","start":"2026-06-19T22:58:56.396533Z","end":"2026-06-19T22:58:56.700818Z","steps":["trace[969361070] 'process raft request' (duration: 303.927025ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:58:56.70097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:58:56.396506Z","time spent":"304.344546ms","remote":"127.0.0.1:42736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10353,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T22:58:56.871187Z","caller":"traceutil/trace.go:171","msg":"trace[1757804734] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"125.759379ms","start":"2026-06-19T22:58:56.745403Z","end":"2026-06-19T22:58:56.871162Z","steps":["trace[1757804734] 'process raft request' (duration: 125.719458ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:58:56.871364Z","caller":"traceutil/trace.go:171","msg":"trace[1175355537] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"162.84693ms","start":"2026-06-19T22:58:56.708508Z","end":"2026-06-19T22:58:56.871355Z","steps":["trace[1175355537] 'process raft request' (duration: 162.488721ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:58:57.189485Z","caller":"traceutil/trace.go:171","msg":"trace[2143479411] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"118.320616ms","start":"2026-06-19T22:58:57.071139Z","end":"2026-06-19T22:58:57.189459Z","steps":["trace[2143479411] 'process raft request' (duration: 45.699133ms)","trace[2143479411] 'compare' (duration: 72.50404ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T22:58:57.194917Z","caller":"traceutil/trace.go:171","msg":"trace[1772883648] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"111.507679ms","start":"2026-06-19T22:58:57.083394Z","end":"2026-06-19T22:58:57.194901Z","steps":["trace[1772883648] 'process raft request' (duration: 111.207262ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:59:08.756728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.675462ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-19T22:59:08.756845Z","caller":"traceutil/trace.go:171","msg":"trace[164100177] linearizableReadLoop","detail":"{readStateIndex:778; appliedIndex:776; }","duration":"779.987989ms","start":"2026-06-19T22:59:07.976837Z","end":"2026-06-19T22:59:08.756825Z","steps":["trace[164100177] 'read index received' (duration: 6.673774ms)","trace[164100177] 'applied index is now lower than readState.Index' (duration: 773.312675ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T22:59:08.75709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.886986ms","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-19T22:59:08.757111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.259526ms","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-19T22:59:08.757188Z","caller":"traceutil/trace.go:171","msg":"trace[1191036464] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:754; }","duration":"780.407439ms","start":"2026-06-19T22:59:07.976758Z","end":"2026-06-19T22:59:08.757165Z","steps":["trace[1191036464] 'agreement among raft nodes before linearized reading' (duration: 780.160863ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:59:08.75724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.414247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7tk2b\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-06-19T22:59:08.757249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:59:07.976745Z","time spent":"780.490081ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-19T22:59:08.75732Z","caller":"traceutil/trace.go:171","msg":"trace[1317816302] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7tk2b; range_end:; response_count:1; response_revision:754; }","duration":"624.490679ms","start":"2026-06-19T22:59:08.132779Z","end":"2026-06-19T22:59:08.757269Z","steps":["trace[1317816302] 'agreement among raft nodes before linearized reading' (duration: 624.388606ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:59:08.757365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:59:08.132761Z","time spent":"624.594522ms","remote":"127.0.0.1:42876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7tk2b\" "} {"level":"info","ts":"2026-06-19T22:59:08.757134Z","caller":"traceutil/trace.go:171","msg":"trace[845260729] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:754; }","duration":"779.949647ms","start":"2026-06-19T22:59:07.977171Z","end":"2026-06-19T22:59:08.757121Z","steps":["trace[845260729] 'agreement among raft nodes before linearized reading' (duration: 779.754203ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:59:08.75754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:59:07.977148Z","time spent":"780.352658ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-19T22:59:08.757741Z","caller":"traceutil/trace.go:171","msg":"trace[1336592884] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"800.602195ms","start":"2026-06-19T22:59:07.956995Z","end":"2026-06-19T22:59:08.757597Z","steps":["trace[1336592884] 'process raft request' (duration: 477.96264ms)","trace[1336592884] 'compare' (duration: 321.083857ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T22:59:08.758156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:59:07.956981Z","time spent":"800.851682ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T22:59:12.424501Z","caller":"traceutil/trace.go:171","msg":"trace[540048662] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"113.914969ms","start":"2026-06-19T22:59:12.310562Z","end":"2026-06-19T22:59:12.424476Z","steps":["trace[540048662] 'process raft request' (duration: 55.809901ms)","trace[540048662] 'compare' (duration: 58.002575ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T22:59:12.706387Z","caller":"traceutil/trace.go:171","msg":"trace[1929372288] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"171.212705ms","start":"2026-06-19T22:59:12.535149Z","end":"2026-06-19T22:59:12.706361Z","steps":["trace[1929372288] 'process raft request' (duration: 136.666047ms)","trace[1929372288] 'compare' (duration: 34.049796ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T22:59:12.708248Z","caller":"traceutil/trace.go:171","msg":"trace[1081933933] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"172.526158ms","start":"2026-06-19T22:59:12.535664Z","end":"2026-06-19T22:59:12.708191Z","steps":["trace[1081933933] 'process raft request' (duration: 172.271042ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:59:12.87855Z","caller":"traceutil/trace.go:171","msg":"trace[2079760456] linearizableReadLoop","detail":"{readStateIndex:807; appliedIndex:806; }","duration":"106.019804ms","start":"2026-06-19T22:59:12.772511Z","end":"2026-06-19T22:59:12.87853Z","steps":["trace[2079760456] 'read index received' (duration: 88.858523ms)","trace[2079760456] 'applied index is now lower than readState.Index' (duration: 17.160511ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T22:59:12.878927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.398804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-19T22:59:12.878973Z","caller":"traceutil/trace.go:171","msg":"trace[445231052] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:781; }","duration":"106.494526ms","start":"2026-06-19T22:59:12.772466Z","end":"2026-06-19T22:59:12.878961Z","steps":["trace[445231052] 'agreement among raft nodes before linearized reading' (duration: 106.143177ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:59:12.878734Z","caller":"traceutil/trace.go:171","msg":"trace[641054128] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"165.70973ms","start":"2026-06-19T22:59:12.712997Z","end":"2026-06-19T22:59:12.878707Z","steps":["trace[641054128] 'process raft request' (duration: 148.417895ms)","trace[641054128] 'compare' (duration: 16.999658ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T22:59:13.196764Z","caller":"traceutil/trace.go:171","msg":"trace[1090200924] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"123.997196ms","start":"2026-06-19T22:59:13.072752Z","end":"2026-06-19T22:59:13.196749Z","steps":["trace[1090200924] 'process raft request' (duration: 123.810711ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:59:13.196763Z","caller":"traceutil/trace.go:171","msg":"trace[251262435] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"122.850618ms","start":"2026-06-19T22:59:13.073891Z","end":"2026-06-19T22:59:13.196742Z","steps":["trace[251262435] 'process raft request' (duration: 122.799386ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:59:23.566634Z","caller":"traceutil/trace.go:171","msg":"trace[898113939] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"146.364114ms","start":"2026-06-19T22:59:23.420252Z","end":"2026-06-19T22:59:23.566616Z","steps":["trace[898113939] 'process raft request' (duration: 146.254552ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:59:23.730798Z","caller":"traceutil/trace.go:171","msg":"trace[493070296] linearizableReadLoop","detail":"{readStateIndex:916; appliedIndex:914; }","duration":"153.07933ms","start":"2026-06-19T22:59:23.577682Z","end":"2026-06-19T22:59:23.730762Z","steps":["trace[493070296] 'read index received' (duration: 107.383088ms)","trace[493070296] 'applied index is now lower than readState.Index' (duration: 45.695102ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T22:59:23.730953Z","caller":"traceutil/trace.go:171","msg":"trace[1474052928] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"310.039534ms","start":"2026-06-19T22:59:23.420894Z","end":"2026-06-19T22:59:23.730933Z","steps":["trace[1474052928] 'process raft request' (duration: 264.23492ms)","trace[1474052928] 'compare' (duration: 45.398995ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T22:59:23.731064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:59:23.420874Z","time spent":"310.111166ms","remote":"127.0.0.1:42962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T22:59:23.731114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.410918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/kube-system/coredns-7c96b6546b-mn9b5\" ","response":"range_response_count:1 size:2276"} {"level":"info","ts":"2026-06-19T22:59:23.731183Z","caller":"traceutil/trace.go:171","msg":"trace[917771649] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/kube-system/coredns-7c96b6546b-mn9b5; range_end:; response_count:1; response_revision:888; }","duration":"153.512371ms","start":"2026-06-19T22:59:23.577652Z","end":"2026-06-19T22:59:23.731164Z","steps":["trace[917771649] 'agreement among raft nodes before linearized reading' (duration: 153.309896ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:59:23.732579Z","caller":"traceutil/trace.go:171","msg":"trace[266488758] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"309.44734ms","start":"2026-06-19T22:59:23.423095Z","end":"2026-06-19T22:59:23.732542Z","steps":["trace[266488758] 'process raft request' (duration: 307.597105ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:59:23.732775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:59:23.423086Z","time spent":"309.594163ms","remote":"127.0.0.1:43166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5192,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T22:59:23.866224Z","caller":"traceutil/trace.go:171","msg":"trace[2003051172] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"125.945164ms","start":"2026-06-19T22:59:23.740249Z","end":"2026-06-19T22:59:23.866195Z","steps":["trace[2003051172] 'process raft request' (duration: 125.726669ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:59:23.866235Z","caller":"traceutil/trace.go:171","msg":"trace[1327083473] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"121.818691ms","start":"2026-06-19T22:59:23.744396Z","end":"2026-06-19T22:59:23.866215Z","steps":["trace[1327083473] 'process raft request' (duration: 121.728159ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:59:23.866335Z","caller":"traceutil/trace.go:171","msg":"trace[1146434878] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"121.567916ms","start":"2026-06-19T22:59:23.744747Z","end":"2026-06-19T22:59:23.866315Z","steps":["trace[1146434878] 'process raft request' (duration: 121.424602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:59:24.309737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.207626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-mn9b5\" ","response":"range_response_count:1 size:5072"} {"level":"info","ts":"2026-06-19T22:59:24.309819Z","caller":"traceutil/trace.go:171","msg":"trace[1986932385] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-mn9b5; range_end:; response_count:1; response_revision:895; }","duration":"114.324128ms","start":"2026-06-19T22:59:24.195475Z","end":"2026-06-19T22:59:24.309799Z","steps":["trace[1986932385] 'range keys from in-memory index tree' (duration: 114.056642ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:59:24.843826Z","caller":"traceutil/trace.go:171","msg":"trace[883858512] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"124.003405ms","start":"2026-06-19T22:59:24.719799Z","end":"2026-06-19T22:59:24.843803Z","steps":["trace[883858512] 'process raft request' (duration: 123.860682ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:59:26.287583Z","caller":"traceutil/trace.go:171","msg":"trace[152298330] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"152.080406ms","start":"2026-06-19T22:59:26.135479Z","end":"2026-06-19T22:59:26.28756Z","steps":["trace[152298330] 'process raft request' (duration: 151.060331ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:59:42.163149Z","caller":"traceutil/trace.go:171","msg":"trace[276431085] linearizableReadLoop","detail":"{readStateIndex:992; appliedIndex:991; }","duration":"118.626725ms","start":"2026-06-19T22:59:42.044505Z","end":"2026-06-19T22:59:42.163132Z","steps":["trace[276431085] 'read index received' (duration: 118.495612ms)","trace[276431085] 'applied index is now lower than readState.Index' (duration: 130.093µs)"],"step_count":2} {"level":"info","ts":"2026-06-19T22:59:42.163252Z","caller":"traceutil/trace.go:171","msg":"trace[588218437] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"147.478249ms","start":"2026-06-19T22:59:42.015767Z","end":"2026-06-19T22:59:42.163245Z","steps":["trace[588218437] 'process raft request' (duration: 147.252744ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:59:42.163568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.046976ms","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-19T22:59:42.163638Z","caller":"traceutil/trace.go:171","msg":"trace[1161941659] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:960; }","duration":"119.122307ms","start":"2026-06-19T22:59:42.044498Z","end":"2026-06-19T22:59:42.16362Z","steps":["trace[1161941659] 'agreement among raft nodes before linearized reading' (duration: 118.971954ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:59:42.441322Z","caller":"traceutil/trace.go:171","msg":"trace[2100220925] linearizableReadLoop","detail":"{readStateIndex:997; appliedIndex:996; }","duration":"127.085579ms","start":"2026-06-19T22:59:42.314217Z","end":"2026-06-19T22:59:42.441302Z","steps":["trace[2100220925] 'read index received' (duration: 37.684977ms)","trace[2100220925] 'applied index is now lower than readState.Index' (duration: 89.399822ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T22:59:42.441344Z","caller":"traceutil/trace.go:171","msg":"trace[842568424] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"181.802096ms","start":"2026-06-19T22:59:42.259518Z","end":"2026-06-19T22:59:42.44132Z","steps":["trace[842568424] 'process raft request' (duration: 92.412694ms)","trace[842568424] 'compare' (duration: 89.213278ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T22:59:42.441574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.339325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:2929"} {"level":"info","ts":"2026-06-19T22:59:42.441646Z","caller":"traceutil/trace.go:171","msg":"trace[407711694] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:965; }","duration":"127.448988ms","start":"2026-06-19T22:59:42.31418Z","end":"2026-06-19T22:59:42.441629Z","steps":["trace[407711694] 'agreement among raft nodes before linearized reading' (duration: 127.217373ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:59:43.756483Z","caller":"traceutil/trace.go:171","msg":"trace[1298817840] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"493.425727ms","start":"2026-06-19T22:59:43.263033Z","end":"2026-06-19T22:59:43.756459Z","steps":["trace[1298817840] 'process raft request' (duration: 493.280794ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:59:43.756647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:59:43.263018Z","time spent":"493.55798ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T22:59:44.082177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.142013ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-19T22:59:44.082269Z","caller":"traceutil/trace.go:171","msg":"trace[683210016] linearizableReadLoop","detail":"{readStateIndex:1002; appliedIndex:1001; }","duration":"217.864394ms","start":"2026-06-19T22:59:43.864389Z","end":"2026-06-19T22:59:44.082253Z","steps":["trace[683210016] 'read index received' (duration: 49.891µs)","trace[683210016] 'applied index is now lower than readState.Index' (duration: 217.813463ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T22:59:44.082356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.976287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T22:59:44.082382Z","caller":"traceutil/trace.go:171","msg":"trace[134394641] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:969; }","duration":"218.041678ms","start":"2026-06-19T22:59:43.864332Z","end":"2026-06-19T22:59:44.082373Z","steps":["trace[134394641] 'agreement among raft nodes before linearized reading' (duration: 217.965576ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T22:59:44.082531Z","caller":"traceutil/trace.go:171","msg":"trace[1021031512] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"819.203068ms","start":"2026-06-19T22:59:43.26329Z","end":"2026-06-19T22:59:44.082493Z","steps":["trace[1021031512] 'process raft request' (duration: 543.673356ms)","trace[1021031512] 'compare' (duration: 275.048ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T22:59:44.082723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:59:43.263279Z","time spent":"819.359983ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T22:59:45.154723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"827.072456ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-19T22:59:45.154804Z","caller":"traceutil/trace.go:171","msg":"trace[220217360] linearizableReadLoop","detail":"{readStateIndex:1003; appliedIndex:1002; }","duration":"980.473849ms","start":"2026-06-19T22:59:44.174317Z","end":"2026-06-19T22:59:45.154791Z","steps":["trace[220217360] 'read index received' (duration: 153.362292ms)","trace[220217360] 'applied index is now lower than readState.Index' (duration: 827.110567ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T22:59:45.155212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"980.883159ms","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-19T22:59:45.155282Z","caller":"traceutil/trace.go:171","msg":"trace[764158693] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:969; }","duration":"981.000062ms","start":"2026-06-19T22:59:44.174264Z","end":"2026-06-19T22:59:45.155264Z","steps":["trace[764158693] 'agreement among raft nodes before linearized reading' (duration: 980.806017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:59:45.155321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:59:44.174245Z","time spent":"981.065764ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-19T22:59:45.158512Z","caller":"traceutil/trace.go:171","msg":"trace[590083532] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"711.73978ms","start":"2026-06-19T22:59:44.446749Z","end":"2026-06-19T22:59:45.158488Z","steps":["trace[590083532] 'process raft request' (duration: 711.587217ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:59:45.158723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:59:44.446713Z","time spent":"711.883064ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T22:59:45.159104Z","caller":"traceutil/trace.go:171","msg":"trace[1102870592] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"209.624266ms","start":"2026-06-19T22:59:44.949462Z","end":"2026-06-19T22:59:45.159087Z","steps":["trace[1102870592] 'process raft request' (duration: 209.39938ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:59:45.159139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.439541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-19T22:59:45.159208Z","caller":"traceutil/trace.go:171","msg":"trace[629188488] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:971; }","duration":"713.548874ms","start":"2026-06-19T22:59:44.44564Z","end":"2026-06-19T22:59:45.159189Z","steps":["trace[629188488] 'agreement among raft nodes before linearized reading' (duration: 713.35976ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T22:59:45.159258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T22:59:44.445621Z","time spent":"713.628406ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-19T22:59:45.159484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.01131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T22:59:45.159523Z","caller":"traceutil/trace.go:171","msg":"trace[726627167] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:971; }","duration":"295.085912ms","start":"2026-06-19T22:59:44.864426Z","end":"2026-06-19T22:59:45.159512Z","steps":["trace[726627167] 'agreement among raft nodes before linearized reading' (duration: 295.029541ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:10.092337Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276103155017866798,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-19T23:00:10.283115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.427645ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-19T23:00:10.283234Z","caller":"traceutil/trace.go:171","msg":"trace[1996908834] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"1.000380628s","start":"2026-06-19T23:00:09.28283Z","end":"2026-06-19T23:00:10.283211Z","steps":["trace[1996908834] 'process raft request' (duration: 885.762509ms)","trace[1996908834] 'compare' (duration: 114.306602ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:00:10.283313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:09.28281Z","time spent":"1.000462761s","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T23:00:10.291066Z","caller":"traceutil/trace.go:171","msg":"trace[476435068] linearizableReadLoop","detail":"{readStateIndex:1092; appliedIndex:1089; }","duration":"699.588458ms","start":"2026-06-19T23:00:09.591454Z","end":"2026-06-19T23:00:10.291043Z","steps":["trace[476435068] 'read index received' (duration: 577.12809ms)","trace[476435068] 'applied index is now lower than readState.Index' (duration: 122.459398ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T23:00:10.291169Z","caller":"traceutil/trace.go:171","msg":"trace[537196282] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"1.007371597s","start":"2026-06-19T23:00:09.283786Z","end":"2026-06-19T23:00:10.291157Z","steps":["trace[537196282] 'process raft request' (duration: 1.007215843s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:10.291269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.804464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:00:10.291217Z","caller":"traceutil/trace.go:171","msg":"trace[337152669] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"1.00749372s","start":"2026-06-19T23:00:09.283674Z","end":"2026-06-19T23:00:10.291168Z","steps":["trace[337152669] 'process raft request' (duration: 1.007206753s)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:10.291333Z","caller":"traceutil/trace.go:171","msg":"trace[1075180145] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1053; }","duration":"699.921947ms","start":"2026-06-19T23:00:09.591395Z","end":"2026-06-19T23:00:10.291317Z","steps":["trace[1075180145] 'agreement among raft nodes before linearized reading' (duration: 699.820234ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:10.291374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:09.591293Z","time spent":"700.0713ms","remote":"127.0.0.1:43178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-19T23:00:10.291577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:09.283658Z","time spent":"1.007841258s","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T23:00:10.29128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:09.283758Z","time spent":"1.007440449s","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T23:00:10.341332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.968506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:00:10.341404Z","caller":"traceutil/trace.go:171","msg":"trace[1106645900] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1054; }","duration":"476.078839ms","start":"2026-06-19T23:00:09.86531Z","end":"2026-06-19T23:00:10.341388Z","steps":["trace[1106645900] 'agreement among raft nodes before linearized reading' (duration: 475.952716ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:10.341431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:09.865275Z","time spent":"476.151231ms","remote":"127.0.0.1:42688","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-19T23:00:10.341647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.513285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-19T23:00:10.341691Z","caller":"traceutil/trace.go:171","msg":"trace[1595214594] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1054; }","duration":"320.597457ms","start":"2026-06-19T23:00:10.021067Z","end":"2026-06-19T23:00:10.341665Z","steps":["trace[1595214594] 'agreement among raft nodes before linearized reading' (duration: 320.559177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:10.341711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:10.021043Z","time spent":"320.662068ms","remote":"127.0.0.1:43170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":2,"response size":29,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"warn","ts":"2026-06-19T23:00:10.341863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.454658ms","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-19T23:00:10.341884Z","caller":"traceutil/trace.go:171","msg":"trace[1517097130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1054; }","duration":"454.51095ms","start":"2026-06-19T23:00:09.887368Z","end":"2026-06-19T23:00:10.341879Z","steps":["trace[1517097130] 'agreement among raft nodes before linearized reading' (duration: 454.430998ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:10.3419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:09.887351Z","time spent":"454.54566ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-19T23:00:10.844419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.208227ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-19T23:00:10.844554Z","caller":"traceutil/trace.go:171","msg":"trace[2030646660] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"500.152818ms","start":"2026-06-19T23:00:10.344371Z","end":"2026-06-19T23:00:10.844524Z","steps":["trace[2030646660] 'process raft request' (duration: 280.718606ms)","trace[2030646660] 'compare' (duration: 218.9093ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:00:10.844664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:10.344357Z","time spent":"500.259632ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T23:00:10.887226Z","caller":"traceutil/trace.go:171","msg":"trace[716287037] linearizableReadLoop","detail":"{readStateIndex:1095; appliedIndex:1094; }","duration":"240.96162ms","start":"2026-06-19T23:00:10.646249Z","end":"2026-06-19T23:00:10.88721Z","steps":["trace[716287037] 'read index received' (duration: 240.878858ms)","trace[716287037] 'applied index is now lower than readState.Index' (duration: 80.392µs)"],"step_count":2} {"level":"info","ts":"2026-06-19T23:00:10.887261Z","caller":"traceutil/trace.go:171","msg":"trace[111909577] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"542.012317ms","start":"2026-06-19T23:00:10.345228Z","end":"2026-06-19T23:00:10.887241Z","steps":["trace[111909577] 'process raft request' (duration: 541.898844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:10.887385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.101593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-19T23:00:10.88746Z","caller":"traceutil/trace.go:171","msg":"trace[368768270] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1056; }","duration":"241.254377ms","start":"2026-06-19T23:00:10.646191Z","end":"2026-06-19T23:00:10.887446Z","steps":["trace[368768270] 'agreement among raft nodes before linearized reading' (duration: 241.097044ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:10.887632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:10.345205Z","time spent":"542.108838ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T23:00:12.646651Z","caller":"traceutil/trace.go:171","msg":"trace[1197406417] linearizableReadLoop","detail":"{readStateIndex:1097; appliedIndex:1096; }","duration":"351.860229ms","start":"2026-06-19T23:00:12.294759Z","end":"2026-06-19T23:00:12.646619Z","steps":["trace[1197406417] 'read index received' (duration: 351.679775ms)","trace[1197406417] 'applied index is now lower than readState.Index' (duration: 178.874µs)"],"step_count":2} {"level":"info","ts":"2026-06-19T23:00:12.647165Z","caller":"traceutil/trace.go:171","msg":"trace[2036713920] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"355.6174ms","start":"2026-06-19T23:00:12.2915Z","end":"2026-06-19T23:00:12.647117Z","steps":["trace[2036713920] 'process raft request' (duration: 354.946814ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:12.64738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:12.29148Z","time spent":"355.782954ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T23:00:12.647501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.70625ms","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-19T23:00:12.647577Z","caller":"traceutil/trace.go:171","msg":"trace[1066730751] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1058; }","duration":"352.814072ms","start":"2026-06-19T23:00:12.294742Z","end":"2026-06-19T23:00:12.647556Z","steps":["trace[1066730751] 'agreement among raft nodes before linearized reading' (duration: 352.082244ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:12.647622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:12.294721Z","time spent":"352.891604ms","remote":"127.0.0.1:42954","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-19T23:00:12.647793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.516396ms","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-19T23:00:12.64787Z","caller":"traceutil/trace.go:171","msg":"trace[219779383] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1058; }","duration":"352.749611ms","start":"2026-06-19T23:00:12.295102Z","end":"2026-06-19T23:00:12.647852Z","steps":["trace[219779383] 'agreement among raft nodes before linearized reading' (duration: 352.136106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:12.647918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:12.295096Z","time spent":"352.808382ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-19T23:00:13.338744Z","caller":"traceutil/trace.go:171","msg":"trace[1172729714] linearizableReadLoop","detail":"{readStateIndex:1099; appliedIndex:1097; }","duration":"488.290383ms","start":"2026-06-19T23:00:12.850426Z","end":"2026-06-19T23:00:13.338716Z","steps":["trace[1172729714] 'read index received' (duration: 410.410738ms)","trace[1172729714] 'applied index is now lower than readState.Index' (duration: 77.878125ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T23:00:13.338926Z","caller":"traceutil/trace.go:171","msg":"trace[1066057504] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"683.897732ms","start":"2026-06-19T23:00:12.655005Z","end":"2026-06-19T23:00:13.338902Z","steps":["trace[1066057504] 'process raft request' (duration: 683.657116ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:13.339011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.577791ms","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-19T23:00:13.339048Z","caller":"traceutil/trace.go:171","msg":"trace[752635330] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1060; }","duration":"488.662053ms","start":"2026-06-19T23:00:12.850377Z","end":"2026-06-19T23:00:13.339039Z","steps":["trace[752635330] 'agreement among raft nodes before linearized reading' (duration: 488.53672ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:13.339046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:12.654971Z","time spent":"684.014545ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T23:00:13.339066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:12.850353Z","time spent":"488.708943ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-19T23:00:13.339046Z","caller":"traceutil/trace.go:171","msg":"trace[1854118566] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"685.462459ms","start":"2026-06-19T23:00:12.65356Z","end":"2026-06-19T23:00:13.339022Z","steps":["trace[1854118566] 'process raft request' (duration: 607.261227ms)","trace[1854118566] 'compare' (duration: 77.66435ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:00:13.339154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:12.653521Z","time spent":"685.574302ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T23:00:13.365832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.893647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:00:13.365905Z","caller":"traceutil/trace.go:171","msg":"trace[639191685] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1061; }","duration":"501.0114ms","start":"2026-06-19T23:00:12.864867Z","end":"2026-06-19T23:00:13.365879Z","steps":["trace[639191685] 'agreement among raft nodes before linearized reading' (duration: 500.887457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:13.36597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.592094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-19T23:00:13.365844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.445548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-19T23:00:13.366009Z","caller":"traceutil/trace.go:171","msg":"trace[839077912] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1061; }","duration":"474.681176ms","start":"2026-06-19T23:00:12.891317Z","end":"2026-06-19T23:00:13.365998Z","steps":["trace[839077912] 'agreement among raft nodes before linearized reading' (duration: 474.562043ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:13.366009Z","caller":"traceutil/trace.go:171","msg":"trace[644165544] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1061; }","duration":"336.667494ms","start":"2026-06-19T23:00:13.029332Z","end":"2026-06-19T23:00:13.366Z","steps":["trace[644165544] 'agreement among raft nodes before linearized reading' (duration: 336.456809ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:13.365974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:12.86486Z","time spent":"501.102712ms","remote":"127.0.0.1:42688","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-19T23:00:13.366075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:13.029303Z","time spent":"336.760236ms","remote":"127.0.0.1:42850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":3,"response size":29,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-06-19T23:00:13.366063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.348282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-19T23:00:13.366043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:12.891284Z","time spent":"474.745377ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-19T23:00:13.366187Z","caller":"traceutil/trace.go:171","msg":"trace[543112309] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1061; }","duration":"345.524017ms","start":"2026-06-19T23:00:13.020639Z","end":"2026-06-19T23:00:13.366163Z","steps":["trace[543112309] 'agreement among raft nodes before linearized reading' (duration: 345.220939ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:13.366259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:13.020592Z","time spent":"345.65625ms","remote":"127.0.0.1:43098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"info","ts":"2026-06-19T23:00:13.505056Z","caller":"traceutil/trace.go:171","msg":"trace[788256357] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"135.192444ms","start":"2026-06-19T23:00:13.369828Z","end":"2026-06-19T23:00:13.505021Z","steps":["trace[788256357] 'process raft request' (duration: 135.123362ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:13.505203Z","caller":"traceutil/trace.go:171","msg":"trace[1821487018] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"161.491427ms","start":"2026-06-19T23:00:13.343656Z","end":"2026-06-19T23:00:13.505148Z","steps":["trace[1821487018] 'process raft request' (duration: 126.654238ms)","trace[1821487018] 'compare' (duration: 34.423139ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T23:00:13.50531Z","caller":"traceutil/trace.go:171","msg":"trace[1819750121] linearizableReadLoop","detail":"{readStateIndex:1101; appliedIndex:1100; }","duration":"137.298135ms","start":"2026-06-19T23:00:13.367984Z","end":"2026-06-19T23:00:13.505282Z","steps":["trace[1819750121] 'read index received' (duration: 102.084228ms)","trace[1819750121] 'applied index is now lower than readState.Index' (duration: 35.201757ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:00:13.50543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.427718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:00:13.505506Z","caller":"traceutil/trace.go:171","msg":"trace[238371581] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1063; }","duration":"137.553821ms","start":"2026-06-19T23:00:13.367932Z","end":"2026-06-19T23:00:13.505486Z","steps":["trace[238371581] 'agreement among raft nodes before linearized reading' (duration: 137.442418ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:15.534102Z","caller":"traceutil/trace.go:171","msg":"trace[826934283] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"186.062919ms","start":"2026-06-19T23:00:15.348005Z","end":"2026-06-19T23:00:15.534068Z","steps":["trace[826934283] 'process raft request' (duration: 185.548846ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:15.534197Z","caller":"traceutil/trace.go:171","msg":"trace[1104569835] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"163.362672ms","start":"2026-06-19T23:00:15.370808Z","end":"2026-06-19T23:00:15.534171Z","steps":["trace[1104569835] 'process raft request' (duration: 163.070205ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:16.591813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.602932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-19T23:00:16.591897Z","caller":"traceutil/trace.go:171","msg":"trace[315320220] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1070; }","duration":"267.748415ms","start":"2026-06-19T23:00:16.324131Z","end":"2026-06-19T23:00:16.591879Z","steps":["trace[315320220] 'count revisions from in-memory index tree' (duration: 267.54442ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:16.59212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.947169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-19T23:00:16.592088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.82155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-19T23:00:16.592213Z","caller":"traceutil/trace.go:171","msg":"trace[1966154791] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1070; }","duration":"123.993205ms","start":"2026-06-19T23:00:16.468196Z","end":"2026-06-19T23:00:16.59219Z","steps":["trace[1966154791] 'count revisions from in-memory index tree' (duration: 123.761859ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:16.592189Z","caller":"traceutil/trace.go:171","msg":"trace[1152998639] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1070; }","duration":"280.061151ms","start":"2026-06-19T23:00:16.312115Z","end":"2026-06-19T23:00:16.592176Z","steps":["trace[1152998639] 'count revisions from in-memory index tree' (duration: 279.856697ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:17.015994Z","caller":"traceutil/trace.go:171","msg":"trace[1790557787] linearizableReadLoop","detail":"{readStateIndex:1111; appliedIndex:1110; }","duration":"150.019451ms","start":"2026-06-19T23:00:16.865949Z","end":"2026-06-19T23:00:17.015969Z","steps":["trace[1790557787] 'read index received' (duration: 149.902588ms)","trace[1790557787] 'applied index is now lower than readState.Index' (duration: 116.023µs)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:00:17.016215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.232666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:00:17.016303Z","caller":"traceutil/trace.go:171","msg":"trace[2094981263] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1071; }","duration":"150.376379ms","start":"2026-06-19T23:00:16.865894Z","end":"2026-06-19T23:00:17.016271Z","steps":["trace[2094981263] 'agreement among raft nodes before linearized reading' (duration: 150.210415ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:17.016055Z","caller":"traceutil/trace.go:171","msg":"trace[331346443] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"322.459331ms","start":"2026-06-19T23:00:16.69356Z","end":"2026-06-19T23:00:17.01602Z","steps":["trace[331346443] 'process raft request' (duration: 322.234916ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:17.016618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:16.693537Z","time spent":"322.981714ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T23:00:17.634966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.291955ms","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-19T23:00:17.635053Z","caller":"traceutil/trace.go:171","msg":"trace[359492013] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1071; }","duration":"191.413697ms","start":"2026-06-19T23:00:17.443621Z","end":"2026-06-19T23:00:17.635035Z","steps":["trace[359492013] 'range keys from in-memory index tree' (duration: 191.11134ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:18.068678Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276103155017866853,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-19T23:00:18.153274Z","caller":"traceutil/trace.go:171","msg":"trace[1960440914] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"613.401724ms","start":"2026-06-19T23:00:17.539837Z","end":"2026-06-19T23:00:18.153238Z","steps":["trace[1960440914] 'process raft request' (duration: 613.266801ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:18.153433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:17.53982Z","time spent":"613.525697ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T23:00:18.98706Z","caller":"traceutil/trace.go:171","msg":"trace[1173934557] linearizableReadLoop","detail":"{readStateIndex:1114; appliedIndex:1112; }","duration":"1.419307603s","start":"2026-06-19T23:00:17.567729Z","end":"2026-06-19T23:00:18.987037Z","steps":["trace[1173934557] 'read index received' (duration: 585.524394ms)","trace[1173934557] 'applied index is now lower than readState.Index' (duration: 833.782379ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T23:00:18.987119Z","caller":"traceutil/trace.go:171","msg":"trace[531094961] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"1.348201141s","start":"2026-06-19T23:00:17.638884Z","end":"2026-06-19T23:00:18.987086Z","steps":["trace[531094961] 'process raft request' (duration: 1.347953746s)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:18.987133Z","caller":"traceutil/trace.go:171","msg":"trace[1401035757] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"1.34812899s","start":"2026-06-19T23:00:17.638982Z","end":"2026-06-19T23:00:18.987111Z","steps":["trace[1401035757] 'process raft request' (duration: 1.348017717s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:18.987295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:17.63887Z","time spent":"1.348315804s","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T23:00:18.987361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.41961525s","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-19T23:00:18.987405Z","caller":"traceutil/trace.go:171","msg":"trace[1774427074] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1074; }","duration":"1.419715583s","start":"2026-06-19T23:00:17.567679Z","end":"2026-06-19T23:00:18.987395Z","steps":["trace[1774427074] 'agreement among raft nodes before linearized reading' (duration: 1.419503908s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:18.987445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:17.567658Z","time spent":"1.419779375s","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-19T23:00:18.987388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.234832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:00:18.987529Z","caller":"traceutil/trace.go:171","msg":"trace[1546106361] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1074; }","duration":"122.419157ms","start":"2026-06-19T23:00:18.865095Z","end":"2026-06-19T23:00:18.987515Z","steps":["trace[1546106361] 'agreement among raft nodes before linearized reading' (duration: 122.189181ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:18.987529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.931825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.129\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-19T23:00:18.987607Z","caller":"traceutil/trace.go:171","msg":"trace[1053314095] range","detail":"{range_begin:/registry/masterleases/199.204.45.129; range_end:; response_count:1; response_revision:1074; }","duration":"225.051848ms","start":"2026-06-19T23:00:18.762542Z","end":"2026-06-19T23:00:18.987594Z","steps":["trace[1053314095] 'agreement among raft nodes before linearized reading' (duration: 224.899884ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:18.98763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:17.638957Z","time spent":"1.348375955s","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T23:00:18.98793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.400335717s","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-19T23:00:18.988071Z","caller":"traceutil/trace.go:171","msg":"trace[2025813674] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1074; }","duration":"1.40049887s","start":"2026-06-19T23:00:17.587561Z","end":"2026-06-19T23:00:18.98806Z","steps":["trace[2025813674] 'agreement among raft nodes before linearized reading' (duration: 1.399720851s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:18.98811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:17.58755Z","time spent":"1.400550272s","remote":"127.0.0.1:42954","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-19T23:00:19.242036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.435767ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-06-19T23:00:19.242296Z","caller":"traceutil/trace.go:171","msg":"trace[1104401300] linearizableReadLoop","detail":"{readStateIndex:1117; appliedIndex:1114; }","duration":"222.384383ms","start":"2026-06-19T23:00:19.019899Z","end":"2026-06-19T23:00:19.242283Z","steps":["trace[1104401300] 'read index received' (duration: 99.71052ms)","trace[1104401300] 'applied index is now lower than readState.Index' (duration: 122.673223ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:00:19.242486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.584157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-19T23:00:19.242485Z","caller":"traceutil/trace.go:171","msg":"trace[884824150] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"250.144751ms","start":"2026-06-19T23:00:18.992319Z","end":"2026-06-19T23:00:19.242463Z","steps":["trace[884824150] 'process raft request' (duration: 249.863714ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:19.242555Z","caller":"traceutil/trace.go:171","msg":"trace[12928640] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1076; }","duration":"222.637189ms","start":"2026-06-19T23:00:19.019889Z","end":"2026-06-19T23:00:19.242526Z","steps":["trace[12928640] 'agreement among raft nodes before linearized reading' (duration: 222.488645ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:19.242658Z","caller":"traceutil/trace.go:171","msg":"trace[2132183070] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"250.035808ms","start":"2026-06-19T23:00:18.992594Z","end":"2026-06-19T23:00:19.24263Z","steps":["trace[2132183070] 'process raft request' (duration: 249.664999ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:27.499237Z","caller":"traceutil/trace.go:171","msg":"trace[287629050] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"214.630807ms","start":"2026-06-19T23:00:27.284584Z","end":"2026-06-19T23:00:27.499215Z","steps":["trace[287629050] 'process raft request' (duration: 214.501844ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:27.500454Z","caller":"traceutil/trace.go:171","msg":"trace[970929452] linearizableReadLoop","detail":"{readStateIndex:1145; appliedIndex:1143; }","duration":"212.768651ms","start":"2026-06-19T23:00:27.287672Z","end":"2026-06-19T23:00:27.500441Z","steps":["trace[970929452] 'read index received' (duration: 211.527991ms)","trace[970929452] 'applied index is now lower than readState.Index' (duration: 1.24003ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T23:00:27.500527Z","caller":"traceutil/trace.go:171","msg":"trace[1126270456] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"215.438946ms","start":"2026-06-19T23:00:27.285079Z","end":"2026-06-19T23:00:27.500518Z","steps":["trace[1126270456] 'process raft request' (duration: 215.295013ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:27.50075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.629299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-19T23:00:27.500798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.103169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-19T23:00:27.500822Z","caller":"traceutil/trace.go:171","msg":"trace[1099184920] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1103; }","duration":"195.751382ms","start":"2026-06-19T23:00:27.305052Z","end":"2026-06-19T23:00:27.500803Z","steps":["trace[1099184920] 'agreement among raft nodes before linearized reading' (duration: 195.483226ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:27.501097Z","caller":"traceutil/trace.go:171","msg":"trace[1753641596] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1103; }","duration":"213.338575ms","start":"2026-06-19T23:00:27.287667Z","end":"2026-06-19T23:00:27.501005Z","steps":["trace[1753641596] 'agreement among raft nodes before linearized reading' (duration: 212.926975ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:27.640636Z","caller":"traceutil/trace.go:171","msg":"trace[552929769] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"136.160397ms","start":"2026-06-19T23:00:27.504458Z","end":"2026-06-19T23:00:27.640618Z","steps":["trace[552929769] 'process raft request' (duration: 44.255495ms)","trace[552929769] 'compare' (duration: 91.81968ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:00:36.168542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.958693ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-19T23:00:36.168646Z","caller":"traceutil/trace.go:171","msg":"trace[2015450591] linearizableReadLoop","detail":"{readStateIndex:1227; appliedIndex:1225; }","duration":"579.97397ms","start":"2026-06-19T23:00:35.588656Z","end":"2026-06-19T23:00:36.16863Z","steps":["trace[2015450591] 'read index received' (duration: 44.176463ms)","trace[2015450591] 'applied index is now lower than readState.Index' (duration: 535.796446ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:00:36.169011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.346338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-19T23:00:36.169053Z","caller":"traceutil/trace.go:171","msg":"trace[1779112868] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1181; }","duration":"580.41981ms","start":"2026-06-19T23:00:35.588622Z","end":"2026-06-19T23:00:36.169041Z","steps":["trace[1779112868] 'agreement among raft nodes before linearized reading' (duration: 580.331608ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:36.169059Z","caller":"traceutil/trace.go:171","msg":"trace[2130109046] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"629.658166ms","start":"2026-06-19T23:00:35.539371Z","end":"2026-06-19T23:00:36.169029Z","steps":["trace[2130109046] 'process raft request' (duration: 306.130199ms)","trace[2130109046] 'compare' (duration: 322.842251ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:00:36.169086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:35.588609Z","time spent":"580.467431ms","remote":"127.0.0.1:42906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":45,"response size":29,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-06-19T23:00:36.169201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:35.539362Z","time spent":"629.763448ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T23:00:36.169033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.122675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-19T23:00:36.169489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.681318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:00:36.169536Z","caller":"traceutil/trace.go:171","msg":"trace[1291611772] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1181; }","duration":"305.75965ms","start":"2026-06-19T23:00:35.863763Z","end":"2026-06-19T23:00:36.169523Z","steps":["trace[1291611772] 'agreement among raft nodes before linearized reading' (duration: 305.684798ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:36.169566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:35.863746Z","time spent":"305.814211ms","remote":"127.0.0.1:42688","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-19T23:00:36.169354Z","caller":"traceutil/trace.go:171","msg":"trace[2050725674] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1181; }","duration":"460.477603ms","start":"2026-06-19T23:00:35.708857Z","end":"2026-06-19T23:00:36.169334Z","steps":["trace[2050725674] 'agreement among raft nodes before linearized reading' (duration: 459.993432ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:36.171143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:35.708842Z","time spent":"462.285667ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-19T23:00:37.666113Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276103155017867105,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-19T23:00:38.076639Z","caller":"traceutil/trace.go:171","msg":"trace[299818980] linearizableReadLoop","detail":"{readStateIndex:1231; appliedIndex:1230; }","duration":"911.18098ms","start":"2026-06-19T23:00:37.165439Z","end":"2026-06-19T23:00:38.07662Z","steps":["trace[299818980] 'read index received' (duration: 910.969535ms)","trace[299818980] 'applied index is now lower than readState.Index' (duration: 210.495µs)"],"step_count":2} {"level":"info","ts":"2026-06-19T23:00:38.076693Z","caller":"traceutil/trace.go:171","msg":"trace[319542210] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"916.268681ms","start":"2026-06-19T23:00:37.160388Z","end":"2026-06-19T23:00:38.076657Z","steps":["trace[319542210] 'process raft request' (duration: 916.105888ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:38.076829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.382225ms","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-19T23:00:38.076856Z","caller":"traceutil/trace.go:171","msg":"trace[1987850191] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1185; }","duration":"911.455806ms","start":"2026-06-19T23:00:37.165393Z","end":"2026-06-19T23:00:38.076849Z","steps":["trace[1987850191] 'agreement among raft nodes before linearized reading' (duration: 911.339143ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:38.076881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:37.165379Z","time spent":"911.496878ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-19T23:00:38.076881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:37.160356Z","time spent":"916.415655ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T23:00:38.076935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.062358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-19T23:00:38.07697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.603232ms","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-19T23:00:38.077023Z","caller":"traceutil/trace.go:171","msg":"trace[789508281] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1185; }","duration":"213.221833ms","start":"2026-06-19T23:00:37.863778Z","end":"2026-06-19T23:00:38.077Z","steps":["trace[789508281] 'agreement among raft nodes before linearized reading' (duration: 213.042198ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:38.077042Z","caller":"traceutil/trace.go:171","msg":"trace[1078022640] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1185; }","duration":"440.718255ms","start":"2026-06-19T23:00:37.636307Z","end":"2026-06-19T23:00:38.077025Z","steps":["trace[1078022640] 'agreement among raft nodes before linearized reading' (duration: 440.49379ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:38.077093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:37.636291Z","time spent":"440.793477ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-19T23:00:38.624491Z","caller":"traceutil/trace.go:171","msg":"trace[1280055094] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"543.084327ms","start":"2026-06-19T23:00:38.081385Z","end":"2026-06-19T23:00:38.624469Z","steps":["trace[1280055094] 'process raft request' (duration: 530.952031ms)","trace[1280055094] 'compare' (duration: 12.051964ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:00:38.624591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:38.08137Z","time spent":"543.173599ms","remote":"127.0.0.1:42954","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-19T23:00:38.639636Z","caller":"traceutil/trace.go:171","msg":"trace[1967181973] linearizableReadLoop","detail":"{readStateIndex:1233; appliedIndex:1231; }","duration":"466.116863ms","start":"2026-06-19T23:00:38.173498Z","end":"2026-06-19T23:00:38.639615Z","steps":["trace[1967181973] 'read index received' (duration: 438.854788ms)","trace[1967181973] 'applied index is now lower than readState.Index' (duration: 27.261165ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T23:00:38.639681Z","caller":"traceutil/trace.go:171","msg":"trace[1513824401] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"557.402836ms","start":"2026-06-19T23:00:38.082249Z","end":"2026-06-19T23:00:38.639652Z","steps":["trace[1513824401] 'process raft request' (duration: 557.212801ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:38.639777Z","caller":"traceutil/trace.go:171","msg":"trace[1031367461] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"357.702114ms","start":"2026-06-19T23:00:38.28206Z","end":"2026-06-19T23:00:38.639762Z","steps":["trace[1031367461] 'process raft request' (duration: 357.5225ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:38.639834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:38.082183Z","time spent":"557.56888ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T23:00:38.639896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.159678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-19T23:00:38.639916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:38.282037Z","time spent":"357.798676ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T23:00:38.639939Z","caller":"traceutil/trace.go:171","msg":"trace[1373220349] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1188; }","duration":"459.22703ms","start":"2026-06-19T23:00:38.180702Z","end":"2026-06-19T23:00:38.639929Z","steps":["trace[1373220349] 'agreement among raft nodes before linearized reading' (duration: 459.114568ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:38.639966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:38.18069Z","time spent":"459.270591ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-19T23:00:38.640071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.574034ms","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-19T23:00:38.640095Z","caller":"traceutil/trace.go:171","msg":"trace[674976838] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1188; }","duration":"466.638045ms","start":"2026-06-19T23:00:38.17345Z","end":"2026-06-19T23:00:38.640088Z","steps":["trace[674976838] 'agreement among raft nodes before linearized reading' (duration: 466.575044ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:38.640122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:38.173429Z","time spent":"466.687677ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-19T23:00:51.112322Z","caller":"traceutil/trace.go:171","msg":"trace[1361718066] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"381.002587ms","start":"2026-06-19T23:00:50.731273Z","end":"2026-06-19T23:00:51.112276Z","steps":["trace[1361718066] 'process raft request' (duration: 380.660129ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:51.112497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:50.731261Z","time spent":"381.13555ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T23:00:51.112823Z","caller":"traceutil/trace.go:171","msg":"trace[304175229] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"381.443998ms","start":"2026-06-19T23:00:50.731367Z","end":"2026-06-19T23:00:51.112811Z","steps":["trace[304175229] 'process raft request' (duration: 380.736991ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:51.1129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:50.731341Z","time spent":"381.521019ms","remote":"127.0.0.1:42954","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-19T23:00:51.112984Z","caller":"traceutil/trace.go:171","msg":"trace[755988540] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"381.57503ms","start":"2026-06-19T23:00:50.731381Z","end":"2026-06-19T23:00:51.112956Z","steps":["trace[755988540] 'process raft request' (duration: 381.156391ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:51.11316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:50.731359Z","time spent":"381.706844ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T23:00:51.113194Z","caller":"traceutil/trace.go:171","msg":"trace[2052704150] linearizableReadLoop","detail":"{readStateIndex:1279; appliedIndex:1275; }","duration":"381.720504ms","start":"2026-06-19T23:00:50.731445Z","end":"2026-06-19T23:00:51.113165Z","steps":["trace[2052704150] 'read index received' (duration: 24.927531ms)","trace[2052704150] 'applied index is now lower than readState.Index' (duration: 356.790673ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:00:51.113501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.900699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-19T23:00:51.113553Z","caller":"traceutil/trace.go:171","msg":"trace[904616110] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1230; }","duration":"382.107473ms","start":"2026-06-19T23:00:50.731429Z","end":"2026-06-19T23:00:51.113536Z","steps":["trace[904616110] 'agreement among raft nodes before linearized reading' (duration: 381.873298ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:51.113601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:50.731419Z","time spent":"382.169274ms","remote":"127.0.0.1:42948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":29,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"warn","ts":"2026-06-19T23:00:51.113795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.178877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:00:51.113852Z","caller":"traceutil/trace.go:171","msg":"trace[1890451810] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1231; }","duration":"109.259948ms","start":"2026-06-19T23:00:51.004575Z","end":"2026-06-19T23:00:51.113835Z","steps":["trace[1890451810] 'agreement among raft nodes before linearized reading' (duration: 109.158056ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:54.8245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.564124ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-19T23:00:54.824817Z","caller":"traceutil/trace.go:171","msg":"trace[1708477696] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"276.206215ms","start":"2026-06-19T23:00:54.548589Z","end":"2026-06-19T23:00:54.824795Z","steps":["trace[1708477696] 'process raft request' (duration: 276.137903ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:54.824884Z","caller":"traceutil/trace.go:171","msg":"trace[37777105] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"281.673494ms","start":"2026-06-19T23:00:54.5432Z","end":"2026-06-19T23:00:54.824874Z","steps":["trace[37777105] 'process raft request' (duration: 85.64954ms)","trace[37777105] 'compare' (duration: 195.452151ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T23:00:54.82487Z","caller":"traceutil/trace.go:171","msg":"trace[1060761505] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"280.409805ms","start":"2026-06-19T23:00:54.544428Z","end":"2026-06-19T23:00:54.824837Z","steps":["trace[1060761505] 'process raft request' (duration: 280.19413ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:54.839116Z","caller":"traceutil/trace.go:171","msg":"trace[808878918] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"101.771651ms","start":"2026-06-19T23:00:54.737312Z","end":"2026-06-19T23:00:54.839084Z","steps":["trace[808878918] 'process raft request' (duration: 101.605557ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:55.334664Z","caller":"traceutil/trace.go:171","msg":"trace[1111338441] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"203.838791ms","start":"2026-06-19T23:00:55.130811Z","end":"2026-06-19T23:00:55.33465Z","steps":["trace[1111338441] 'process raft request' (duration: 203.754409ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:56.137301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.123642ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-19T23:00:56.137553Z","caller":"traceutil/trace.go:171","msg":"trace[1050573454] linearizableReadLoop","detail":"{readStateIndex:1313; appliedIndex:1310; }","duration":"886.025792ms","start":"2026-06-19T23:00:55.251508Z","end":"2026-06-19T23:00:56.137534Z","steps":["trace[1050573454] 'read index received' (duration: 83.103529ms)","trace[1050573454] 'applied index is now lower than readState.Index' (duration: 802.921273ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:00:56.137677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"886.165636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:00:56.137711Z","caller":"traceutil/trace.go:171","msg":"trace[1712073796] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1263; }","duration":"886.207327ms","start":"2026-06-19T23:00:55.251492Z","end":"2026-06-19T23:00:56.1377Z","steps":["trace[1712073796] 'agreement among raft nodes before linearized reading' (duration: 886.140265ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:56.137745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:55.251431Z","time spent":"886.303609ms","remote":"127.0.0.1:51282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-19T23:00:56.137836Z","caller":"traceutil/trace.go:171","msg":"trace[452684056] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"1.00620609s","start":"2026-06-19T23:00:55.131593Z","end":"2026-06-19T23:00:56.137799Z","steps":["trace[452684056] 'process raft request' (duration: 588.480894ms)","trace[452684056] 'compare' (duration: 416.663951ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:00:56.13789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.3892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:00:56.13796Z","caller":"traceutil/trace.go:171","msg":"trace[2136168974] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1263; }","duration":"599.515043ms","start":"2026-06-19T23:00:55.538428Z","end":"2026-06-19T23:00:56.137943Z","steps":["trace[2136168974] 'agreement among raft nodes before linearized reading' (duration: 599.396291ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:56.13799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:55.131585Z","time spent":"1.006325363s","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T23:00:56.13801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:55.538404Z","time spent":"599.595176ms","remote":"127.0.0.1:51140","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"info","ts":"2026-06-19T23:00:56.137861Z","caller":"traceutil/trace.go:171","msg":"trace[3483651] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"1.005034082s","start":"2026-06-19T23:00:55.132784Z","end":"2026-06-19T23:00:56.137818Z","steps":["trace[3483651] 'process raft request' (duration: 1.004635543s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:56.138234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:55.132752Z","time spent":"1.005382201s","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T23:00:57.064778Z","caller":"traceutil/trace.go:171","msg":"trace[909864562] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"224.992891ms","start":"2026-06-19T23:00:56.839762Z","end":"2026-06-19T23:00:57.064755Z","steps":["trace[909864562] 'process raft request' (duration: 224.857488ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:57.809285Z","caller":"traceutil/trace.go:171","msg":"trace[379292331] linearizableReadLoop","detail":"{readStateIndex:1316; appliedIndex:1314; }","duration":"947.314365ms","start":"2026-06-19T23:00:56.861946Z","end":"2026-06-19T23:00:57.80926Z","steps":["trace[379292331] 'read index received' (duration: 202.660942ms)","trace[379292331] 'applied index is now lower than readState.Index' (duration: 744.652593ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T23:00:57.809425Z","caller":"traceutil/trace.go:171","msg":"trace[1783620663] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"965.487976ms","start":"2026-06-19T23:00:56.843891Z","end":"2026-06-19T23:00:57.809379Z","steps":["trace[1783620663] 'process raft request' (duration: 965.206599ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:57.809538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.951829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-19T23:00:57.809587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.324408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-19T23:00:57.809607Z","caller":"traceutil/trace.go:171","msg":"trace[549693532] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1266; }","duration":"574.070732ms","start":"2026-06-19T23:00:57.235518Z","end":"2026-06-19T23:00:57.809589Z","steps":["trace[549693532] 'agreement among raft nodes before linearized reading' (duration: 573.956429ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:57.809615Z","caller":"traceutil/trace.go:171","msg":"trace[1930792619] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1266; }","duration":"620.353738ms","start":"2026-06-19T23:00:57.189252Z","end":"2026-06-19T23:00:57.809606Z","steps":["trace[1930792619] 'agreement among raft nodes before linearized reading' (duration: 620.291347ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:57.809603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:56.84388Z","time spent":"965.631099ms","remote":"127.0.0.1:42954","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-19T23:00:57.809648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:57.189192Z","time spent":"620.44897ms","remote":"127.0.0.1:43218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":29,"response size":29,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"warn","ts":"2026-06-19T23:00:57.809744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.283886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-19T23:00:57.809771Z","caller":"traceutil/trace.go:171","msg":"trace[1366004898] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1266; }","duration":"471.359798ms","start":"2026-06-19T23:00:57.338406Z","end":"2026-06-19T23:00:57.809765Z","steps":["trace[1366004898] 'agreement among raft nodes before linearized reading' (duration: 471.258406ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:57.809746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"908.320561ms","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-19T23:00:57.80979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:57.33838Z","time spent":"471.404379ms","remote":"127.0.0.1:42954","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":"warn","ts":"2026-06-19T23:00:57.809869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.720693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:00:57.809896Z","caller":"traceutil/trace.go:171","msg":"trace[478398700] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1266; }","duration":"795.782525ms","start":"2026-06-19T23:00:57.014105Z","end":"2026-06-19T23:00:57.809888Z","steps":["trace[478398700] 'agreement among raft nodes before linearized reading' (duration: 795.741334ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:57.809917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:57.014089Z","time spent":"795.821206ms","remote":"127.0.0.1:51142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-06-19T23:00:57.809921Z","caller":"traceutil/trace.go:171","msg":"trace[110940153] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1266; }","duration":"908.440414ms","start":"2026-06-19T23:00:56.901362Z","end":"2026-06-19T23:00:57.809802Z","steps":["trace[110940153] 'agreement among raft nodes before linearized reading' (duration: 908.111236ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:57.809648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:57.235496Z","time spent":"574.142473ms","remote":"127.0.0.1:43830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-19T23:00:57.810338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:56.90135Z","time spent":"908.974876ms","remote":"127.0.0.1:42954","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":"warn","ts":"2026-06-19T23:00:57.810356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"948.38975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:00:57.810424Z","caller":"traceutil/trace.go:171","msg":"trace[1821063764] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1266; }","duration":"948.499013ms","start":"2026-06-19T23:00:56.861909Z","end":"2026-06-19T23:00:57.810408Z","steps":["trace[1821063764] 'agreement among raft nodes before linearized reading' (duration: 947.493999ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:57.810463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:56.861899Z","time spent":"948.554064ms","remote":"127.0.0.1:42688","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-19T23:00:58.154413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.936973ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-19T23:00:58.154596Z","caller":"traceutil/trace.go:171","msg":"trace[702751322] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"340.558799ms","start":"2026-06-19T23:00:57.814019Z","end":"2026-06-19T23:00:58.154578Z","steps":["trace[702751322] 'process raft request' (duration: 95.38276ms)","trace[702751322] 'compare' (duration: 244.79106ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:00:58.154676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:57.814002Z","time spent":"340.642171ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T23:00:58.154741Z","caller":"traceutil/trace.go:171","msg":"trace[354348271] linearizableReadLoop","detail":"{readStateIndex:1318; appliedIndex:1316; }","duration":"283.880606ms","start":"2026-06-19T23:00:57.870845Z","end":"2026-06-19T23:00:58.154725Z","steps":["trace[354348271] 'read index received' (duration: 38.573553ms)","trace[354348271] 'applied index is now lower than readState.Index' (duration: 245.303893ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:00:58.154879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.03933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:00:58.154893Z","caller":"traceutil/trace.go:171","msg":"trace[1368416693] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"340.691082ms","start":"2026-06-19T23:00:57.814178Z","end":"2026-06-19T23:00:58.154869Z","steps":["trace[1368416693] 'process raft request' (duration: 340.336284ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:58.154916Z","caller":"traceutil/trace.go:171","msg":"trace[1351969089] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1268; }","duration":"284.113132ms","start":"2026-06-19T23:00:57.870793Z","end":"2026-06-19T23:00:58.154906Z","steps":["trace[1351969089] 'agreement among raft nodes before linearized reading' (duration: 284.056631ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:58.155036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:57.814166Z","time spent":"340.794075ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T23:00:58.24933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.9654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-19T23:00:58.249374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.450411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-19T23:00:58.249423Z","caller":"traceutil/trace.go:171","msg":"trace[481501461] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1269; }","duration":"347.072313ms","start":"2026-06-19T23:00:57.902332Z","end":"2026-06-19T23:00:58.249405Z","steps":["trace[481501461] 'agreement among raft nodes before linearized reading' (duration: 346.905559ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:58.249457Z","caller":"traceutil/trace.go:171","msg":"trace[668603780] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1269; }","duration":"106.544624ms","start":"2026-06-19T23:00:58.142893Z","end":"2026-06-19T23:00:58.249437Z","steps":["trace[668603780] 'agreement among raft nodes before linearized reading' (duration: 106.319228ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:58.24947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:57.902311Z","time spent":"347.148095ms","remote":"127.0.0.1:51270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-19T23:00:58.249506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.020104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:00:58.24954Z","caller":"traceutil/trace.go:171","msg":"trace[395621287] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1269; }","duration":"166.101706ms","start":"2026-06-19T23:00:58.083432Z","end":"2026-06-19T23:00:58.249533Z","steps":["trace[395621287] 'agreement among raft nodes before linearized reading' (duration: 166.003094ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:00:58.249373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.485432ms","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-19T23:00:58.249625Z","caller":"traceutil/trace.go:171","msg":"trace[1365792974] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1269; }","duration":"106.80524ms","start":"2026-06-19T23:00:58.142811Z","end":"2026-06-19T23:00:58.249616Z","steps":["trace[1365792974] 'agreement among raft nodes before linearized reading' (duration: 106.40896ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:58.24939Z","caller":"traceutil/trace.go:171","msg":"trace[1432323825] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"165.981233ms","start":"2026-06-19T23:00:58.083376Z","end":"2026-06-19T23:00:58.249358Z","steps":["trace[1432323825] 'process raft request' (duration: 165.697036ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:00:58.406309Z","caller":"traceutil/trace.go:171","msg":"trace[527464279] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"152.76941ms","start":"2026-06-19T23:00:58.253418Z","end":"2026-06-19T23:00:58.406188Z","steps":["trace[527464279] 'process raft request' (duration: 82.856583ms)","trace[527464279] 'compare' (duration: 69.769073ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:01:00.100769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.294205892s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:01:00.100906Z","caller":"traceutil/trace.go:171","msg":"trace[1060921629] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1270; }","duration":"1.294346866s","start":"2026-06-19T23:00:58.806535Z","end":"2026-06-19T23:01:00.100882Z","steps":["trace[1060921629] 'range keys from in-memory index tree' (duration: 1.294188122s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:00.100982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.363200257s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-19T23:01:00.101169Z","caller":"traceutil/trace.go:171","msg":"trace[244872932] linearizableReadLoop","detail":"{readStateIndex:1322; appliedIndex:1320; }","duration":"1.335365987s","start":"2026-06-19T23:00:58.765788Z","end":"2026-06-19T23:01:00.101154Z","steps":["trace[244872932] 'read index received' (duration: 54.271µs)","trace[244872932] 'applied index is now lower than readState.Index' (duration: 1.335310566s)"],"step_count":2} {"level":"info","ts":"2026-06-19T23:01:00.101421Z","caller":"traceutil/trace.go:171","msg":"trace[1350655547] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"1.847159853s","start":"2026-06-19T23:00:58.25421Z","end":"2026-06-19T23:01:00.10137Z","steps":["trace[1350655547] 'process raft request' (duration: 1.846855846s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:00.101799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:58.254192Z","time spent":"1.847509042s","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T23:01:00.101464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.335676175s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.129\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-19T23:01:00.102286Z","caller":"traceutil/trace.go:171","msg":"trace[1424798084] range","detail":"{range_begin:/registry/masterleases/199.204.45.129; range_end:; response_count:1; response_revision:1272; }","duration":"1.336537345s","start":"2026-06-19T23:00:58.765736Z","end":"2026-06-19T23:01:00.102273Z","steps":["trace[1424798084] 'agreement among raft nodes before linearized reading' (duration: 1.335624723s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:00.102337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:58.765715Z","time spent":"1.336606717s","remote":"127.0.0.1:42728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.129\" "} {"level":"info","ts":"2026-06-19T23:01:00.101548Z","caller":"traceutil/trace.go:171","msg":"trace[664571805] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"1.847738507s","start":"2026-06-19T23:00:58.253796Z","end":"2026-06-19T23:01:00.101534Z","steps":["trace[664571805] 'process raft request' (duration: 483.909155ms)","trace[664571805] 'compare' (duration: 1.362982772s)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:01:00.102533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:58.253773Z","time spent":"1.84866092s","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T23:01:00.602272Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276103155017867301,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-19T23:01:00.863314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000561918s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-19T23:01:00.863416Z","caller":"traceutil/trace.go:171","msg":"trace[914093357] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000712881s","start":"2026-06-19T23:00:58.862686Z","end":"2026-06-19T23:01:00.863399Z","steps":["trace[914093357] 'agreement among raft nodes before linearized reading' (duration: 2.000589398s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:00.863463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:58.862669Z","time spent":"2.000784663s","remote":"127.0.0.1:42700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/19 23:01:00 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-19T23:01:01.50582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"878.611588ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-19T23:01:01.506052Z","caller":"traceutil/trace.go:171","msg":"trace[1395694244] linearizableReadLoop","detail":"{readStateIndex:1324; appliedIndex:1322; }","duration":"1.404819545s","start":"2026-06-19T23:01:00.101209Z","end":"2026-06-19T23:01:01.506028Z","steps":["trace[1395694244] 'read index received' (duration: 525.928981ms)","trace[1395694244] 'applied index is now lower than readState.Index' (duration: 878.889474ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:01:01.506105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:01:00.103078Z","time spent":"1.403022392s","remote":"127.0.0.1:42728","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-19T23:01:01.506134Z","caller":"traceutil/trace.go:171","msg":"trace[433565306] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"1.691220789s","start":"2026-06-19T23:00:59.814876Z","end":"2026-06-19T23:01:01.506097Z","steps":["trace[433565306] 'process raft request' (duration: 812.246572ms)","trace[433565306] 'compare' (duration: 878.285051ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:01:01.506329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:00:59.814852Z","time spent":"1.691354003s","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T23:01:01.568483Z","caller":"traceutil/trace.go:171","msg":"trace[1225169180] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"702.177468ms","start":"2026-06-19T23:01:00.866288Z","end":"2026-06-19T23:01:01.568465Z","steps":["trace[1225169180] 'process raft request' (duration: 702.087416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:01.568585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:01:00.866251Z","time spent":"702.28797ms","remote":"127.0.0.1:42752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-19T23:01:01.996387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.024ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-19T23:01:01.996681Z","caller":"traceutil/trace.go:171","msg":"trace[1707393007] linearizableReadLoop","detail":"{readStateIndex:1326; appliedIndex:1325; }","duration":"490.574433ms","start":"2026-06-19T23:01:01.506089Z","end":"2026-06-19T23:01:01.996663Z","steps":["trace[1707393007] 'read index received' (duration: 62.403098ms)","trace[1707393007] 'applied index is now lower than readState.Index' (duration: 428.170295ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T23:01:01.99668Z","caller":"traceutil/trace.go:171","msg":"trace[1094372671] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"510.739481ms","start":"2026-06-19T23:01:01.485914Z","end":"2026-06-19T23:01:01.996654Z","steps":["trace[1094372671] 'process raft request' (duration: 318.347953ms)","trace[1094372671] 'compare' (duration: 191.777804ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T23:01:01.996744Z","caller":"traceutil/trace.go:171","msg":"trace[363793789] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"489.039137ms","start":"2026-06-19T23:01:01.507686Z","end":"2026-06-19T23:01:01.996725Z","steps":["trace[363793789] 'process raft request' (duration: 488.877983ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:01.996789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:01:01.485895Z","time spent":"510.836704ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T23:01:01.996811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.12897693s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-19T23:01:01.996887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.837728952s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-19T23:01:01.996908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.837964528s","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-19T23:01:01.996847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:01:01.507658Z","time spent":"489.131689ms","remote":"127.0.0.1:42728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T23:01:01.996925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.585335852s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-19T23:01:01.996943Z","caller":"traceutil/trace.go:171","msg":"trace[1698624822] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1276; }","duration":"1.837810964s","start":"2026-06-19T23:01:00.159118Z","end":"2026-06-19T23:01:01.996929Z","steps":["trace[1698624822] 'agreement among raft nodes before linearized reading' (duration: 1.837606489s)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:01:01.996907Z","caller":"traceutil/trace.go:171","msg":"trace[1647300703] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1276; }","duration":"1.129127594s","start":"2026-06-19T23:01:00.867761Z","end":"2026-06-19T23:01:01.996889Z","steps":["trace[1647300703] 'agreement among raft nodes before linearized reading' (duration: 1.12895303s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:01.996983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:01:00.159112Z","time spent":"1.837862825s","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-19T23:01:01.996993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:01:00.867734Z","time spent":"1.129249877s","remote":"127.0.0.1:42688","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-19T23:01:01.996949Z","caller":"traceutil/trace.go:171","msg":"trace[587243397] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1276; }","duration":"1.83804542s","start":"2026-06-19T23:01:00.158893Z","end":"2026-06-19T23:01:01.996939Z","steps":["trace[587243397] 'agreement among raft nodes before linearized reading' (duration: 1.837826565s)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:01:01.996985Z","caller":"traceutil/trace.go:171","msg":"trace[309210399] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1276; }","duration":"1.585438045s","start":"2026-06-19T23:01:00.411534Z","end":"2026-06-19T23:01:01.996972Z","steps":["trace[309210399] 'agreement among raft nodes before linearized reading' (duration: 1.585190119s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:01.997349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:01:00.411512Z","time spent":"1.585823503s","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-19T23:01:01.997712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:01:00.158874Z","time spent":"1.838264655s","remote":"127.0.0.1:42954","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-19T23:01:02.133229Z","caller":"traceutil/trace.go:171","msg":"trace[908590599] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"132.50575ms","start":"2026-06-19T23:01:02.000701Z","end":"2026-06-19T23:01:02.133206Z","steps":["trace[908590599] 'process raft request' (duration: 132.387647ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:02.133494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.281535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-19T23:01:02.133577Z","caller":"traceutil/trace.go:171","msg":"trace[253767684] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1277; }","duration":"132.410537ms","start":"2026-06-19T23:01:02.00115Z","end":"2026-06-19T23:01:02.133561Z","steps":["trace[253767684] 'agreement among raft nodes before linearized reading' (duration: 132.210852ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:01:02.133442Z","caller":"traceutil/trace.go:171","msg":"trace[260838032] linearizableReadLoop","detail":"{readStateIndex:1328; appliedIndex:1328; }","duration":"132.09912ms","start":"2026-06-19T23:01:02.001173Z","end":"2026-06-19T23:01:02.133272Z","steps":["trace[260838032] 'read index received' (duration: 132.08175ms)","trace[260838032] 'applied index is now lower than readState.Index' (duration: 14.68µs)"],"step_count":2} {"level":"info","ts":"2026-06-19T23:01:02.149302Z","caller":"traceutil/trace.go:171","msg":"trace[2111036687] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"147.404413ms","start":"2026-06-19T23:01:02.001874Z","end":"2026-06-19T23:01:02.149279Z","steps":["trace[2111036687] 'process raft request' (duration: 147.248169ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:01:02.149578Z","caller":"traceutil/trace.go:171","msg":"trace[1460929595] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"147.394043ms","start":"2026-06-19T23:01:02.002155Z","end":"2026-06-19T23:01:02.149549Z","steps":["trace[1460929595] 'process raft request' (duration: 147.086226ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:02.149622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.779331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:01:02.149874Z","caller":"traceutil/trace.go:171","msg":"trace[1104958266] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1279; }","duration":"145.049347ms","start":"2026-06-19T23:01:02.0048Z","end":"2026-06-19T23:01:02.149849Z","steps":["trace[1104958266] 'agreement among raft nodes before linearized reading' (duration: 144.684378ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:01:02.58653Z","caller":"traceutil/trace.go:171","msg":"trace[1524748475] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"133.585226ms","start":"2026-06-19T23:01:02.452916Z","end":"2026-06-19T23:01:02.586501Z","steps":["trace[1524748475] 'process raft request' (duration: 106.32243ms)","trace[1524748475] 'compare' (duration: 27.143823ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T23:01:03.673118Z","caller":"traceutil/trace.go:171","msg":"trace[273430257] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"161.710181ms","start":"2026-06-19T23:01:03.511387Z","end":"2026-06-19T23:01:03.673097Z","steps":["trace[273430257] 'process raft request' (duration: 161.584148ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:03.985703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.478945ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-19T23:01:03.985901Z","caller":"traceutil/trace.go:171","msg":"trace[695989916] linearizableReadLoop","detail":"{readStateIndex:1340; appliedIndex:1339; }","duration":"121.5283ms","start":"2026-06-19T23:01:03.864347Z","end":"2026-06-19T23:01:03.985876Z","steps":["trace[695989916] 'read index received' (duration: 8.793639ms)","trace[695989916] 'applied index is now lower than readState.Index' (duration: 112.732461ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:01:03.986057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.698264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:01:03.986181Z","caller":"traceutil/trace.go:171","msg":"trace[1434086428] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1288; }","duration":"121.860348ms","start":"2026-06-19T23:01:03.8643Z","end":"2026-06-19T23:01:03.98616Z","steps":["trace[1434086428] 'agreement among raft nodes before linearized reading' (duration: 121.694184ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:08.064046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.873773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-06-19T23:01:08.064139Z","caller":"traceutil/trace.go:171","msg":"trace[957232393] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1307; }","duration":"473.014936ms","start":"2026-06-19T23:01:07.591102Z","end":"2026-06-19T23:01:08.064117Z","steps":["trace[957232393] 'range keys from in-memory index tree' (duration: 472.682928ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:08.064243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:01:07.591079Z","time spent":"473.14875ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-19T23:01:08.364765Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276103155017867375,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-19T23:01:08.865292Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276103155017867375,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-19T23:01:09.365899Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276103155017867375,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-19T23:01:09.864909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000372783s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-19T23:01:09.865104Z","caller":"traceutil/trace.go:171","msg":"trace[257311094] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000606509s","start":"2026-06-19T23:01:07.864464Z","end":"2026-06-19T23:01:09.86507Z","steps":["trace[257311094] 'agreement among raft nodes before linearized reading' (duration: 2.000404444s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:09.865175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:01:07.864448Z","time spent":"2.000712361s","remote":"127.0.0.1:42688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/19 23:01:09 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-19T23:01:09.867173Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276103155017867375,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-19T23:01:09.874809Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.190237162s","expected-duration":"1s"} {"level":"info","ts":"2026-06-19T23:01:09.875813Z","caller":"traceutil/trace.go:171","msg":"trace[1434263742] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"2.191378209s","start":"2026-06-19T23:01:07.684415Z","end":"2026-06-19T23:01:09.875793Z","steps":["trace[1434263742] 'process raft request' (duration: 2.191226435s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:09.875943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:01:07.684391Z","time spent":"2.191479181s","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T23:01:09.876946Z","caller":"traceutil/trace.go:171","msg":"trace[687944647] linearizableReadLoop","detail":"{readStateIndex:1361; appliedIndex:1359; }","duration":"2.012409469s","start":"2026-06-19T23:01:07.864509Z","end":"2026-06-19T23:01:09.876918Z","steps":["trace[687944647] 'read index received' (duration: 2.011091767s)","trace[687944647] 'applied index is now lower than readState.Index' (duration: 1.316302ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:01:09.877414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.560799358s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:01:09.877503Z","caller":"traceutil/trace.go:171","msg":"trace[1902777131] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1309; }","duration":"1.560945512s","start":"2026-06-19T23:01:08.316537Z","end":"2026-06-19T23:01:09.877483Z","steps":["trace[1902777131] 'agreement among raft nodes before linearized reading' (duration: 1.560775838s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:09.877558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:01:08.316518Z","time spent":"1.561030075s","remote":"127.0.0.1:42836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"info","ts":"2026-06-19T23:01:09.877635Z","caller":"traceutil/trace.go:171","msg":"trace[1917733851] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"1.809085422s","start":"2026-06-19T23:01:08.068528Z","end":"2026-06-19T23:01:09.877613Z","steps":["trace[1917733851] 'process raft request' (duration: 1.808219742s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:09.877786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:01:08.068498Z","time spent":"1.809196674s","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T23:01:09.877919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.110987934s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.129\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-19T23:01:09.878Z","caller":"traceutil/trace.go:171","msg":"trace[1755652773] range","detail":"{range_begin:/registry/masterleases/199.204.45.129; range_end:; response_count:1; response_revision:1309; }","duration":"1.111130058s","start":"2026-06-19T23:01:08.766849Z","end":"2026-06-19T23:01:09.877979Z","steps":["trace[1755652773] 'agreement among raft nodes before linearized reading' (duration: 1.110934113s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:09.878037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:01:08.766829Z","time spent":"1.111198999s","remote":"127.0.0.1:42728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.129\" "} {"level":"warn","ts":"2026-06-19T23:01:09.878048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.704304379s","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-19T23:01:09.878089Z","caller":"traceutil/trace.go:171","msg":"trace[865139911] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1309; }","duration":"1.704380281s","start":"2026-06-19T23:01:08.173692Z","end":"2026-06-19T23:01:09.878073Z","steps":["trace[865139911] 'agreement among raft nodes before linearized reading' (duration: 1.704248388s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:09.878131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:01:08.173667Z","time spent":"1.704457492s","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-19T23:01:09.877562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.723444742s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-19T23:01:09.878432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.70817821s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-19T23:01:09.878473Z","caller":"traceutil/trace.go:171","msg":"trace[623426957] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1309; }","duration":"1.708240812s","start":"2026-06-19T23:01:08.170222Z","end":"2026-06-19T23:01:09.878463Z","steps":["trace[623426957] 'agreement among raft nodes before linearized reading' (duration: 1.70813352s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:09.878518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:01:08.17021Z","time spent":"1.708301663s","remote":"127.0.0.1:42954","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":"warn","ts":"2026-06-19T23:01:09.878563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.708326414s","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-19T23:01:09.878641Z","caller":"traceutil/trace.go:171","msg":"trace[1013928224] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1309; }","duration":"1.708428697s","start":"2026-06-19T23:01:08.170191Z","end":"2026-06-19T23:01:09.878619Z","steps":["trace[1013928224] 'agreement among raft nodes before linearized reading' (duration: 1.708204932s)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:01:09.878419Z","caller":"traceutil/trace.go:171","msg":"trace[849197879] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1309; }","duration":"1.724315603s","start":"2026-06-19T23:01:08.154087Z","end":"2026-06-19T23:01:09.878402Z","steps":["trace[849197879] 'agreement among raft nodes before linearized reading' (duration: 1.723034922s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:09.878879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:01:08.170175Z","time spent":"1.708684253s","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-19T23:01:09.879014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:01:08.154022Z","time spent":"1.724675402s","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-19T23:01:09.879256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.691577187s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-19T23:01:09.880665Z","caller":"traceutil/trace.go:171","msg":"trace[1741411361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1309; }","duration":"1.693035292s","start":"2026-06-19T23:01:08.187612Z","end":"2026-06-19T23:01:09.880648Z","steps":["trace[1741411361] 'agreement among raft nodes before linearized reading' (duration: 1.690594074s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:09.880719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:01:08.187586Z","time spent":"1.693116133s","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-19T23:01:12.068363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.694657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:01:12.068429Z","caller":"traceutil/trace.go:171","msg":"trace[192154770] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1318; }","duration":"203.814179ms","start":"2026-06-19T23:01:11.864602Z","end":"2026-06-19T23:01:12.068416Z","steps":["trace[192154770] 'range keys from in-memory index tree' (duration: 203.587405ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:01:12.080235Z","caller":"traceutil/trace.go:171","msg":"trace[280288062] linearizableReadLoop","detail":"{readStateIndex:1372; appliedIndex:1371; }","duration":"131.995038ms","start":"2026-06-19T23:01:11.948225Z","end":"2026-06-19T23:01:12.08022Z","steps":["trace[280288062] 'read index received' (duration: 131.775933ms)","trace[280288062] 'applied index is now lower than readState.Index' (duration: 218.375µs)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:01:12.080339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.10605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:01:12.080377Z","caller":"traceutil/trace.go:171","msg":"trace[379608074] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1319; }","duration":"132.192422ms","start":"2026-06-19T23:01:11.948175Z","end":"2026-06-19T23:01:12.080367Z","steps":["trace[379608074] 'agreement among raft nodes before linearized reading' (duration: 132.125381ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:01:12.080307Z","caller":"traceutil/trace.go:171","msg":"trace[1888533749] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"197.786536ms","start":"2026-06-19T23:01:11.882497Z","end":"2026-06-19T23:01:12.080283Z","steps":["trace[1888533749] 'process raft request' (duration: 197.577591ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:12.080604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.803516ms","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-19T23:01:12.080651Z","caller":"traceutil/trace.go:171","msg":"trace[1053737456] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1319; }","duration":"110.852887ms","start":"2026-06-19T23:01:11.969785Z","end":"2026-06-19T23:01:12.080638Z","steps":["trace[1053737456] 'agreement among raft nodes before linearized reading' (duration: 110.691353ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:12.080761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.824115ms","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-19T23:01:12.080869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.245666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-19T23:01:12.081022Z","caller":"traceutil/trace.go:171","msg":"trace[747182300] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1319; }","duration":"111.4044ms","start":"2026-06-19T23:01:11.969568Z","end":"2026-06-19T23:01:12.080973Z","steps":["trace[747182300] 'agreement among raft nodes before linearized reading' (duration: 110.947209ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:12.080796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.207435ms","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-19T23:01:12.08115Z","caller":"traceutil/trace.go:171","msg":"trace[1404860171] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1319; }","duration":"111.611225ms","start":"2026-06-19T23:01:11.969526Z","end":"2026-06-19T23:01:12.081137Z","steps":["trace[1404860171] 'agreement among raft nodes before linearized reading' (duration: 111.141083ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:01:12.080876Z","caller":"traceutil/trace.go:171","msg":"trace[1805088343] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1319; }","duration":"110.98412ms","start":"2026-06-19T23:01:11.969874Z","end":"2026-06-19T23:01:12.080858Z","steps":["trace[1805088343] 'agreement among raft nodes before linearized reading' (duration: 110.675433ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:01:12.081311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.739177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-19T23:01:12.081488Z","caller":"traceutil/trace.go:171","msg":"trace[1696900598] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1319; }","duration":"111.938762ms","start":"2026-06-19T23:01:11.969531Z","end":"2026-06-19T23:01:12.081469Z","steps":["trace[1696900598] 'agreement among raft nodes before linearized reading' (duration: 110.917808ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:01:18.265952Z","caller":"traceutil/trace.go:171","msg":"trace[1371364165] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"105.05511ms","start":"2026-06-19T23:01:18.160875Z","end":"2026-06-19T23:01:18.26593Z","steps":["trace[1371364165] 'process raft request' (duration: 105.006038ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:01:18.265971Z","caller":"traceutil/trace.go:171","msg":"trace[1721483568] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"105.149352ms","start":"2026-06-19T23:01:18.160788Z","end":"2026-06-19T23:01:18.265938Z","steps":["trace[1721483568] 'process raft request' (duration: 104.262861ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:01:18.266101Z","caller":"traceutil/trace.go:171","msg":"trace[1977005416] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"105.270645ms","start":"2026-06-19T23:01:18.160785Z","end":"2026-06-19T23:01:18.266056Z","steps":["trace[1977005416] 'process raft request' (duration: 105.06203ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:01:18.266155Z","caller":"traceutil/trace.go:171","msg":"trace[1516942992] transaction","detail":"{read_only:false; response_revision:1375; number_of_response:1; }","duration":"105.229724ms","start":"2026-06-19T23:01:18.160917Z","end":"2026-06-19T23:01:18.266146Z","steps":["trace[1516942992] 'process raft request' (duration: 104.991418ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:01:18.949994Z","caller":"traceutil/trace.go:171","msg":"trace[1590531911] linearizableReadLoop","detail":"{readStateIndex:1430; appliedIndex:1429; }","duration":"127.277795ms","start":"2026-06-19T23:01:18.822689Z","end":"2026-06-19T23:01:18.949966Z","steps":["trace[1590531911] 'read index received' (duration: 127.06043ms)","trace[1590531911] 'applied index is now lower than readState.Index' (duration: 215.945µs)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:01:18.950192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.47086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:01:18.950314Z","caller":"traceutil/trace.go:171","msg":"trace[463629029] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1375; }","duration":"127.634854ms","start":"2026-06-19T23:01:18.822639Z","end":"2026-06-19T23:01:18.950274Z","steps":["trace[463629029] 'agreement among raft nodes before linearized reading' (duration: 127.454919ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:01:19.118244Z","caller":"traceutil/trace.go:171","msg":"trace[869522853] linearizableReadLoop","detail":"{readStateIndex:1431; appliedIndex:1430; }","duration":"155.672769ms","start":"2026-06-19T23:01:18.962536Z","end":"2026-06-19T23:01:19.118209Z","steps":["trace[869522853] 'read index received' (duration: 98.888993ms)","trace[869522853] 'applied index is now lower than readState.Index' (duration: 56.782506ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T23:01:19.118296Z","caller":"traceutil/trace.go:171","msg":"trace[609851282] transaction","detail":"{read_only:false; response_revision:1376; number_of_response:1; }","duration":"167.09158ms","start":"2026-06-19T23:01:18.951151Z","end":"2026-06-19T23:01:19.118243Z","steps":["trace[609851282] 'process raft request' (duration: 110.245362ms)","trace[609851282] 'compare' (duration: 56.627973ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:01:19.118618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.057398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-06-19T23:01:19.11871Z","caller":"traceutil/trace.go:171","msg":"trace[285479751] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1376; }","duration":"156.191472ms","start":"2026-06-19T23:01:18.962494Z","end":"2026-06-19T23:01:19.118685Z","steps":["trace[285479751] 'agreement among raft nodes before linearized reading' (duration: 155.855684ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:01:58.771743Z","caller":"traceutil/trace.go:171","msg":"trace[546973661] transaction","detail":"{read_only:false; response_revision:1556; number_of_response:1; }","duration":"216.370718ms","start":"2026-06-19T23:01:58.555333Z","end":"2026-06-19T23:01:58.771704Z","steps":["trace[546973661] 'process raft request' (duration: 186.342055ms)","trace[546973661] 'compare' (duration: 29.667914ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T23:01:58.771802Z","caller":"traceutil/trace.go:171","msg":"trace[155329905] transaction","detail":"{read_only:false; response_revision:1557; number_of_response:1; }","duration":"215.912737ms","start":"2026-06-19T23:01:58.555862Z","end":"2026-06-19T23:01:58.771775Z","steps":["trace[155329905] 'process raft request' (duration: 215.725022ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:01:58.77195Z","caller":"traceutil/trace.go:171","msg":"trace[1263200340] transaction","detail":"{read_only:false; response_revision:1558; number_of_response:1; }","duration":"215.847465ms","start":"2026-06-19T23:01:58.556091Z","end":"2026-06-19T23:01:58.771938Z","steps":["trace[1263200340] 'process raft request' (duration: 215.578169ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:01:58.771983Z","caller":"traceutil/trace.go:171","msg":"trace[1953029313] transaction","detail":"{read_only:false; response_revision:1560; number_of_response:1; }","duration":"215.660791ms","start":"2026-06-19T23:01:58.556296Z","end":"2026-06-19T23:01:58.771956Z","steps":["trace[1953029313] 'process raft request' (duration: 215.446546ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:01:58.771986Z","caller":"traceutil/trace.go:171","msg":"trace[439070760] transaction","detail":"{read_only:false; response_revision:1559; number_of_response:1; }","duration":"215.690062ms","start":"2026-06-19T23:01:58.55624Z","end":"2026-06-19T23:01:58.77193Z","steps":["trace[439070760] 'process raft request' (duration: 215.467317ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:03:25.595502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.588376ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-19T23:03:25.595644Z","caller":"traceutil/trace.go:171","msg":"trace[674581760] linearizableReadLoop","detail":"{readStateIndex:2035; appliedIndex:2034; }","duration":"213.599102ms","start":"2026-06-19T23:03:25.382024Z","end":"2026-06-19T23:03:25.595623Z","steps":["trace[674581760] 'read index received' (duration: 109.729569ms)","trace[674581760] 'applied index is now lower than readState.Index' (duration: 103.865153ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T23:03:25.595782Z","caller":"traceutil/trace.go:171","msg":"trace[1798780894] transaction","detail":"{read_only:false; response_revision:1955; number_of_response:1; }","duration":"241.117536ms","start":"2026-06-19T23:03:25.354612Z","end":"2026-06-19T23:03:25.59573Z","steps":["trace[1798780894] 'process raft request' (duration: 137.218532ms)","trace[1798780894] 'compare' (duration: 103.298909ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:03:25.595875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.827378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-06-19T23:03:25.59587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.843408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-19T23:03:25.59592Z","caller":"traceutil/trace.go:171","msg":"trace[8432092] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1955; }","duration":"213.879959ms","start":"2026-06-19T23:03:25.382017Z","end":"2026-06-19T23:03:25.595897Z","steps":["trace[8432092] 'agreement among raft nodes before linearized reading' (duration: 213.793597ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:03:25.59592Z","caller":"traceutil/trace.go:171","msg":"trace[1510643407] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1955; }","duration":"213.91937ms","start":"2026-06-19T23:03:25.381985Z","end":"2026-06-19T23:03:25.595905Z","steps":["trace[1510643407] 'agreement among raft nodes before linearized reading' (duration: 213.758486ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:03:25.595933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.852239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-06-19T23:03:25.595988Z","caller":"traceutil/trace.go:171","msg":"trace[1982649836] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1955; }","duration":"213.93803ms","start":"2026-06-19T23:03:25.382037Z","end":"2026-06-19T23:03:25.595975Z","steps":["trace[1982649836] 'agreement among raft nodes before linearized reading' (duration: 213.787327ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T23:03:52.112683Z","caller":"traceutil/trace.go:171","msg":"trace[492289953] linearizableReadLoop","detail":"{readStateIndex:2161; appliedIndex:2160; }","duration":"307.085658ms","start":"2026-06-19T23:03:51.805555Z","end":"2026-06-19T23:03:52.112641Z","steps":["trace[492289953] 'read index received' (duration: 303.552074ms)","trace[492289953] 'applied index is now lower than readState.Index' (duration: 3.532374ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T23:03:52.112811Z","caller":"traceutil/trace.go:171","msg":"trace[385654156] transaction","detail":"{read_only:false; response_revision:2076; number_of_response:1; }","duration":"312.027996ms","start":"2026-06-19T23:03:51.800765Z","end":"2026-06-19T23:03:52.112793Z","steps":["trace[385654156] 'process raft request' (duration: 308.372828ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:03:52.112928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:03:51.80075Z","time spent":"312.094608ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T23:03:52.11295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.055493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-06-19T23:03:52.11302Z","caller":"traceutil/trace.go:171","msg":"trace[1059291355] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2076; }","duration":"306.157606ms","start":"2026-06-19T23:03:51.806844Z","end":"2026-06-19T23:03:52.113002Z","steps":["trace[1059291355] 'agreement among raft nodes before linearized reading' (duration: 305.982472ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:03:52.113058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:03:51.806831Z","time spent":"306.217687ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":553,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-06-19T23:03:52.113115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.543629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-19T23:03:52.113174Z","caller":"traceutil/trace.go:171","msg":"trace[1992971913] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2076; }","duration":"307.646072ms","start":"2026-06-19T23:03:51.805514Z","end":"2026-06-19T23:03:52.11316Z","steps":["trace[1992971913] 'agreement among raft nodes before linearized reading' (duration: 307.467948ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:03:52.113207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:03:51.805496Z","time spent":"307.703283ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-19T23:03:53.331556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.492931ms","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-19T23:03:53.331642Z","caller":"traceutil/trace.go:171","msg":"trace[523508055] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2080; }","duration":"169.628085ms","start":"2026-06-19T23:03:53.161996Z","end":"2026-06-19T23:03:53.331624Z","steps":["trace[523508055] 'range keys from in-memory index tree' (duration: 169.317128ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:04:02.329313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.325562ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-19T23:04:02.329468Z","caller":"traceutil/trace.go:171","msg":"trace[1102369699] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"150.370754ms","start":"2026-06-19T23:04:02.179079Z","end":"2026-06-19T23:04:02.32945Z","steps":["trace[1102369699] 'process raft request' (duration: 37.831317ms)","trace[1102369699] 'compare' (duration: 112.149747ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:05:04.459287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.954584ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-19T23:05:04.459429Z","caller":"traceutil/trace.go:171","msg":"trace[1385537142] linearizableReadLoop","detail":"{readStateIndex:2532; appliedIndex:2531; }","duration":"346.900587ms","start":"2026-06-19T23:05:04.112483Z","end":"2026-06-19T23:05:04.459384Z","steps":["trace[1385537142] 'read index received' (duration: 146.757889ms)","trace[1385537142] 'applied index is now lower than readState.Index' (duration: 200.140928ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:05:04.459588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.092422ms","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-19T23:05:04.459618Z","caller":"traceutil/trace.go:171","msg":"trace[48684138] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2431; }","duration":"347.161323ms","start":"2026-06-19T23:05:04.112444Z","end":"2026-06-19T23:05:04.459606Z","steps":["trace[48684138] 'agreement among raft nodes before linearized reading' (duration: 347.01939ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:05:04.459649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:05:04.112426Z","time spent":"347.215884ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-19T23:05:40.297247Z","caller":"traceutil/trace.go:171","msg":"trace[1335542380] linearizableReadLoop","detail":"{readStateIndex:2711; appliedIndex:2710; }","duration":"475.451988ms","start":"2026-06-19T23:05:39.821778Z","end":"2026-06-19T23:05:40.29723Z","steps":["trace[1335542380] 'read index received' (duration: 475.325575ms)","trace[1335542380] 'applied index is now lower than readState.Index' (duration: 125.533µs)"],"step_count":2} {"level":"info","ts":"2026-06-19T23:05:40.29727Z","caller":"traceutil/trace.go:171","msg":"trace[1247621694] transaction","detail":"{read_only:false; response_revision:2602; number_of_response:1; }","duration":"496.328059ms","start":"2026-06-19T23:05:39.800926Z","end":"2026-06-19T23:05:40.297254Z","steps":["trace[1247621694] 'process raft request' (duration: 496.197716ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:05:40.297392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:05:39.80091Z","time spent":"496.40283ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":511,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T23:05:40.297406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.631123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-jlkx8\" ","response":"range_response_count:1 size:11390"} {"level":"info","ts":"2026-06-19T23:05:40.29751Z","caller":"traceutil/trace.go:171","msg":"trace[293005772] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-jlkx8; range_end:; response_count:1; response_revision:2602; }","duration":"475.765916ms","start":"2026-06-19T23:05:39.821737Z","end":"2026-06-19T23:05:40.297503Z","steps":["trace[293005772] 'agreement among raft nodes before linearized reading' (duration: 475.579211ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:05:40.29753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:05:39.821722Z","time spent":"475.801117ms","remote":"127.0.0.1:42876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":11412,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-jlkx8\" "} {"level":"warn","ts":"2026-06-19T23:05:40.297514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.598069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-19T23:05:40.297568Z","caller":"traceutil/trace.go:171","msg":"trace[1098088348] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2602; }","duration":"230.68498ms","start":"2026-06-19T23:05:40.066873Z","end":"2026-06-19T23:05:40.297558Z","steps":["trace[1098088348] 'agreement among raft nodes before linearized reading' (duration: 230.551437ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:05:40.297859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.602465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-19T23:05:40.297964Z","caller":"traceutil/trace.go:171","msg":"trace[965706648] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2602; }","duration":"380.766098ms","start":"2026-06-19T23:05:39.917181Z","end":"2026-06-19T23:05:40.297948Z","steps":["trace[965706648] 'agreement among raft nodes before linearized reading' (duration: 380.269277ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:05:40.298021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:05:39.917161Z","time spent":"380.85039ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-19T23:05:41.059657Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276103155017871643,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-19T23:05:41.46989Z","caller":"traceutil/trace.go:171","msg":"trace[1326771767] linearizableReadLoop","detail":"{readStateIndex:2714; appliedIndex:2713; }","duration":"910.380306ms","start":"2026-06-19T23:05:40.559484Z","end":"2026-06-19T23:05:41.469864Z","steps":["trace[1326771767] 'read index received' (duration: 910.106429ms)","trace[1326771767] 'applied index is now lower than readState.Index' (duration: 272.847µs)"],"step_count":2} {"level":"warn","ts":"2026-06-19T23:05:41.470128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"910.621701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-szt7k\" ","response":"range_response_count:1 size:13721"} {"level":"info","ts":"2026-06-19T23:05:41.470179Z","caller":"traceutil/trace.go:171","msg":"trace[59171372] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-szt7k; range_end:; response_count:1; response_revision:2605; }","duration":"910.749454ms","start":"2026-06-19T23:05:40.559421Z","end":"2026-06-19T23:05:41.470171Z","steps":["trace[59171372] 'agreement among raft nodes before linearized reading' (duration: 910.531479ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:05:41.470206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:05:40.559402Z","time spent":"910.799046ms","remote":"127.0.0.1:42876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":13743,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-szt7k\" "} {"level":"info","ts":"2026-06-19T23:05:41.469933Z","caller":"traceutil/trace.go:171","msg":"trace[306613662] transaction","detail":"{read_only:false; response_revision:2605; number_of_response:1; }","duration":"978.845917ms","start":"2026-06-19T23:05:40.491062Z","end":"2026-06-19T23:05:41.469907Z","steps":["trace[306613662] 'process raft request' (duration: 978.496769ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:05:41.470578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:05:40.491044Z","time spent":"979.490562ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T23:05:41.474032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"846.784441ms","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-19T23:05:41.474107Z","caller":"traceutil/trace.go:171","msg":"trace[1442620512] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2606; }","duration":"846.868863ms","start":"2026-06-19T23:05:40.627211Z","end":"2026-06-19T23:05:41.47408Z","steps":["trace[1442620512] 'agreement among raft nodes before linearized reading' (duration: 846.681969ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:05:41.474138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:05:40.627204Z","time spent":"846.927254ms","remote":"127.0.0.1:42954","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-19T23:05:41.474342Z","caller":"traceutil/trace.go:171","msg":"trace[467592830] transaction","detail":"{read_only:false; response_revision:2606; number_of_response:1; }","duration":"203.000687ms","start":"2026-06-19T23:05:41.271334Z","end":"2026-06-19T23:05:41.474334Z","steps":["trace[467592830] 'process raft request' (duration: 202.450844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:05:41.474471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.521777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T23:05:41.474497Z","caller":"traceutil/trace.go:171","msg":"trace[2088556333] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:2606; }","duration":"190.552208ms","start":"2026-06-19T23:05:41.283937Z","end":"2026-06-19T23:05:41.474489Z","steps":["trace[2088556333] 'agreement among raft nodes before linearized reading' (duration: 190.498747ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:05:41.474653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.815622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-19T23:05:41.474688Z","caller":"traceutil/trace.go:171","msg":"trace[1707665707] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:2606; }","duration":"320.877602ms","start":"2026-06-19T23:05:41.153793Z","end":"2026-06-19T23:05:41.47467Z","steps":["trace[1707665707] 'agreement among raft nodes before linearized reading' (duration: 320.832571ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:05:41.47471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:05:41.153772Z","time spent":"320.931834ms","remote":"127.0.0.1:43128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":29,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-19T23:05:41.474734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.013314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-19T23:05:41.474781Z","caller":"traceutil/trace.go:171","msg":"trace[525169822] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2606; }","duration":"829.071587ms","start":"2026-06-19T23:05:40.645698Z","end":"2026-06-19T23:05:41.474769Z","steps":["trace[525169822] 'agreement among raft nodes before linearized reading' (duration: 828.940553ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:05:41.474806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:05:40.645692Z","time spent":"829.108957ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-19T23:05:41.474949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.953257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-19T23:05:41.475275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.781663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-19T23:05:41.475303Z","caller":"traceutil/trace.go:171","msg":"trace[500322748] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2606; }","duration":"570.846395ms","start":"2026-06-19T23:05:40.90445Z","end":"2026-06-19T23:05:41.475296Z","steps":["trace[500322748] 'agreement among raft nodes before linearized reading' (duration: 570.743133ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:05:41.475322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:05:40.904431Z","time spent":"570.886557ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-06-19T23:05:41.47499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.258317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-19T23:05:41.475378Z","caller":"traceutil/trace.go:171","msg":"trace[1246132105] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2606; }","duration":"692.675597ms","start":"2026-06-19T23:05:40.782685Z","end":"2026-06-19T23:05:41.47536Z","steps":["trace[1246132105] 'agreement among raft nodes before linearized reading' (duration: 692.237416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:05:41.475416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:05:40.782662Z","time spent":"692.743598ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-19T23:05:41.475593Z","caller":"traceutil/trace.go:171","msg":"trace[894951770] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2606; }","duration":"611.085669ms","start":"2026-06-19T23:05:40.863931Z","end":"2026-06-19T23:05:41.475016Z","steps":["trace[894951770] 'agreement among raft nodes before linearized reading' (duration: 610.934516ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T23:05:41.475872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T23:05:40.863915Z","time spent":"611.833248ms","remote":"127.0.0.1:42688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}