{"level":"warn","ts":"2026-08-11T08:27:54.112633Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-11T08:27:54.112743Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.125:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.125:2380","--initial-cluster=instance=https://199.19.213.125:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.125:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.125: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-08-11T08:27:54.112822Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-11T08:27:54.11283Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.125:2380"]} {"level":"info","ts":"2026-08-11T08:27:54.112849Z","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-08-11T08:27:54.113762Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.125:2379"]} {"level":"info","ts":"2026-08-11T08:27:54.113843Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.125:2380"],"listen-peer-urls":["https://199.19.213.125:2380"],"advertise-client-urls":["https://199.19.213.125:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.125:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.125: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-08-11T08:27:54.116849Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.79775ms"} {"level":"info","ts":"2026-08-11T08:27:54.125542Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b448fdce642f2755","cluster-id":"66f7e5dc9a72c5e3"} {"level":"info","ts":"2026-08-11T08:27:54.125634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 switched to configuration voters=()"} {"level":"info","ts":"2026-08-11T08:27:54.125666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became follower at term 0"} {"level":"info","ts":"2026-08-11T08:27:54.12569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b448fdce642f2755 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-11T08:27:54.125698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became follower at term 1"} {"level":"info","ts":"2026-08-11T08:27:54.125744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 switched to configuration voters=(12990912188036097877)"} {"level":"warn","ts":"2026-08-11T08:27:54.13067Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-11T08:27:54.136272Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-11T08:27:54.137927Z","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-08-11T08:27:54.141069Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b448fdce642f2755","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-11T08:27:54.142211Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b448fdce642f2755","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-11T08:27:54.144307Z","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-08-11T08:27:54.144406Z","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-08-11T08:27:54.144438Z","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-08-11T08:27:54.145752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 switched to configuration voters=(12990912188036097877)"} {"level":"info","ts":"2026-08-11T08:27:54.14586Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"66f7e5dc9a72c5e3","local-member-id":"b448fdce642f2755","added-peer-id":"b448fdce642f2755","added-peer-peer-urls":["https://199.19.213.125:2380"]} {"level":"info","ts":"2026-08-11T08:27:54.146612Z","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-08-11T08:27:54.146712Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.125:2380"} {"level":"info","ts":"2026-08-11T08:27:54.146784Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.125:2380"} {"level":"info","ts":"2026-08-11T08:27:54.146865Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b448fdce642f2755","initial-advertise-peer-urls":["https://199.19.213.125:2380"],"listen-peer-urls":["https://199.19.213.125:2380"],"advertise-client-urls":["https://199.19.213.125:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.125:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-11T08:27:54.146901Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-11T08:27:54.426623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 is starting a new election at term 1"} {"level":"info","ts":"2026-08-11T08:27:54.426696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-11T08:27:54.426733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 received MsgPreVoteResp from b448fdce642f2755 at term 1"} {"level":"info","ts":"2026-08-11T08:27:54.426765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became candidate at term 2"} {"level":"info","ts":"2026-08-11T08:27:54.426786Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 received MsgVoteResp from b448fdce642f2755 at term 2"} {"level":"info","ts":"2026-08-11T08:27:54.426814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became leader at term 2"} {"level":"info","ts":"2026-08-11T08:27:54.426837Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b448fdce642f2755 elected leader b448fdce642f2755 at term 2"} {"level":"info","ts":"2026-08-11T08:27:54.427931Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:27:54.428226Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b448fdce642f2755","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.125:2379]}","request-path":"/0/members/b448fdce642f2755/attributes","cluster-id":"66f7e5dc9a72c5e3","publish-timeout":"7s"} {"level":"info","ts":"2026-08-11T08:27:54.428276Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T08:27:54.428557Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T08:27:54.428776Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"66f7e5dc9a72c5e3","local-member-id":"b448fdce642f2755","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:27:54.428876Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:27:54.42891Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:27:54.428974Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-11T08:27:54.428996Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-11T08:27:54.431571Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-11T08:27:54.432597Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.125:2379"} {"level":"warn","ts":"2026-08-11T08:28:11.287594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.214668ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T08:28:11.287791Z","caller":"traceutil/trace.go:171","msg":"trace[914017077] linearizableReadLoop","detail":"{readStateIndex:389; appliedIndex:388; }","duration":"129.656071ms","start":"2026-08-11T08:28:11.158106Z","end":"2026-08-11T08:28:11.287762Z","steps":["trace[914017077] 'read index received' (duration: 55.272µs)","trace[914017077] 'applied index is now lower than readState.Index' (duration: 129.599219ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:28:11.28796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.853428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-08-11T08:28:11.28799Z","caller":"traceutil/trace.go:171","msg":"trace[809666332] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:376; }","duration":"129.93353ms","start":"2026-08-11T08:28:11.158046Z","end":"2026-08-11T08:28:11.28798Z","steps":["trace[809666332] 'agreement among raft nodes before linearized reading' (duration: 129.866068ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:28:11.288124Z","caller":"traceutil/trace.go:171","msg":"trace[1739286889] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"558.560928ms","start":"2026-08-11T08:28:10.729553Z","end":"2026-08-11T08:28:11.288114Z","steps":["trace[1739286889] 'process raft request' (duration: 199.260345ms)","trace[1739286889] 'compare' (duration: 357.887997ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:28:11.288184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:28:10.729536Z","time spent":"558.61077ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:28:11.438609Z","caller":"traceutil/trace.go:171","msg":"trace[751114432] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"146.018467ms","start":"2026-08-11T08:28:11.292552Z","end":"2026-08-11T08:28:11.43857Z","steps":["trace[751114432] 'process raft request' (duration: 145.728737ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:28:31.007301Z","caller":"traceutil/trace.go:171","msg":"trace[1184317519] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"102.4711ms","start":"2026-08-11T08:28:30.904809Z","end":"2026-08-11T08:28:31.00728Z","steps":["trace[1184317519] 'process raft request' (duration: 102.328395ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:28:31.35897Z","caller":"traceutil/trace.go:171","msg":"trace[1951553298] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"139.977112ms","start":"2026-08-11T08:28:31.218956Z","end":"2026-08-11T08:28:31.358933Z","steps":["trace[1951553298] 'process raft request' (duration: 138.382471ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:28:31.362892Z","caller":"traceutil/trace.go:171","msg":"trace[1255984372] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"127.210273ms","start":"2026-08-11T08:28:31.235663Z","end":"2026-08-11T08:28:31.362874Z","steps":["trace[1255984372] 'process raft request' (duration: 126.995836ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:28:31.363025Z","caller":"traceutil/trace.go:171","msg":"trace[2060495342] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"126.127199ms","start":"2026-08-11T08:28:31.236864Z","end":"2026-08-11T08:28:31.362991Z","steps":["trace[2060495342] 'process raft request' (duration: 125.819889ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:28:31.363227Z","caller":"traceutil/trace.go:171","msg":"trace[1857146971] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"115.365032ms","start":"2026-08-11T08:28:31.247835Z","end":"2026-08-11T08:28:31.3632Z","steps":["trace[1857146971] 'process raft request' (duration: 114.939759ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:28:31.363293Z","caller":"traceutil/trace.go:171","msg":"trace[162650930] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"115.954681ms","start":"2026-08-11T08:28:31.247331Z","end":"2026-08-11T08:28:31.363286Z","steps":["trace[162650930] 'process raft request' (duration: 115.413974ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:28:31.363373Z","caller":"traceutil/trace.go:171","msg":"trace[1158109170] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"133.148704ms","start":"2026-08-11T08:28:31.230218Z","end":"2026-08-11T08:28:31.363367Z","steps":["trace[1158109170] 'process raft request' (duration: 132.42254ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:28:31.363344Z","caller":"traceutil/trace.go:171","msg":"trace[854709281] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"120.962582ms","start":"2026-08-11T08:28:31.24233Z","end":"2026-08-11T08:28:31.363292Z","steps":["trace[854709281] 'process raft request' (duration: 120.393234ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:28:31.363417Z","caller":"traceutil/trace.go:171","msg":"trace[424346702] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"142.534145ms","start":"2026-08-11T08:28:31.220877Z","end":"2026-08-11T08:28:31.363411Z","steps":["trace[424346702] 'process raft request' (duration: 141.707959ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:28:31.363259Z","caller":"traceutil/trace.go:171","msg":"trace[1634366717] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"108.627187ms","start":"2026-08-11T08:28:31.254621Z","end":"2026-08-11T08:28:31.363249Z","steps":["trace[1634366717] 'process raft request' (duration: 108.192813ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:28:37.15197Z","caller":"traceutil/trace.go:171","msg":"trace[730062151] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"118.09502ms","start":"2026-08-11T08:28:37.03385Z","end":"2026-08-11T08:28:37.151945Z","steps":["trace[730062151] 'process raft request' (duration: 117.843242ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:28:37.251733Z","caller":"traceutil/trace.go:171","msg":"trace[819415701] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"190.903846ms","start":"2026-08-11T08:28:37.060808Z","end":"2026-08-11T08:28:37.251712Z","steps":["trace[819415701] 'process raft request' (duration: 190.444951ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:28:37.785318Z","caller":"traceutil/trace.go:171","msg":"trace[1024342879] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"341.653456ms","start":"2026-08-11T08:28:37.443641Z","end":"2026-08-11T08:28:37.785295Z","steps":["trace[1024342879] 'read index received' (duration: 341.47279ms)","trace[1024342879] 'applied index is now lower than readState.Index' (duration: 179.106µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:28:37.785495Z","caller":"traceutil/trace.go:171","msg":"trace[1740922822] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"469.707736ms","start":"2026-08-11T08:28:37.315767Z","end":"2026-08-11T08:28:37.785475Z","steps":["trace[1740922822] 'process raft request' (duration: 469.381735ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:28:37.785627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:28:37.31574Z","time spent":"469.806699ms","remote":"127.0.0.1:34390","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T08:28:37.785935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.267635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-11T08:28:37.785959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.578423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:28:37.786016Z","caller":"traceutil/trace.go:171","msg":"trace[558288806] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:591; }","duration":"342.406609ms","start":"2026-08-11T08:28:37.443589Z","end":"2026-08-11T08:28:37.785996Z","steps":["trace[558288806] 'agreement among raft nodes before linearized reading' (duration: 342.063788ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:28:37.786023Z","caller":"traceutil/trace.go:171","msg":"trace[852963604] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:591; }","duration":"274.685577ms","start":"2026-08-11T08:28:37.511319Z","end":"2026-08-11T08:28:37.786005Z","steps":["trace[852963604] 'agreement among raft nodes before linearized reading' (duration: 274.569883ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:28:37.786071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:28:37.443567Z","time spent":"342.486622ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-11T08:28:37.786079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.348138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kkj75\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-08-11T08:28:37.786124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.076201ms","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-08-11T08:28:37.78619Z","caller":"traceutil/trace.go:171","msg":"trace[704549987] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kkj75; range_end:; response_count:1; response_revision:591; }","duration":"318.588506ms","start":"2026-08-11T08:28:37.467574Z","end":"2026-08-11T08:28:37.786162Z","steps":["trace[704549987] 'agreement among raft nodes before linearized reading' (duration: 318.081599ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:28:37.786212Z","caller":"traceutil/trace.go:171","msg":"trace[1175071859] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:591; }","duration":"214.222536ms","start":"2026-08-11T08:28:37.571965Z","end":"2026-08-11T08:28:37.786188Z","steps":["trace[1175071859] 'agreement among raft nodes before linearized reading' (duration: 213.861934ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:28:37.786246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:28:37.46755Z","time spent":"318.686119ms","remote":"127.0.0.1:34224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-kkj75\" "} {"level":"warn","ts":"2026-08-11T08:28:37.786106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.896176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.125\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-11T08:28:37.786497Z","caller":"traceutil/trace.go:171","msg":"trace[713120128] range","detail":"{range_begin:/registry/masterleases/199.19.213.125; range_end:; response_count:1; response_revision:591; }","duration":"119.235337ms","start":"2026-08-11T08:28:37.667146Z","end":"2026-08-11T08:28:37.786381Z","steps":["trace[713120128] 'agreement among raft nodes before linearized reading' (duration: 118.881015ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:28:38.427261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.652657ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-08-11T08:28:38.427406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:28:37.787464Z","time spent":"639.93445ms","remote":"127.0.0.1:60234","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-08-11T08:28:38.427742Z","caller":"traceutil/trace.go:171","msg":"trace[1300460245] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"626.570131ms","start":"2026-08-11T08:28:37.801138Z","end":"2026-08-11T08:28:38.427708Z","steps":["trace[1300460245] 'process raft request' (duration: 626.514669ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:28:38.427814Z","caller":"traceutil/trace.go:171","msg":"trace[669510997] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"637.942075ms","start":"2026-08-11T08:28:37.789844Z","end":"2026-08-11T08:28:38.427786Z","steps":["trace[669510997] 'process raft request' (duration: 637.529212ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:28:38.427875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:28:37.801097Z","time spent":"626.699035ms","remote":"127.0.0.1:34224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:28:38.427925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:28:37.789821Z","time spent":"638.047599ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:28:38.427902Z","caller":"traceutil/trace.go:171","msg":"trace[1653203763] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"640.113015ms","start":"2026-08-11T08:28:37.787755Z","end":"2026-08-11T08:28:38.427868Z","steps":["trace[1653203763] 'read index received' (duration: 363.863959ms)","trace[1653203763] 'applied index is now lower than readState.Index' (duration: 276.246756ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:28:38.427921Z","caller":"traceutil/trace.go:171","msg":"trace[1041375146] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"636.352655ms","start":"2026-08-11T08:28:37.791538Z","end":"2026-08-11T08:28:38.42789Z","steps":["trace[1041375146] 'process raft request' (duration: 636.055065ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:28:38.428071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:28:37.791491Z","time spent":"636.497259ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:28:38.428087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.675067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T08:28:38.4281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.318501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:28:38.428123Z","caller":"traceutil/trace.go:171","msg":"trace[927736327] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:594; }","duration":"632.730329ms","start":"2026-08-11T08:28:37.795381Z","end":"2026-08-11T08:28:38.428112Z","steps":["trace[927736327] 'agreement among raft nodes before linearized reading' (duration: 632.669067ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:28:38.428139Z","caller":"traceutil/trace.go:171","msg":"trace[1917581100] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"640.418195ms","start":"2026-08-11T08:28:37.787711Z","end":"2026-08-11T08:28:38.428129Z","steps":["trace[1917581100] 'agreement among raft nodes before linearized reading' (duration: 640.318632ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:28:38.428148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:28:37.795369Z","time spent":"632.77395ms","remote":"127.0.0.1:34526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "} {"level":"warn","ts":"2026-08-11T08:28:38.428173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:28:37.787693Z","time spent":"640.473296ms","remote":"127.0.0.1:60226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-11T08:28:53.358836Z","caller":"traceutil/trace.go:171","msg":"trace[707499072] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"133.822326ms","start":"2026-08-11T08:28:53.224982Z","end":"2026-08-11T08:28:53.358805Z","steps":["trace[707499072] 'process raft request' (duration: 133.62448ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:29:07.282082Z","caller":"traceutil/trace.go:171","msg":"trace[2145094694] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"251.688935ms","start":"2026-08-11T08:29:07.030376Z","end":"2026-08-11T08:29:07.282065Z","steps":["trace[2145094694] 'process raft request' (duration: 251.570831ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:29:07.592344Z","caller":"traceutil/trace.go:171","msg":"trace[586916865] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"304.069204ms","start":"2026-08-11T08:29:07.28825Z","end":"2026-08-11T08:29:07.59232Z","steps":["trace[586916865] 'process raft request' (duration: 303.880988ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:29:07.592605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:29:07.288235Z","time spent":"304.189288ms","remote":"127.0.0.1:34320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1628,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:29:07.63263Z","caller":"traceutil/trace.go:171","msg":"trace[1635844529] linearizableReadLoop","detail":"{readStateIndex:922; appliedIndex:919; }","duration":"215.617714ms","start":"2026-08-11T08:29:07.416987Z","end":"2026-08-11T08:29:07.632605Z","steps":["trace[1635844529] 'read index received' (duration: 175.187045ms)","trace[1635844529] 'applied index is now lower than readState.Index' (duration: 40.429949ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:29:07.632654Z","caller":"traceutil/trace.go:171","msg":"trace[502589167] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"343.651776ms","start":"2026-08-11T08:29:07.288976Z","end":"2026-08-11T08:29:07.632628Z","steps":["trace[502589167] 'process raft request' (duration: 343.456519ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:29:07.632759Z","caller":"traceutil/trace.go:171","msg":"trace[261211447] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"341.832848ms","start":"2026-08-11T08:29:07.290898Z","end":"2026-08-11T08:29:07.632731Z","steps":["trace[261211447] 'process raft request' (duration: 341.669163ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:29:07.632848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.833961ms","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-08-11T08:29:07.632882Z","caller":"traceutil/trace.go:171","msg":"trace[1815957894] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:892; }","duration":"215.920243ms","start":"2026-08-11T08:29:07.416952Z","end":"2026-08-11T08:29:07.632872Z","steps":["trace[1815957894] 'agreement among raft nodes before linearized reading' (duration: 215.779289ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:29:07.632906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:29:07.290878Z","time spent":"341.945221ms","remote":"127.0.0.1:34494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5192,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:29:07.632855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:29:07.288952Z","time spent":"343.77737ms","remote":"127.0.0.1:34198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1105,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:29:07.633226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.469476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:29:07.63325Z","caller":"traceutil/trace.go:171","msg":"trace[1436591568] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:892; }","duration":"123.523448ms","start":"2026-08-11T08:29:07.50972Z","end":"2026-08-11T08:29:07.633244Z","steps":["trace[1436591568] 'agreement among raft nodes before linearized reading' (duration: 123.485527ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:29:07.633407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.266356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T08:29:07.633427Z","caller":"traceutil/trace.go:171","msg":"trace[2053677799] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:892; }","duration":"169.291487ms","start":"2026-08-11T08:29:07.46413Z","end":"2026-08-11T08:29:07.633422Z","steps":["trace[2053677799] 'agreement among raft nodes before linearized reading' (duration: 169.039139ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:29:07.915275Z","caller":"traceutil/trace.go:171","msg":"trace[120533812] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"182.627302ms","start":"2026-08-11T08:29:07.732626Z","end":"2026-08-11T08:29:07.915253Z","steps":["trace[120533812] 'process raft request' (duration: 113.805838ms)","trace[120533812] 'compare' (duration: 68.734281ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:29:20.060001Z","caller":"traceutil/trace.go:171","msg":"trace[356842560] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"339.37548ms","start":"2026-08-11T08:29:19.720586Z","end":"2026-08-11T08:29:20.059962Z","steps":["trace[356842560] 'process raft request' (duration: 339.161213ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:29:20.060254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:29:19.720512Z","time spent":"339.603997ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:29:20.218951Z","caller":"traceutil/trace.go:171","msg":"trace[870559403] linearizableReadLoop","detail":"{readStateIndex:975; appliedIndex:974; }","duration":"156.962043ms","start":"2026-08-11T08:29:20.061959Z","end":"2026-08-11T08:29:20.218921Z","steps":["trace[870559403] 'read index received' (duration: 146.720197ms)","trace[870559403] 'applied index is now lower than readState.Index' (duration: 10.240616ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:29:20.219026Z","caller":"traceutil/trace.go:171","msg":"trace[1085980590] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"258.874973ms","start":"2026-08-11T08:29:19.960113Z","end":"2026-08-11T08:29:20.218988Z","steps":["trace[1085980590] 'process raft request' (duration: 248.629496ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:29:20.219138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.16534ms","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-08-11T08:29:20.219165Z","caller":"traceutil/trace.go:171","msg":"trace[1141869714] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:941; }","duration":"157.245122ms","start":"2026-08-11T08:29:20.061911Z","end":"2026-08-11T08:29:20.219156Z","steps":["trace[1141869714] 'agreement among raft nodes before linearized reading' (duration: 157.104267ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:29:21.470781Z","caller":"traceutil/trace.go:171","msg":"trace[1745342209] linearizableReadLoop","detail":"{readStateIndex:980; appliedIndex:979; }","duration":"259.073399ms","start":"2026-08-11T08:29:21.211688Z","end":"2026-08-11T08:29:21.470761Z","steps":["trace[1745342209] 'read index received' (duration: 258.935745ms)","trace[1745342209] 'applied index is now lower than readState.Index' (duration: 136.784µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:29:21.470894Z","caller":"traceutil/trace.go:171","msg":"trace[1507512994] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"435.617288ms","start":"2026-08-11T08:29:21.035265Z","end":"2026-08-11T08:29:21.470882Z","steps":["trace[1507512994] 'process raft request' (duration: 435.36868ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:29:21.470971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:29:21.035239Z","time spent":"435.67451ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:29:21.471243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.550135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T08:29:21.47131Z","caller":"traceutil/trace.go:171","msg":"trace[595952487] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:946; }","duration":"259.657558ms","start":"2026-08-11T08:29:21.211638Z","end":"2026-08-11T08:29:21.471296Z","steps":["trace[595952487] 'agreement among raft nodes before linearized reading' (duration: 259.564325ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:29:40.884563Z","caller":"traceutil/trace.go:171","msg":"trace[786560688] linearizableReadLoop","detail":"{readStateIndex:1051; appliedIndex:1050; }","duration":"123.845988ms","start":"2026-08-11T08:29:40.760695Z","end":"2026-08-11T08:29:40.884541Z","steps":["trace[786560688] 'read index received' (duration: 123.669222ms)","trace[786560688] 'applied index is now lower than readState.Index' (duration: 175.876µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:29:40.88472Z","caller":"traceutil/trace.go:171","msg":"trace[1400895595] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"124.061465ms","start":"2026-08-11T08:29:40.76059Z","end":"2026-08-11T08:29:40.884652Z","steps":["trace[1400895595] 'process raft request' (duration: 123.818788ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:29:40.884787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.083356ms","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-08-11T08:29:40.884953Z","caller":"traceutil/trace.go:171","msg":"trace[869950038] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1013; }","duration":"124.297112ms","start":"2026-08-11T08:29:40.76064Z","end":"2026-08-11T08:29:40.884937Z","steps":["trace[869950038] 'agreement among raft nodes before linearized reading' (duration: 124.019244ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:29:40.885162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.472363ms","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-08-11T08:29:40.885323Z","caller":"traceutil/trace.go:171","msg":"trace[1476979829] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1013; }","duration":"105.69615ms","start":"2026-08-11T08:29:40.779613Z","end":"2026-08-11T08:29:40.885309Z","steps":["trace[1476979829] 'agreement among raft nodes before linearized reading' (duration: 105.145843ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:29:42.182714Z","caller":"traceutil/trace.go:171","msg":"trace[107886721] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"243.417161ms","start":"2026-08-11T08:29:41.939271Z","end":"2026-08-11T08:29:42.182688Z","steps":["trace[107886721] 'process raft request' (duration: 243.293267ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:29:42.298273Z","caller":"traceutil/trace.go:171","msg":"trace[852856332] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"110.811253ms","start":"2026-08-11T08:29:42.187435Z","end":"2026-08-11T08:29:42.298246Z","steps":["trace[852856332] 'process raft request' (duration: 23.434637ms)","trace[852856332] 'compare' (duration: 87.159799ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:29:42.570736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.064972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-11T08:29:42.570827Z","caller":"traceutil/trace.go:171","msg":"trace[1260227531] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1018; }","duration":"117.212017ms","start":"2026-08-11T08:29:42.453597Z","end":"2026-08-11T08:29:42.570809Z","steps":["trace[1260227531] 'range keys from in-memory index tree' (duration: 116.835744ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:29:42.921188Z","caller":"traceutil/trace.go:171","msg":"trace[1718330650] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"345.501154ms","start":"2026-08-11T08:29:42.575671Z","end":"2026-08-11T08:29:42.921172Z","steps":["trace[1718330650] 'process raft request' (duration: 345.37357ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:29:42.921298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:29:42.575654Z","time spent":"345.587467ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:29:43.167854Z","caller":"traceutil/trace.go:171","msg":"trace[365025215] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"242.768919ms","start":"2026-08-11T08:29:42.925052Z","end":"2026-08-11T08:29:43.167821Z","steps":["trace[365025215] 'process raft request' (duration: 231.538661ms)","trace[365025215] 'compare' (duration: 11.092664ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:29:43.175332Z","caller":"traceutil/trace.go:171","msg":"trace[1634793767] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"249.651369ms","start":"2026-08-11T08:29:42.925665Z","end":"2026-08-11T08:29:43.175317Z","steps":["trace[1634793767] 'process raft request' (duration: 249.533236ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:29:43.235475Z","caller":"traceutil/trace.go:171","msg":"trace[35677707] linearizableReadLoop","detail":"{readStateIndex:1059; appliedIndex:1057; }","duration":"296.354078ms","start":"2026-08-11T08:29:42.939085Z","end":"2026-08-11T08:29:43.23544Z","steps":["trace[35677707] 'read index received' (duration: 217.489164ms)","trace[35677707] 'applied index is now lower than readState.Index' (duration: 78.862664ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:29:43.235615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.500773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:29:43.235683Z","caller":"traceutil/trace.go:171","msg":"trace[45684872] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1021; }","duration":"296.633977ms","start":"2026-08-11T08:29:42.939032Z","end":"2026-08-11T08:29:43.235666Z","steps":["trace[45684872] 'agreement among raft nodes before linearized reading' (duration: 296.494412ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:29:43.235898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.005489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:29:43.236023Z","caller":"traceutil/trace.go:171","msg":"trace[298567] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1021; }","duration":"116.192374ms","start":"2026-08-11T08:29:43.119809Z","end":"2026-08-11T08:29:43.236002Z","steps":["trace[298567] 'agreement among raft nodes before linearized reading' (duration: 115.988218ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:29:43.236108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.129469ms","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-08-11T08:29:43.236279Z","caller":"traceutil/trace.go:171","msg":"trace[1238951574] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1021; }","duration":"274.228983ms","start":"2026-08-11T08:29:42.961925Z","end":"2026-08-11T08:29:43.236154Z","steps":["trace[1238951574] 'agreement among raft nodes before linearized reading' (duration: 273.752788ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:29:59.761278Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2834347393362663068,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-11T08:30:00.119378Z","caller":"traceutil/trace.go:171","msg":"trace[518919857] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"876.91583ms","start":"2026-08-11T08:29:59.242443Z","end":"2026-08-11T08:30:00.119358Z","steps":["trace[518919857] 'process raft request' (duration: 876.799336ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:00.119538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:29:59.242423Z","time spent":"877.010904ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:30:00.846077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:00.198954Z","time spent":"647.114858ms","remote":"127.0.0.1:60162","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-08-11T08:30:00.846388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.2701ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T08:30:00.846545Z","caller":"traceutil/trace.go:171","msg":"trace[1644880362] transaction","detail":"{read_only:false; response_revision:1125; number_of_response:1; }","duration":"1.601443131s","start":"2026-08-11T08:29:59.245075Z","end":"2026-08-11T08:30:00.846518Z","steps":["trace[1644880362] 'process raft request' (duration: 1.397955294s)","trace[1644880362] 'compare' (duration: 203.102325ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:30:00.846577Z","caller":"traceutil/trace.go:171","msg":"trace[1281459437] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"385.430938ms","start":"2026-08-11T08:30:00.461129Z","end":"2026-08-11T08:30:00.84656Z","steps":["trace[1281459437] 'process raft request' (duration: 385.338205ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:00.846631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:00.461099Z","time spent":"385.508021ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:30:00.846653Z","caller":"traceutil/trace.go:171","msg":"trace[1105603561] linearizableReadLoop","detail":"{readStateIndex:1168; appliedIndex:1166; }","duration":"1.585590686s","start":"2026-08-11T08:29:59.261035Z","end":"2026-08-11T08:30:00.846625Z","steps":["trace[1105603561] 'read index received' (duration: 858.219435ms)","trace[1105603561] 'applied index is now lower than readState.Index' (duration: 727.369141ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:30:00.846682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:29:59.245064Z","time spent":"1.601542285s","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:30:00.846823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.337201202s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:30:00.846848Z","caller":"traceutil/trace.go:171","msg":"trace[178448293] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1126; }","duration":"1.337264783s","start":"2026-08-11T08:29:59.509576Z","end":"2026-08-11T08:30:00.84684Z","steps":["trace[178448293] 'agreement among raft nodes before linearized reading' (duration: 1.337223522s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:00.846869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:29:59.509556Z","time spent":"1.337308735s","remote":"127.0.0.1:60222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-11T08:30:00.84684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.585776313s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T08:30:00.846921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.456015972s","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-08-11T08:30:00.846902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.359266ms","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-08-11T08:30:00.846933Z","caller":"traceutil/trace.go:171","msg":"trace[1603419166] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1126; }","duration":"1.585895016s","start":"2026-08-11T08:29:59.261011Z","end":"2026-08-11T08:30:00.846906Z","steps":["trace[1603419166] 'agreement among raft nodes before linearized reading' (duration: 1.58570682s)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:30:00.846957Z","caller":"traceutil/trace.go:171","msg":"trace[2066552477] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1126; }","duration":"1.456089435s","start":"2026-08-11T08:29:59.390855Z","end":"2026-08-11T08:30:00.846945Z","steps":["trace[2066552477] 'agreement among raft nodes before linearized reading' (duration: 1.456033963s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:00.84697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:29:59.261001Z","time spent":"1.585962859s","remote":"127.0.0.1:55000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-08-11T08:30:00.846975Z","caller":"traceutil/trace.go:171","msg":"trace[862273542] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1126; }","duration":"391.488081ms","start":"2026-08-11T08:30:00.455469Z","end":"2026-08-11T08:30:00.846958Z","steps":["trace[862273542] 'agreement among raft nodes before linearized reading' (duration: 391.314975ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:00.846987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.067612401s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T08:30:00.846992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:29:59.390831Z","time spent":"1.456152167s","remote":"127.0.0.1:37592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-11T08:30:00.847006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:00.455456Z","time spent":"391.544122ms","remote":"127.0.0.1:34310","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-08-11T08:30:00.847013Z","caller":"traceutil/trace.go:171","msg":"trace[68117656] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1126; }","duration":"1.067669752s","start":"2026-08-11T08:29:59.779335Z","end":"2026-08-11T08:30:00.847004Z","steps":["trace[68117656] 'agreement among raft nodes before linearized reading' (duration: 1.067632821s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:00.847035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:29:59.779311Z","time spent":"1.067718064s","remote":"127.0.0.1:55174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-08-11T08:30:00.847095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.820629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-11T08:30:00.846865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.529981236s","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-08-11T08:30:00.847138Z","caller":"traceutil/trace.go:171","msg":"trace[1168474685] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1126; }","duration":"286.900822ms","start":"2026-08-11T08:30:00.560225Z","end":"2026-08-11T08:30:00.847126Z","steps":["trace[1168474685] 'agreement among raft nodes before linearized reading' (duration: 286.82941ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:30:00.847145Z","caller":"traceutil/trace.go:171","msg":"trace[1012233595] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1126; }","duration":"1.530319228s","start":"2026-08-11T08:29:59.316818Z","end":"2026-08-11T08:30:00.847137Z","steps":["trace[1012233595] 'agreement among raft nodes before linearized reading' (duration: 1.529939026s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:00.847238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:29:59.316805Z","time spent":"1.530425241s","remote":"127.0.0.1:34310","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-08-11T08:30:19.221789Z","caller":"traceutil/trace.go:171","msg":"trace[130923648] linearizableReadLoop","detail":"{readStateIndex:1252; appliedIndex:1251; }","duration":"298.287704ms","start":"2026-08-11T08:30:18.923466Z","end":"2026-08-11T08:30:19.221753Z","steps":["trace[130923648] 'read index received' (duration: 298.15538ms)","trace[130923648] 'applied index is now lower than readState.Index' (duration: 130.774µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:30:19.221929Z","caller":"traceutil/trace.go:171","msg":"trace[1917435746] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"319.365696ms","start":"2026-08-11T08:30:18.902523Z","end":"2026-08-11T08:30:19.221889Z","steps":["trace[1917435746] 'process raft request' (duration: 318.992924ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:19.222161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.658457ms","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-08-11T08:30:19.222429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:18.902492Z","time spent":"319.82565ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:30:19.222463Z","caller":"traceutil/trace.go:171","msg":"trace[183043142] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1204; }","duration":"298.993037ms","start":"2026-08-11T08:30:18.923422Z","end":"2026-08-11T08:30:19.222415Z","steps":["trace[183043142] 'agreement among raft nodes before linearized reading' (duration: 298.489921ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:19.674227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.394641ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T08:30:19.674364Z","caller":"traceutil/trace.go:171","msg":"trace[61767217] linearizableReadLoop","detail":"{readStateIndex:1253; appliedIndex:1252; }","duration":"452.10666ms","start":"2026-08-11T08:30:19.222239Z","end":"2026-08-11T08:30:19.674346Z","steps":["trace[61767217] 'read index received' (duration: 91.511452ms)","trace[61767217] 'applied index is now lower than readState.Index' (duration: 360.593558ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:30:19.674518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.779725ms","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-08-11T08:30:19.674616Z","caller":"traceutil/trace.go:171","msg":"trace[1997542840] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1205; }","duration":"580.910799ms","start":"2026-08-11T08:30:19.093677Z","end":"2026-08-11T08:30:19.674588Z","steps":["trace[1997542840] 'agreement among raft nodes before linearized reading' (duration: 580.681932ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:19.674687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:19.093658Z","time spent":"581.013723ms","remote":"127.0.0.1:34310","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-08-11T08:30:19.674718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.132501ms","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-08-11T08:30:19.674756Z","caller":"traceutil/trace.go:171","msg":"trace[2080285905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1205; }","duration":"742.192223ms","start":"2026-08-11T08:30:18.932552Z","end":"2026-08-11T08:30:19.674744Z","steps":["trace[2080285905] 'agreement among raft nodes before linearized reading' (duration: 742.103721ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:19.674793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:18.932539Z","time spent":"742.245555ms","remote":"127.0.0.1:34310","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-08-11T08:30:19.67463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"738.911879ms","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-08-11T08:30:19.674869Z","caller":"traceutil/trace.go:171","msg":"trace[588683827] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"519.787644ms","start":"2026-08-11T08:30:19.15505Z","end":"2026-08-11T08:30:19.674838Z","steps":["trace[588683827] 'process raft request' (duration: 158.685691ms)","trace[588683827] 'compare' (duration: 360.089051ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:30:19.674888Z","caller":"traceutil/trace.go:171","msg":"trace[1432198208] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1205; }","duration":"739.207218ms","start":"2026-08-11T08:30:18.93566Z","end":"2026-08-11T08:30:19.674868Z","steps":["trace[1432198208] 'agreement among raft nodes before linearized reading' (duration: 738.762804ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:19.674962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:18.935627Z","time spent":"739.316602ms","remote":"127.0.0.1:34310","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-08-11T08:30:19.67504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:19.155027Z","time spent":"519.914629ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:30:19.698138Z","caller":"traceutil/trace.go:171","msg":"trace[290131905] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"471.224478ms","start":"2026-08-11T08:30:19.226885Z","end":"2026-08-11T08:30:19.698109Z","steps":["trace[290131905] 'process raft request' (duration: 471.010231ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:19.698146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.717531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:30:19.698232Z","caller":"traceutil/trace.go:171","msg":"trace[1658855648] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1206; }","duration":"185.864765ms","start":"2026-08-11T08:30:19.512346Z","end":"2026-08-11T08:30:19.69821Z","steps":["trace[1658855648] 'agreement among raft nodes before linearized reading' (duration: 185.69467ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:19.698289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:19.226857Z","time spent":"471.347032ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:30:21.680323Z","caller":"traceutil/trace.go:171","msg":"trace[907273095] linearizableReadLoop","detail":"{readStateIndex:1266; appliedIndex:1265; }","duration":"317.189136ms","start":"2026-08-11T08:30:21.363104Z","end":"2026-08-11T08:30:21.680293Z","steps":["trace[907273095] 'read index received' (duration: 316.936608ms)","trace[907273095] 'applied index is now lower than readState.Index' (duration: 251.608µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:30:21.68036Z","caller":"traceutil/trace.go:171","msg":"trace[1306230610] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"452.603366ms","start":"2026-08-11T08:30:21.22773Z","end":"2026-08-11T08:30:21.680333Z","steps":["trace[1306230610] 'process raft request' (duration: 452.399389ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:21.680534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:21.227701Z","time spent":"452.72511ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:30:21.680587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.652988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T08:30:21.680545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.417043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:30:21.680742Z","caller":"traceutil/trace.go:171","msg":"trace[1414884944] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1218; }","duration":"168.786602ms","start":"2026-08-11T08:30:21.511877Z","end":"2026-08-11T08:30:21.680663Z","steps":["trace[1414884944] 'agreement among raft nodes before linearized reading' (duration: 168.632818ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:30:21.680788Z","caller":"traceutil/trace.go:171","msg":"trace[1336353122] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1218; }","duration":"317.679891ms","start":"2026-08-11T08:30:21.363068Z","end":"2026-08-11T08:30:21.680748Z","steps":["trace[1336353122] 'agreement among raft nodes before linearized reading' (duration: 317.367151ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:21.680864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:21.363051Z","time spent":"317.772805ms","remote":"127.0.0.1:60222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-11T08:30:21.924642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.733499ms","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-08-11T08:30:21.924717Z","caller":"traceutil/trace.go:171","msg":"trace[891133844] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1218; }","duration":"222.863854ms","start":"2026-08-11T08:30:21.701838Z","end":"2026-08-11T08:30:21.924702Z","steps":["trace[891133844] 'range keys from in-memory index tree' (duration: 222.536323ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:21.924927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.356531ms","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-08-11T08:30:21.924949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.480125ms","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-08-11T08:30:21.925032Z","caller":"traceutil/trace.go:171","msg":"trace[234344013] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1218; }","duration":"191.451754ms","start":"2026-08-11T08:30:21.733539Z","end":"2026-08-11T08:30:21.92499Z","steps":["trace[234344013] 'range keys from in-memory index tree' (duration: 190.865165ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:30:21.925065Z","caller":"traceutil/trace.go:171","msg":"trace[342091885] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1218; }","duration":"191.665721ms","start":"2026-08-11T08:30:21.733372Z","end":"2026-08-11T08:30:21.925038Z","steps":["trace[342091885] 'range keys from in-memory index tree' (duration: 191.02767ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:21.925291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.893486ms","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-08-11T08:30:21.925528Z","caller":"traceutil/trace.go:171","msg":"trace[1465717447] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1218; }","duration":"191.172835ms","start":"2026-08-11T08:30:21.734337Z","end":"2026-08-11T08:30:21.92551Z","steps":["trace[1465717447] 'range keys from in-memory index tree' (duration: 189.899115ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:30:22.057459Z","caller":"traceutil/trace.go:171","msg":"trace[489946906] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"125.05432ms","start":"2026-08-11T08:30:21.93237Z","end":"2026-08-11T08:30:22.057424Z","steps":["trace[489946906] 'process raft request' (duration: 125.000719ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:30:22.057497Z","caller":"traceutil/trace.go:171","msg":"trace[855038467] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"126.9283ms","start":"2026-08-11T08:30:21.930532Z","end":"2026-08-11T08:30:22.05746Z","steps":["trace[855038467] 'process raft request' (duration: 108.364159ms)","trace[855038467] 'compare' (duration: 18.24367ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:30:22.057665Z","caller":"traceutil/trace.go:171","msg":"trace[307721219] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"125.604357ms","start":"2026-08-11T08:30:21.932035Z","end":"2026-08-11T08:30:22.057639Z","steps":["trace[307721219] 'process raft request' (duration: 125.284867ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:23.472365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.314615ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-11T08:30:25.853288Z","caller":"traceutil/trace.go:171","msg":"trace[438828578] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"101.941926ms","start":"2026-08-11T08:30:25.751316Z","end":"2026-08-11T08:30:25.853258Z","steps":["trace[438828578] 'process raft request' (duration: 101.76789ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:26.876438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.032749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:30:26.876532Z","caller":"traceutil/trace.go:171","msg":"trace[1704402508] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1243; }","duration":"365.167433ms","start":"2026-08-11T08:30:26.511342Z","end":"2026-08-11T08:30:26.876509Z","steps":["trace[1704402508] 'range keys from in-memory index tree' (duration: 364.933316ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:26.876784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:26.511322Z","time spent":"365.438221ms","remote":"127.0.0.1:60222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-11T08:30:26.876809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.350308ms","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-08-11T08:30:26.876908Z","caller":"traceutil/trace.go:171","msg":"trace[1516255732] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1243; }","duration":"523.491552ms","start":"2026-08-11T08:30:26.353393Z","end":"2026-08-11T08:30:26.876885Z","steps":["trace[1516255732] 'range keys from in-memory index tree' (duration: 523.164952ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:30:26.876969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:30:26.353359Z","time spent":"523.596336ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-11T08:30:27.101016Z","caller":"traceutil/trace.go:171","msg":"trace[1525971636] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"219.278009ms","start":"2026-08-11T08:30:26.881718Z","end":"2026-08-11T08:30:27.100996Z","steps":["trace[1525971636] 'process raft request' (duration: 219.160576ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:30:29.264449Z","caller":"traceutil/trace.go:171","msg":"trace[1474140138] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"156.177231ms","start":"2026-08-11T08:30:29.108247Z","end":"2026-08-11T08:30:29.264424Z","steps":["trace[1474140138] 'process raft request' (duration: 155.53041ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:33:24.953899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.775395ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-11T08:33:24.953997Z","caller":"traceutil/trace.go:171","msg":"trace[1811745841] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"111.886376ms","start":"2026-08-11T08:33:24.842101Z","end":"2026-08-11T08:33:24.953987Z","steps":["trace[1811745841] 'compare' (duration: 108.668472ms)"],"step_count":1}