{"level":"warn","ts":"2026-07-17T05:30:03.54069Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-17T05:30:03.540778Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4: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.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4: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-07-17T05:30:03.540843Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-17T05:30:03.540858Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-07-17T05:30:03.54088Z","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-07-17T05:30:03.54151Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]} {"level":"info","ts":"2026-07-17T05:30:03.541604Z","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":16,"max-cpu-available":16,"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.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4: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-07-17T05:30:03.545572Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.76146ms"} {"level":"info","ts":"2026-07-17T05:30:03.55585Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"} {"level":"info","ts":"2026-07-17T05:30:03.555955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"} {"level":"info","ts":"2026-07-17T05:30:03.555981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"} {"level":"info","ts":"2026-07-17T05:30:03.555997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-17T05:30:03.556007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"} {"level":"info","ts":"2026-07-17T05:30:03.556055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"warn","ts":"2026-07-17T05:30:03.562368Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-17T05:30:03.564319Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-17T05:30:03.565729Z","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-07-17T05:30:03.568219Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-17T05:30:03.568402Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-17T05:30:03.568567Z","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-07-17T05:30:03.568666Z","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-07-17T05:30:03.568684Z","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-07-17T05:30:03.571131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"info","ts":"2026-07-17T05:30:03.571246Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-07-17T05:30:03.573842Z","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-07-17T05:30:03.573957Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-07-17T05:30:03.574Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-07-17T05:30:03.574311Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-17T05:30:03.574369Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-17T05:30:03.657348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"} {"level":"info","ts":"2026-07-17T05:30:03.657396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"} {"level":"info","ts":"2026-07-17T05:30:03.657436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"} {"level":"info","ts":"2026-07-17T05:30:03.65746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"} {"level":"info","ts":"2026-07-17T05:30:03.657471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-07-17T05:30:03.657488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"} {"level":"info","ts":"2026-07-17T05:30:03.65751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-07-17T05:30:03.658842Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"} {"level":"info","ts":"2026-07-17T05:30:03.658875Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-17T05:30:03.65951Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T05:30:03.659796Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-17T05:30:03.661182Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-17T05:30:03.661313Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-17T05:30:03.661932Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T05:30:03.662048Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T05:30:03.662122Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T05:30:03.662701Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-17T05:30:03.663656Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"} {"level":"info","ts":"2026-07-17T05:30:07.123633Z","caller":"traceutil/trace.go:171","msg":"trace[916645302] transaction","detail":"{read_only:false; response_revision:161; number_of_response:1; }","duration":"152.670655ms","start":"2026-07-17T05:30:06.970938Z","end":"2026-07-17T05:30:07.123608Z","steps":["trace[916645302] 'process raft request' (duration: 141.792633ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:20.625364Z","caller":"traceutil/trace.go:171","msg":"trace[2048294989] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"130.021396ms","start":"2026-07-17T05:30:20.495293Z","end":"2026-07-17T05:30:20.625314Z","steps":["trace[2048294989] 'process raft request' (duration: 129.788949ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:39.379707Z","caller":"traceutil/trace.go:171","msg":"trace[1592330566] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"110.183132ms","start":"2026-07-17T05:30:39.269495Z","end":"2026-07-17T05:30:39.379679Z","steps":["trace[1592330566] 'process raft request' (duration: 23.157563ms)","trace[1592330566] 'compare' (duration: 86.890406ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:30:39.380076Z","caller":"traceutil/trace.go:171","msg":"trace[2033203435] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"104.941962ms","start":"2026-07-17T05:30:39.275101Z","end":"2026-07-17T05:30:39.380043Z","steps":["trace[2033203435] 'process raft request' (duration: 104.794657ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:30:42.296251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.149275ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-17T05:30:42.296398Z","caller":"traceutil/trace.go:171","msg":"trace[323205063] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"581.7104ms","start":"2026-07-17T05:30:41.714669Z","end":"2026-07-17T05:30:42.29638Z","steps":["trace[323205063] 'process raft request' (duration: 465.873316ms)","trace[323205063] 'compare' (duration: 114.963811ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:30:42.296464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:30:41.714639Z","time spent":"581.793492ms","remote":"127.0.0.1:33158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T05:30:42.301011Z","caller":"traceutil/trace.go:171","msg":"trace[2083067759] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"582.023669ms","start":"2026-07-17T05:30:41.71893Z","end":"2026-07-17T05:30:42.300953Z","steps":["trace[2083067759] 'process raft request' (duration: 581.68468ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:42.301131Z","caller":"traceutil/trace.go:171","msg":"trace[1264092592] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:597; }","duration":"471.741673ms","start":"2026-07-17T05:30:41.829358Z","end":"2026-07-17T05:30:42.301099Z","steps":["trace[1264092592] 'read index received' (duration: 351.077939ms)","trace[1264092592] 'applied index is now lower than readState.Index' (duration: 120.661534ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:30:42.301214Z","caller":"traceutil/trace.go:171","msg":"trace[330922606] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"577.422955ms","start":"2026-07-17T05:30:41.72376Z","end":"2026-07-17T05:30:42.301183Z","steps":["trace[330922606] 'process raft request' (duration: 577.092237ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:30:42.301311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:30:41.723745Z","time spent":"577.525728ms","remote":"127.0.0.1:33158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":73770,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-17T05:30:42.301338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.650367ms","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-07-17T05:30:42.301286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:30:41.718882Z","time spent":"582.272186ms","remote":"127.0.0.1:33158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65412,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T05:30:42.301376Z","caller":"traceutil/trace.go:171","msg":"trace[1203870946] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:581; }","duration":"238.741439ms","start":"2026-07-17T05:30:42.062621Z","end":"2026-07-17T05:30:42.301363Z","steps":["trace[1203870946] 'agreement among raft nodes before linearized reading' (duration: 238.624966ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:30:42.301357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.98201ms","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-07-17T05:30:42.301461Z","caller":"traceutil/trace.go:171","msg":"trace[1102706863] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:581; }","duration":"472.131364ms","start":"2026-07-17T05:30:41.829294Z","end":"2026-07-17T05:30:42.301426Z","steps":["trace[1102706863] 'agreement among raft nodes before linearized reading' (duration: 471.922538ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:30:42.301527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:30:41.829272Z","time spent":"472.241998ms","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-17T05:30:48.407661Z","caller":"traceutil/trace.go:171","msg":"trace[1714131488] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"286.593125ms","start":"2026-07-17T05:30:48.121027Z","end":"2026-07-17T05:30:48.40762Z","steps":["trace[1714131488] 'process raft request' (duration: 284.756026ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:49.039964Z","caller":"traceutil/trace.go:171","msg":"trace[1188697713] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"139.205333ms","start":"2026-07-17T05:30:48.900723Z","end":"2026-07-17T05:30:49.039928Z","steps":["trace[1188697713] 'read index received' (duration: 138.266328ms)","trace[1188697713] 'applied index is now lower than readState.Index' (duration: 937.485µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:30:49.040063Z","caller":"traceutil/trace.go:171","msg":"trace[434408890] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"226.856719ms","start":"2026-07-17T05:30:48.813131Z","end":"2026-07-17T05:30:49.039988Z","steps":["trace[434408890] 'process raft request' (duration: 226.096049ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:30:49.040298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.541652ms","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-07-17T05:30:49.040424Z","caller":"traceutil/trace.go:171","msg":"trace[785334928] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:625; }","duration":"139.731346ms","start":"2026-07-17T05:30:48.900661Z","end":"2026-07-17T05:30:49.040392Z","steps":["trace[785334928] 'agreement among raft nodes before linearized reading' (duration: 139.433379ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:30:49.527055Z","caller":"traceutil/trace.go:171","msg":"trace[766883907] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"342.420311ms","start":"2026-07-17T05:30:49.184607Z","end":"2026-07-17T05:30:49.527027Z","steps":["trace[766883907] 'read index received' (duration: 340.81467ms)","trace[766883907] 'applied index is now lower than readState.Index' (duration: 1.604561ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:30:49.527167Z","caller":"traceutil/trace.go:171","msg":"trace[1302487251] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"420.193025ms","start":"2026-07-17T05:30:49.106925Z","end":"2026-07-17T05:30:49.527118Z","steps":["trace[1302487251] 'process raft request' (duration: 418.542253ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:30:49.527274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.644767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-b5jvb\" ","response":"range_response_count:1 size:16957"} {"level":"info","ts":"2026-07-17T05:30:49.527318Z","caller":"traceutil/trace.go:171","msg":"trace[1273761257] range","detail":"{range_begin:/registry/pods/kube-system/cilium-b5jvb; range_end:; response_count:1; response_revision:627; }","duration":"342.74984ms","start":"2026-07-17T05:30:49.184557Z","end":"2026-07-17T05:30:49.527307Z","steps":["trace[1273761257] 'agreement among raft nodes before linearized reading' (duration: 342.568695ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:30:49.527356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:30:49.184535Z","time spent":"342.812902ms","remote":"127.0.0.1:33284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16980,"request content":"key:\"/registry/pods/kube-system/cilium-b5jvb\" "} {"level":"warn","ts":"2026-07-17T05:30:49.527344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:30:49.106894Z","time spent":"420.365411ms","remote":"127.0.0.1:33432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T05:30:49.739105Z","caller":"traceutil/trace.go:171","msg":"trace[2059321947] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"198.628247ms","start":"2026-07-17T05:30:49.540453Z","end":"2026-07-17T05:30:49.739081Z","steps":["trace[2059321947] 'process raft request' (duration: 198.468773ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:31:05.563575Z","caller":"traceutil/trace.go:171","msg":"trace[102750162] linearizableReadLoop","detail":"{readStateIndex:824; appliedIndex:823; }","duration":"275.650827ms","start":"2026-07-17T05:31:05.287896Z","end":"2026-07-17T05:31:05.563546Z","steps":["trace[102750162] 'read index received' (duration: 275.42436ms)","trace[102750162] 'applied index is now lower than readState.Index' (duration: 225.167µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:31:05.563759Z","caller":"traceutil/trace.go:171","msg":"trace[984508092] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"397.773349ms","start":"2026-07-17T05:31:05.165854Z","end":"2026-07-17T05:31:05.563627Z","steps":["trace[984508092] 'process raft request' (duration: 397.530492ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:31:05.5638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.887473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-6dzgr\" ","response":"range_response_count:1 size:3963"} {"level":"warn","ts":"2026-07-17T05:31:05.563957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:31:05.165824Z","time spent":"398.043106ms","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T05:31:05.564057Z","caller":"traceutil/trace.go:171","msg":"trace[505839066] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-6dzgr; range_end:; response_count:1; response_revision:798; }","duration":"276.14781ms","start":"2026-07-17T05:31:05.287846Z","end":"2026-07-17T05:31:05.563994Z","steps":["trace[505839066] 'agreement among raft nodes before linearized reading' (duration: 275.815292ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:31:38.893022Z","caller":"traceutil/trace.go:171","msg":"trace[1046142882] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"198.558875ms","start":"2026-07-17T05:31:38.694438Z","end":"2026-07-17T05:31:38.892997Z","steps":["trace[1046142882] 'process raft request' (duration: 198.409011ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:31:38.894525Z","caller":"traceutil/trace.go:171","msg":"trace[1539481577] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"198.468993ms","start":"2026-07-17T05:31:38.696028Z","end":"2026-07-17T05:31:38.894497Z","steps":["trace[1539481577] 'process raft request' (duration: 198.228536ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:31:38.894605Z","caller":"traceutil/trace.go:171","msg":"trace[1022915577] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"197.660531ms","start":"2026-07-17T05:31:38.696907Z","end":"2026-07-17T05:31:38.894568Z","steps":["trace[1022915577] 'process raft request' (duration: 197.448816ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:24.387089Z","caller":"traceutil/trace.go:171","msg":"trace[1778175579] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"113.602873ms","start":"2026-07-17T05:32:24.273448Z","end":"2026-07-17T05:32:24.387051Z","steps":["trace[1778175579] 'process raft request' (duration: 111.698702ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:24.401436Z","caller":"traceutil/trace.go:171","msg":"trace[969001003] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"123.251713ms","start":"2026-07-17T05:32:24.278158Z","end":"2026-07-17T05:32:24.40141Z","steps":["trace[969001003] 'process raft request' (duration: 122.985035ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:24.589979Z","caller":"traceutil/trace.go:171","msg":"trace[1489891919] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"101.142367ms","start":"2026-07-17T05:32:24.488793Z","end":"2026-07-17T05:32:24.589935Z","steps":["trace[1489891919] 'process raft request' (duration: 70.689336ms)","trace[1489891919] 'compare' (duration: 30.144113ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:32:24.74107Z","caller":"traceutil/trace.go:171","msg":"trace[1298089714] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"135.410851ms","start":"2026-07-17T05:32:24.605622Z","end":"2026-07-17T05:32:24.741033Z","steps":["trace[1298089714] 'process raft request' (duration: 135.35024ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:24.741119Z","caller":"traceutil/trace.go:171","msg":"trace[1778610282] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"136.827019ms","start":"2026-07-17T05:32:24.604231Z","end":"2026-07-17T05:32:24.741058Z","steps":["trace[1778610282] 'process raft request' (duration: 93.82942ms)","trace[1778610282] 'compare' (duration: 42.632448ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:32:24.741084Z","caller":"traceutil/trace.go:171","msg":"trace[1920345333] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"136.747216ms","start":"2026-07-17T05:32:24.604296Z","end":"2026-07-17T05:32:24.741043Z","steps":["trace[1920345333] 'process raft request' (duration: 136.621303ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:24.776429Z","caller":"traceutil/trace.go:171","msg":"trace[892022660] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"124.485096ms","start":"2026-07-17T05:32:24.651888Z","end":"2026-07-17T05:32:24.776373Z","steps":["trace[892022660] 'process raft request' (duration: 124.183858ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:24.776495Z","caller":"traceutil/trace.go:171","msg":"trace[1567742902] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"123.874071ms","start":"2026-07-17T05:32:24.652583Z","end":"2026-07-17T05:32:24.776457Z","steps":["trace[1567742902] 'process raft request' (duration: 123.673235ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:24.776553Z","caller":"traceutil/trace.go:171","msg":"trace[2091350855] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"121.937689ms","start":"2026-07-17T05:32:24.654563Z","end":"2026-07-17T05:32:24.776501Z","steps":["trace[2091350855] 'process raft request' (duration: 121.769664ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:24.776696Z","caller":"traceutil/trace.go:171","msg":"trace[341256977] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"120.278064ms","start":"2026-07-17T05:32:24.656368Z","end":"2026-07-17T05:32:24.776646Z","steps":["trace[341256977] 'process raft request' (duration: 120.019176ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:24.863864Z","caller":"traceutil/trace.go:171","msg":"trace[793993171] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"117.090697ms","start":"2026-07-17T05:32:24.74676Z","end":"2026-07-17T05:32:24.863851Z","steps":["trace[793993171] 'process raft request' (duration: 116.990745ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:24.864004Z","caller":"traceutil/trace.go:171","msg":"trace[1499300264] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"117.388736ms","start":"2026-07-17T05:32:24.746565Z","end":"2026-07-17T05:32:24.863954Z","steps":["trace[1499300264] 'process raft request' (duration: 117.086687ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:24.864114Z","caller":"traceutil/trace.go:171","msg":"trace[1592494786] linearizableReadLoop","detail":"{readStateIndex:1913; appliedIndex:1907; }","duration":"116.330417ms","start":"2026-07-17T05:32:24.747462Z","end":"2026-07-17T05:32:24.863792Z","steps":["trace[1592494786] 'read index received' (duration: 28.623642ms)","trace[1592494786] 'applied index is now lower than readState.Index' (duration: 87.706155ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:32:24.864326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.857421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:122605"} {"level":"info","ts":"2026-07-17T05:32:24.864371Z","caller":"traceutil/trace.go:171","msg":"trace[1402838904] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1843; }","duration":"116.947203ms","start":"2026-07-17T05:32:24.747402Z","end":"2026-07-17T05:32:24.864349Z","steps":["trace[1402838904] 'agreement among raft nodes before linearized reading' (duration: 116.767138ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:24.884787Z","caller":"traceutil/trace.go:171","msg":"trace[224691674] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"101.61925ms","start":"2026-07-17T05:32:24.783113Z","end":"2026-07-17T05:32:24.884733Z","steps":["trace[224691674] 'process raft request' (duration: 101.301581ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:25.031215Z","caller":"traceutil/trace.go:171","msg":"trace[1859425532] linearizableReadLoop","detail":"{readStateIndex:1915; appliedIndex:1914; }","duration":"141.623878ms","start":"2026-07-17T05:32:24.889557Z","end":"2026-07-17T05:32:25.031181Z","steps":["trace[1859425532] 'read index received' (duration: 105.693819ms)","trace[1859425532] 'applied index is now lower than readState.Index' (duration: 35.928999ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:32:25.031257Z","caller":"traceutil/trace.go:171","msg":"trace[1804187375] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"163.480018ms","start":"2026-07-17T05:32:24.867729Z","end":"2026-07-17T05:32:25.031209Z","steps":["trace[1804187375] 'process raft request' (duration: 127.492618ms)","trace[1804187375] 'compare' (duration: 35.777664ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:32:25.03148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.890026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:7079"} {"level":"info","ts":"2026-07-17T05:32:25.031526Z","caller":"traceutil/trace.go:171","msg":"trace[1755798399] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1845; }","duration":"142.016909ms","start":"2026-07-17T05:32:24.889499Z","end":"2026-07-17T05:32:25.031516Z","steps":["trace[1755798399] 'agreement among raft nodes before linearized reading' (duration: 141.802684ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:25.071588Z","caller":"traceutil/trace.go:171","msg":"trace[1343232868] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"161.685869ms","start":"2026-07-17T05:32:24.909876Z","end":"2026-07-17T05:32:25.071562Z","steps":["trace[1343232868] 'process raft request' (duration: 161.598517ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:25.071681Z","caller":"traceutil/trace.go:171","msg":"trace[952424588] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"181.895435ms","start":"2026-07-17T05:32:24.889729Z","end":"2026-07-17T05:32:25.071625Z","steps":["trace[952424588] 'process raft request' (duration: 181.603417ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:25.251387Z","caller":"traceutil/trace.go:171","msg":"trace[1561309639] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"212.549711ms","start":"2026-07-17T05:32:25.038794Z","end":"2026-07-17T05:32:25.251344Z","steps":["trace[1561309639] 'process raft request' (duration: 212.429318ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:25.251481Z","caller":"traceutil/trace.go:171","msg":"trace[445013858] linearizableReadLoop","detail":"{readStateIndex:1919; appliedIndex:1915; }","duration":"211.488822ms","start":"2026-07-17T05:32:25.03998Z","end":"2026-07-17T05:32:25.251469Z","steps":["trace[445013858] 'read index received' (duration: 31.447098ms)","trace[445013858] 'applied index is now lower than readState.Index' (duration: 180.040154ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:32:25.251462Z","caller":"traceutil/trace.go:171","msg":"trace[387953280] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"138.418883ms","start":"2026-07-17T05:32:25.113005Z","end":"2026-07-17T05:32:25.251424Z","steps":["trace[387953280] 'process raft request' (duration: 138.365322ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:25.251633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.631686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/local-path-storage/\" range_end:\"/registry/limitranges/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T05:32:25.251415Z","caller":"traceutil/trace.go:171","msg":"trace[180900346] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"218.113012ms","start":"2026-07-17T05:32:25.033271Z","end":"2026-07-17T05:32:25.251384Z","steps":["trace[180900346] 'process raft request' (duration: 131.089146ms)","trace[180900346] 'compare' (duration: 86.625265ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:32:25.251677Z","caller":"traceutil/trace.go:171","msg":"trace[854182216] range","detail":"{range_begin:/registry/limitranges/local-path-storage/; range_end:/registry/limitranges/local-path-storage0; response_count:0; response_revision:1851; }","duration":"211.723478ms","start":"2026-07-17T05:32:25.039942Z","end":"2026-07-17T05:32:25.251666Z","steps":["trace[854182216] 'agreement among raft nodes before linearized reading' (duration: 211.622986ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:25.251805Z","caller":"traceutil/trace.go:171","msg":"trace[1787067747] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"175.478091ms","start":"2026-07-17T05:32:25.076285Z","end":"2026-07-17T05:32:25.251763Z","steps":["trace[1787067747] 'process raft request' (duration: 175.021129ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:25.251923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.10396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:3963"} {"level":"info","ts":"2026-07-17T05:32:25.251959Z","caller":"traceutil/trace.go:171","msg":"trace[883964554] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1851; }","duration":"143.143381ms","start":"2026-07-17T05:32:25.108806Z","end":"2026-07-17T05:32:25.25195Z","steps":["trace[883964554] 'agreement among raft nodes before linearized reading' (duration: 143.006377ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:25.252124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.900475ms","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-07-17T05:32:25.25214Z","caller":"traceutil/trace.go:171","msg":"trace[2119430656] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1851; }","duration":"102.973707ms","start":"2026-07-17T05:32:25.149161Z","end":"2026-07-17T05:32:25.252135Z","steps":["trace[2119430656] 'agreement among raft nodes before linearized reading' (duration: 102.916796ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:25.252282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.395569ms","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-07-17T05:32:25.252298Z","caller":"traceutil/trace.go:171","msg":"trace[157491949] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1851; }","duration":"106.466441ms","start":"2026-07-17T05:32:25.145826Z","end":"2026-07-17T05:32:25.252293Z","steps":["trace[157491949] 'agreement among raft nodes before linearized reading' (duration: 106.41791ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:25.252439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.491098ms","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-07-17T05:32:25.252456Z","caller":"traceutil/trace.go:171","msg":"trace[1367371359] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1851; }","duration":"107.549539ms","start":"2026-07-17T05:32:25.144902Z","end":"2026-07-17T05:32:25.252452Z","steps":["trace[1367371359] 'agreement among raft nodes before linearized reading' (duration: 107.486598ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:26.866625Z","caller":"traceutil/trace.go:171","msg":"trace[1813029698] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"133.775377ms","start":"2026-07-17T05:32:26.732822Z","end":"2026-07-17T05:32:26.866598Z","steps":["trace[1813029698] 'process raft request' (duration: 133.614803ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:27.258153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.352842ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-17T05:32:27.258498Z","caller":"traceutil/trace.go:171","msg":"trace[1877548154] linearizableReadLoop","detail":"{readStateIndex:1958; appliedIndex:1954; }","duration":"303.664288ms","start":"2026-07-17T05:32:26.954815Z","end":"2026-07-17T05:32:27.25848Z","steps":["trace[1877548154] 'read index received' (duration: 102.894385ms)","trace[1877548154] 'applied index is now lower than readState.Index' (duration: 200.768643ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:32:27.258598Z","caller":"traceutil/trace.go:171","msg":"trace[88495910] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"380.16253ms","start":"2026-07-17T05:32:26.878425Z","end":"2026-07-17T05:32:27.258588Z","steps":["trace[88495910] 'process raft request' (duration: 379.971745ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:27.258601Z","caller":"traceutil/trace.go:171","msg":"trace[297426595] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"384.768715ms","start":"2026-07-17T05:32:26.873789Z","end":"2026-07-17T05:32:27.258558Z","steps":["trace[297426595] 'process raft request' (duration: 384.465807ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:27.258646Z","caller":"traceutil/trace.go:171","msg":"trace[619084887] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"384.269272ms","start":"2026-07-17T05:32:26.87434Z","end":"2026-07-17T05:32:27.258609Z","steps":["trace[619084887] 'process raft request' (duration: 384.013945ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:27.258672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:26.878408Z","time spent":"380.225952ms","remote":"127.0.0.1:33284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3730,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T05:32:27.258783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:26.873755Z","time spent":"384.93087ms","remote":"127.0.0.1:33376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T05:32:27.258801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:26.874321Z","time spent":"384.392974ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T05:32:27.258844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.796473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T05:32:27.258917Z","caller":"traceutil/trace.go:171","msg":"trace[1883505007] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1888; }","duration":"164.904036ms","start":"2026-07-17T05:32:27.093994Z","end":"2026-07-17T05:32:27.258898Z","steps":["trace[1883505007] 'agreement among raft nodes before linearized reading' (duration: 164.787303ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:27.258954Z","caller":"traceutil/trace.go:171","msg":"trace[1812173352] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"385.297288ms","start":"2026-07-17T05:32:26.873415Z","end":"2026-07-17T05:32:27.258712Z","steps":["trace[1812173352] 'process raft request' (duration: 184.289429ms)","trace[1812173352] 'compare' (duration: 200.200338ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:32:27.259044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.181272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T05:32:27.259185Z","caller":"traceutil/trace.go:171","msg":"trace[1968124684] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1888; }","duration":"304.359177ms","start":"2026-07-17T05:32:26.954802Z","end":"2026-07-17T05:32:27.259161Z","steps":["trace[1968124684] 'agreement among raft nodes before linearized reading' (duration: 304.086019ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:27.259212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:26.873392Z","time spent":"385.617448ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T05:32:27.25924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:26.954746Z","time spent":"304.48419ms","remote":"127.0.0.1:60642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-07-17T05:32:27.59209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.631495ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-17T05:32:27.592264Z","caller":"traceutil/trace.go:171","msg":"trace[1970807725] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"187.110726ms","start":"2026-07-17T05:32:27.40514Z","end":"2026-07-17T05:32:27.59225Z","steps":["trace[1970807725] 'process raft request' (duration: 187.047164ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:27.592234Z","caller":"traceutil/trace.go:171","msg":"trace[1887790015] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"333.475082ms","start":"2026-07-17T05:32:27.258716Z","end":"2026-07-17T05:32:27.592191Z","steps":["trace[1887790015] 'process raft request' (duration: 183.664612ms)","trace[1887790015] 'compare' (duration: 149.522653ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:32:27.59234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.965391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T05:32:27.592381Z","caller":"traceutil/trace.go:171","msg":"trace[1704806115] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1890; }","duration":"332.056985ms","start":"2026-07-17T05:32:27.260315Z","end":"2026-07-17T05:32:27.592372Z","steps":["trace[1704806115] 'agreement among raft nodes before linearized reading' (duration: 331.977422ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:27.592408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:27.260291Z","time spent":"332.109145ms","remote":"127.0.0.1:33120","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-07-17T05:32:27.592402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:27.258694Z","time spent":"333.627366ms","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T05:32:27.592265Z","caller":"traceutil/trace.go:171","msg":"trace[5471565] linearizableReadLoop","detail":"{readStateIndex:1959; appliedIndex:1958; }","duration":"331.859938ms","start":"2026-07-17T05:32:27.260387Z","end":"2026-07-17T05:32:27.592247Z","steps":["trace[5471565] 'read index received' (duration: 182.074879ms)","trace[5471565] 'applied index is now lower than readState.Index' (duration: 149.783739ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:32:27.592653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.244466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-07-17T05:32:27.592685Z","caller":"traceutil/trace.go:171","msg":"trace[985522915] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1890; }","duration":"326.308128ms","start":"2026-07-17T05:32:27.266368Z","end":"2026-07-17T05:32:27.592676Z","steps":["trace[985522915] 'agreement among raft nodes before linearized reading' (duration: 326.195035ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:27.592691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.143181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8a6f671e-9093-485f-8dfc-40a7ef7f1c4c\" ","response":"range_response_count:1 size:3745"} {"level":"warn","ts":"2026-07-17T05:32:27.592711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:27.266346Z","time spent":"326.35764ms","remote":"127.0.0.1:43044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-07-17T05:32:27.592726Z","caller":"traceutil/trace.go:171","msg":"trace[197290477] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8a6f671e-9093-485f-8dfc-40a7ef7f1c4c; range_end:; response_count:1; response_revision:1890; }","duration":"258.203042ms","start":"2026-07-17T05:32:27.33451Z","end":"2026-07-17T05:32:27.592714Z","steps":["trace[197290477] 'agreement among raft nodes before linearized reading' (duration: 258.063609ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:27.592753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.013763ms","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-07-17T05:32:27.592792Z","caller":"traceutil/trace.go:171","msg":"trace[1170694899] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1890; }","duration":"289.097665ms","start":"2026-07-17T05:32:27.303683Z","end":"2026-07-17T05:32:27.592781Z","steps":["trace[1170694899] 'agreement among raft nodes before linearized reading' (duration: 289.000092ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:27.592838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.461667ms","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-07-17T05:32:27.592912Z","caller":"traceutil/trace.go:171","msg":"trace[1346363255] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1890; }","duration":"278.578911ms","start":"2026-07-17T05:32:27.314314Z","end":"2026-07-17T05:32:27.592893Z","steps":["trace[1346363255] 'agreement among raft nodes before linearized reading' (duration: 278.317084ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:27.59294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.885745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18c2fcc987a76aee\" ","response":"range_response_count:1 size:982"} {"level":"warn","ts":"2026-07-17T05:32:27.59295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.570498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.4\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-07-17T05:32:27.593056Z","caller":"traceutil/trace.go:171","msg":"trace[1199501849] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18c2fcc987a76aee; range_end:; response_count:1; response_revision:1890; }","duration":"215.171513ms","start":"2026-07-17T05:32:27.377855Z","end":"2026-07-17T05:32:27.593026Z","steps":["trace[1199501849] 'agreement among raft nodes before linearized reading' (duration: 214.740521ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:27.59306Z","caller":"traceutil/trace.go:171","msg":"trace[1505014898] range","detail":"{range_begin:/registry/masterleases/199.204.45.4; range_end:; response_count:1; response_revision:1890; }","duration":"223.740863ms","start":"2026-07-17T05:32:27.369294Z","end":"2026-07-17T05:32:27.593035Z","steps":["trace[1505014898] 'agreement among raft nodes before linearized reading' (duration: 223.328862ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:27.593103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.683195ms","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-07-17T05:32:27.59313Z","caller":"traceutil/trace.go:171","msg":"trace[1692944916] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1890; }","duration":"288.753517ms","start":"2026-07-17T05:32:27.30437Z","end":"2026-07-17T05:32:27.593123Z","steps":["trace[1692944916] 'agreement among raft nodes before linearized reading' (duration: 288.207332ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:28.336774Z","caller":"traceutil/trace.go:171","msg":"trace[1550805054] linearizableReadLoop","detail":"{readStateIndex:1969; appliedIndex:1968; }","duration":"289.775584ms","start":"2026-07-17T05:32:28.046979Z","end":"2026-07-17T05:32:28.336754Z","steps":["trace[1550805054] 'read index received' (duration: 289.669641ms)","trace[1550805054] 'applied index is now lower than readState.Index' (duration: 105.293µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:32:28.336812Z","caller":"traceutil/trace.go:171","msg":"trace[2088718504] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"387.150089ms","start":"2026-07-17T05:32:27.949642Z","end":"2026-07-17T05:32:28.336792Z","steps":["trace[2088718504] 'process raft request' (duration: 386.962505ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:28.336941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.961178ms","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-07-17T05:32:28.336934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:27.949613Z","time spent":"387.249602ms","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T05:32:28.33698Z","caller":"traceutil/trace.go:171","msg":"trace[1319147643] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1898; }","duration":"290.02561ms","start":"2026-07-17T05:32:28.046943Z","end":"2026-07-17T05:32:28.336969Z","steps":["trace[1319147643] 'agreement among raft nodes before linearized reading' (duration: 289.916487ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:28.337003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.826628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T05:32:28.337089Z","caller":"traceutil/trace.go:171","msg":"trace[292090969] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1898; }","duration":"242.962842ms","start":"2026-07-17T05:32:28.094106Z","end":"2026-07-17T05:32:28.337069Z","steps":["trace[292090969] 'agreement among raft nodes before linearized reading' (duration: 242.811588ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:34.175836Z","caller":"traceutil/trace.go:171","msg":"trace[505547373] linearizableReadLoop","detail":"{readStateIndex:2028; appliedIndex:2027; }","duration":"338.379164ms","start":"2026-07-17T05:32:33.837431Z","end":"2026-07-17T05:32:34.17581Z","steps":["trace[505547373] 'read index received' (duration: 338.21678ms)","trace[505547373] 'applied index is now lower than readState.Index' (duration: 161.494µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:32:34.175906Z","caller":"traceutil/trace.go:171","msg":"trace[296626540] transaction","detail":"{read_only:false; response_revision:1955; number_of_response:1; }","duration":"379.625655ms","start":"2026-07-17T05:32:33.796249Z","end":"2026-07-17T05:32:34.175874Z","steps":["trace[296626540] 'process raft request' (duration: 379.39875ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:34.176176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:33.796225Z","time spent":"379.861813ms","remote":"127.0.0.1:33284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11965,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T05:32:34.176253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.748414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-07-17T05:32:34.176329Z","caller":"traceutil/trace.go:171","msg":"trace[191096790] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1955; }","duration":"338.96083ms","start":"2026-07-17T05:32:33.837345Z","end":"2026-07-17T05:32:34.176306Z","steps":["trace[191096790] 'agreement among raft nodes before linearized reading' (duration: 338.613991ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:34.176382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:33.837239Z","time spent":"339.129264ms","remote":"127.0.0.1:33262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":1876,"request content":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-07-17T05:32:35.824948Z","caller":"traceutil/trace.go:171","msg":"trace[1013605185] transaction","detail":"{read_only:false; response_revision:1968; number_of_response:1; }","duration":"102.786491ms","start":"2026-07-17T05:32:35.722141Z","end":"2026-07-17T05:32:35.824928Z","steps":["trace[1013605185] 'process raft request' (duration: 102.713479ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:35.824775Z","caller":"traceutil/trace.go:171","msg":"trace[178429207] transaction","detail":"{read_only:false; response_revision:1966; number_of_response:1; }","duration":"102.982387ms","start":"2026-07-17T05:32:35.721775Z","end":"2026-07-17T05:32:35.824757Z","steps":["trace[178429207] 'process raft request' (duration: 99.975185ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:35.825027Z","caller":"traceutil/trace.go:171","msg":"trace[496201727] transaction","detail":"{read_only:false; response_revision:1967; number_of_response:1; }","duration":"102.994277ms","start":"2026-07-17T05:32:35.721991Z","end":"2026-07-17T05:32:35.824985Z","steps":["trace[496201727] 'process raft request' (duration: 102.7265ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:39.899778Z","caller":"traceutil/trace.go:171","msg":"trace[180792205] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"262.807986ms","start":"2026-07-17T05:32:39.63694Z","end":"2026-07-17T05:32:39.899748Z","steps":["trace[180792205] 'process raft request' (duration: 262.672852ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:40.512136Z","caller":"traceutil/trace.go:171","msg":"trace[1100423113] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"134.965049ms","start":"2026-07-17T05:32:40.377149Z","end":"2026-07-17T05:32:40.512115Z","steps":["trace[1100423113] 'process raft request' (duration: 134.919868ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:40.512173Z","caller":"traceutil/trace.go:171","msg":"trace[1645325099] transaction","detail":"{read_only:false; response_revision:1991; number_of_response:1; }","duration":"783.863796ms","start":"2026-07-17T05:32:39.728267Z","end":"2026-07-17T05:32:40.512131Z","steps":["trace[1645325099] 'process raft request' (duration: 701.584717ms)","trace[1645325099] 'compare' (duration: 82.088894ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:32:40.512184Z","caller":"traceutil/trace.go:171","msg":"trace[815307952] linearizableReadLoop","detail":"{readStateIndex:2065; appliedIndex:2064; }","duration":"766.147067ms","start":"2026-07-17T05:32:39.745997Z","end":"2026-07-17T05:32:40.512145Z","steps":["trace[815307952] 'read index received' (duration: 153.733104ms)","trace[815307952] 'applied index is now lower than readState.Index' (duration: 612.410703ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:32:40.51231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:39.728241Z","time spent":"783.982609ms","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T05:32:40.512731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.709013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-07-17T05:32:40.512788Z","caller":"traceutil/trace.go:171","msg":"trace[1894987858] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1992; }","duration":"766.829646ms","start":"2026-07-17T05:32:39.745942Z","end":"2026-07-17T05:32:40.512772Z","steps":["trace[1894987858] 'agreement among raft nodes before linearized reading' (duration: 766.338212ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:40.512823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:39.745918Z","time spent":"766.896568ms","remote":"127.0.0.1:43044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-07-17T05:32:40.515724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.508049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T05:32:40.515772Z","caller":"traceutil/trace.go:171","msg":"trace[647563033] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1994; }","duration":"420.607941ms","start":"2026-07-17T05:32:40.095154Z","end":"2026-07-17T05:32:40.515762Z","steps":["trace[647563033] 'agreement among raft nodes before linearized reading' (duration: 420.535839ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:40.51575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.345432ms","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-07-17T05:32:40.515841Z","caller":"traceutil/trace.go:171","msg":"trace[1267135965] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1994; }","duration":"677.477406ms","start":"2026-07-17T05:32:39.838342Z","end":"2026-07-17T05:32:40.515819Z","steps":["trace[1267135965] 'agreement among raft nodes before linearized reading' (duration: 677.228049ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:40.515906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:39.838142Z","time spent":"677.741733ms","remote":"127.0.0.1:33374","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-07-17T05:32:40.516009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.551899ms","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-07-17T05:32:40.51607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.356518ms","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-07-17T05:32:40.516111Z","caller":"traceutil/trace.go:171","msg":"trace[1368668821] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1994; }","duration":"116.43371ms","start":"2026-07-17T05:32:40.399669Z","end":"2026-07-17T05:32:40.516103Z","steps":["trace[1368668821] 'agreement among raft nodes before linearized reading' (duration: 116.311787ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:40.516139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.785539ms","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-07-17T05:32:40.516166Z","caller":"traceutil/trace.go:171","msg":"trace[846658922] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1994; }","duration":"676.812029ms","start":"2026-07-17T05:32:39.839347Z","end":"2026-07-17T05:32:40.516159Z","steps":["trace[846658922] 'agreement among raft nodes before linearized reading' (duration: 676.746068ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:40.516194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:39.839286Z","time spent":"676.902791ms","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-17T05:32:40.5158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:40.095126Z","time spent":"420.667333ms","remote":"127.0.0.1:33132","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-07-17T05:32:40.51621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.357891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-17T05:32:40.516074Z","caller":"traceutil/trace.go:171","msg":"trace[621101161] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1994; }","duration":"677.618781ms","start":"2026-07-17T05:32:39.838441Z","end":"2026-07-17T05:32:40.516059Z","steps":["trace[621101161] 'agreement among raft nodes before linearized reading' (duration: 677.442995ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:32:40.516272Z","caller":"traceutil/trace.go:171","msg":"trace[1680081216] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1994; }","duration":"306.480404ms","start":"2026-07-17T05:32:40.209774Z","end":"2026-07-17T05:32:40.516255Z","steps":["trace[1680081216] 'agreement among raft nodes before linearized reading' (duration: 306.32876ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:40.516284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:39.838389Z","time spent":"677.882747ms","remote":"127.0.0.1:33374","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-07-17T05:32:40.516308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:40.209731Z","time spent":"306.567746ms","remote":"127.0.0.1:39990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":17,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-07-17T05:32:40.516615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.222566ms","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-07-17T05:32:40.517314Z","caller":"traceutil/trace.go:171","msg":"trace[401472687] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1994; }","duration":"678.929735ms","start":"2026-07-17T05:32:39.838362Z","end":"2026-07-17T05:32:40.517292Z","steps":["trace[401472687] 'agreement among raft nodes before linearized reading' (duration: 677.692593ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:32:40.517391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:32:39.83835Z","time spent":"679.012157ms","remote":"127.0.0.1:33374","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":"info","ts":"2026-07-17T05:33:18.268673Z","caller":"traceutil/trace.go:171","msg":"trace[1352269578] linearizableReadLoop","detail":"{readStateIndex:2296; appliedIndex:2295; }","duration":"144.92801ms","start":"2026-07-17T05:33:18.123713Z","end":"2026-07-17T05:33:18.268641Z","steps":["trace[1352269578] 'read index received' (duration: 144.779076ms)","trace[1352269578] 'applied index is now lower than readState.Index' (duration: 147.714µs)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:33:18.268805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.074054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T05:33:18.268843Z","caller":"traceutil/trace.go:171","msg":"trace[1949488807] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2213; }","duration":"145.165666ms","start":"2026-07-17T05:33:18.123663Z","end":"2026-07-17T05:33:18.268829Z","steps":["trace[1949488807] 'agreement among raft nodes before linearized reading' (duration: 145.088634ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:33:18.268815Z","caller":"traceutil/trace.go:171","msg":"trace[343397569] transaction","detail":"{read_only:false; response_revision:2213; number_of_response:1; }","duration":"151.690157ms","start":"2026-07-17T05:33:18.117062Z","end":"2026-07-17T05:33:18.268752Z","steps":["trace[343397569] 'process raft request' (duration: 151.377338ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:33:19.229342Z","caller":"traceutil/trace.go:171","msg":"trace[1275161369] linearizableReadLoop","detail":"{readStateIndex:2299; appliedIndex:2296; }","duration":"445.385517ms","start":"2026-07-17T05:33:18.783935Z","end":"2026-07-17T05:33:19.22932Z","steps":["trace[1275161369] 'read index received' (duration: 32.148719ms)","trace[1275161369] 'applied index is now lower than readState.Index' (duration: 413.235928ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:33:19.22939Z","caller":"traceutil/trace.go:171","msg":"trace[1003501117] transaction","detail":"{read_only:false; response_revision:2215; number_of_response:1; }","duration":"462.615676ms","start":"2026-07-17T05:33:18.766755Z","end":"2026-07-17T05:33:19.229371Z","steps":["trace[1003501117] 'process raft request' (duration: 393.405381ms)","trace[1003501117] 'compare' (duration: 68.838685ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:33:19.229427Z","caller":"traceutil/trace.go:171","msg":"trace[2025110914] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"462.558124ms","start":"2026-07-17T05:33:18.766821Z","end":"2026-07-17T05:33:19.229379Z","steps":["trace[2025110914] 'process raft request' (duration: 462.433961ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:33:19.229511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:33:18.766741Z","time spent":"462.694598ms","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T05:33:19.229563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.627873ms","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-07-17T05:33:19.229603Z","caller":"traceutil/trace.go:171","msg":"trace[253597750] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2216; }","duration":"445.719325ms","start":"2026-07-17T05:33:18.783873Z","end":"2026-07-17T05:33:19.229593Z","steps":["trace[253597750] 'agreement among raft nodes before linearized reading' (duration: 445.583041ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:33:19.229638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:33:18.783846Z","time spent":"445.784927ms","remote":"127.0.0.1:33374","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-07-17T05:33:19.229673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:33:18.766792Z","time spent":"462.75265ms","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T05:33:19.229777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.31967ms","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-07-17T05:33:19.22981Z","caller":"traceutil/trace.go:171","msg":"trace[474177081] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2216; }","duration":"408.376512ms","start":"2026-07-17T05:33:18.821426Z","end":"2026-07-17T05:33:19.229803Z","steps":["trace[474177081] 'agreement among raft nodes before linearized reading' (duration: 408.290489ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:33:19.229836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:33:18.821409Z","time spent":"408.421884ms","remote":"127.0.0.1:33374","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-07-17T05:33:19.229974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.488183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-07-17T05:33:19.229962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.385861ms","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-07-17T05:33:19.230007Z","caller":"traceutil/trace.go:171","msg":"trace[241545311] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2216; }","duration":"365.562855ms","start":"2026-07-17T05:33:18.864434Z","end":"2026-07-17T05:33:19.229997Z","steps":["trace[241545311] 'agreement among raft nodes before linearized reading' (duration: 365.473763ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:33:19.230007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.547274ms","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-07-17T05:33:19.230033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:33:18.86441Z","time spent":"365.617006ms","remote":"127.0.0.1:43044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-07-17T05:33:19.230035Z","caller":"traceutil/trace.go:171","msg":"trace[971460170] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2216; }","duration":"406.513223ms","start":"2026-07-17T05:33:18.823506Z","end":"2026-07-17T05:33:19.23002Z","steps":["trace[971460170] 'agreement among raft nodes before linearized reading' (duration: 406.37728ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:33:19.230048Z","caller":"traceutil/trace.go:171","msg":"trace[1055362683] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2216; }","duration":"401.589495ms","start":"2026-07-17T05:33:18.828447Z","end":"2026-07-17T05:33:19.230037Z","steps":["trace[1055362683] 'agreement among raft nodes before linearized reading' (duration: 401.39601ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:33:19.230073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:33:18.823474Z","time spent":"406.590315ms","remote":"127.0.0.1:33374","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-07-17T05:33:19.230095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:33:18.828429Z","time spent":"401.650607ms","remote":"127.0.0.1:33374","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-07-17T05:33:19.230129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.34412ms","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-07-17T05:33:19.230229Z","caller":"traceutil/trace.go:171","msg":"trace[252418391] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2216; }","duration":"403.478344ms","start":"2026-07-17T05:33:18.826725Z","end":"2026-07-17T05:33:19.230204Z","steps":["trace[252418391] 'agreement among raft nodes before linearized reading' (duration: 403.155526ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:33:19.230281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:33:18.826717Z","time spent":"403.555496ms","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-17T05:33:19.521261Z","caller":"traceutil/trace.go:171","msg":"trace[1864276670] transaction","detail":"{read_only:false; response_revision:2217; number_of_response:1; }","duration":"286.919344ms","start":"2026-07-17T05:33:19.234308Z","end":"2026-07-17T05:33:19.521228Z","steps":["trace[1864276670] 'process raft request' (duration: 204.676808ms)","trace[1864276670] 'compare' (duration: 82.061021ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:33:19.526725Z","caller":"traceutil/trace.go:171","msg":"trace[1578628428] transaction","detail":"{read_only:false; response_revision:2218; number_of_response:1; }","duration":"291.619587ms","start":"2026-07-17T05:33:19.235082Z","end":"2026-07-17T05:33:19.526701Z","steps":["trace[1578628428] 'process raft request' (duration: 291.453922ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:33:19.526728Z","caller":"traceutil/trace.go:171","msg":"trace[683873121] transaction","detail":"{read_only:false; response_revision:2219; number_of_response:1; }","duration":"291.588376ms","start":"2026-07-17T05:33:19.235113Z","end":"2026-07-17T05:33:19.526702Z","steps":["trace[683873121] 'process raft request' (duration: 291.518064ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:33:19.52696Z","caller":"traceutil/trace.go:171","msg":"trace[139705220] transaction","detail":"{read_only:false; response_revision:2220; number_of_response:1; }","duration":"291.559394ms","start":"2026-07-17T05:33:19.235393Z","end":"2026-07-17T05:33:19.526952Z","steps":["trace[139705220] 'process raft request' (duration: 291.277267ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:33:19.527121Z","caller":"traceutil/trace.go:171","msg":"trace[527498954] transaction","detail":"{read_only:false; response_revision:2221; number_of_response:1; }","duration":"290.439486ms","start":"2026-07-17T05:33:19.236658Z","end":"2026-07-17T05:33:19.527098Z","steps":["trace[527498954] 'process raft request' (duration: 290.239631ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:34:16.391715Z","caller":"traceutil/trace.go:171","msg":"trace[684958468] transaction","detail":"{read_only:false; response_revision:2815; number_of_response:1; }","duration":"101.33506ms","start":"2026-07-17T05:34:16.290317Z","end":"2026-07-17T05:34:16.391652Z","steps":["trace[684958468] 'process raft request' (duration: 101.014962ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:34:16.849088Z","caller":"traceutil/trace.go:171","msg":"trace[1193661659] linearizableReadLoop","detail":"{readStateIndex:2922; appliedIndex:2921; }","duration":"375.161037ms","start":"2026-07-17T05:34:16.473903Z","end":"2026-07-17T05:34:16.849064Z","steps":["trace[1193661659] 'read index received' (duration: 375.022372ms)","trace[1193661659] 'applied index is now lower than readState.Index' (duration: 137.505µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:34:16.849165Z","caller":"traceutil/trace.go:171","msg":"trace[380907314] transaction","detail":"{read_only:false; response_revision:2816; number_of_response:1; }","duration":"448.377563ms","start":"2026-07-17T05:34:16.400749Z","end":"2026-07-17T05:34:16.849126Z","steps":["trace[380907314] 'process raft request' (duration: 448.159147ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:16.849287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.373392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/percona-xtradb\" ","response":"range_response_count:1 size:724"} {"level":"info","ts":"2026-07-17T05:34:16.849326Z","caller":"traceutil/trace.go:171","msg":"trace[453463151] range","detail":"{range_begin:/registry/secrets/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2816; }","duration":"375.480255ms","start":"2026-07-17T05:34:16.473835Z","end":"2026-07-17T05:34:16.849315Z","steps":["trace[453463151] 'agreement among raft nodes before linearized reading' (duration: 375.326371ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:16.849332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:16.400727Z","time spent":"448.515396ms","remote":"127.0.0.1:33284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3720,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T05:34:16.849363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:16.473805Z","time spent":"375.548506ms","remote":"127.0.0.1:33210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":747,"request content":"key:\"/registry/secrets/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-07-17T05:34:16.878658Z","caller":"traceutil/trace.go:171","msg":"trace[696930211] transaction","detail":"{read_only:false; response_revision:2817; number_of_response:1; }","duration":"391.271988ms","start":"2026-07-17T05:34:16.487358Z","end":"2026-07-17T05:34:16.87863Z","steps":["trace[696930211] 'process raft request' (duration: 391.080293ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:16.878838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:16.487337Z","time spent":"391.406882ms","remote":"127.0.0.1:33374","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-07-17T05:34:17.742191Z","caller":"traceutil/trace.go:171","msg":"trace[151672654] transaction","detail":"{read_only:false; response_revision:2830; number_of_response:1; }","duration":"116.833147ms","start":"2026-07-17T05:34:17.625326Z","end":"2026-07-17T05:34:17.742159Z","steps":["trace[151672654] 'process raft request' (duration: 113.276394ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:34:17.742259Z","caller":"traceutil/trace.go:171","msg":"trace[958265221] linearizableReadLoop","detail":"{readStateIndex:2938; appliedIndex:2936; }","duration":"116.798476ms","start":"2026-07-17T05:34:17.62543Z","end":"2026-07-17T05:34:17.742229Z","steps":["trace[958265221] 'read index received' (duration: 85.622601ms)","trace[958265221] 'applied index is now lower than readState.Index' (duration: 31.172365ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:34:17.742612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.163115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/valkey-server-8zjt4\" ","response":"range_response_count:1 size:2454"} {"level":"info","ts":"2026-07-17T05:34:17.742723Z","caller":"traceutil/trace.go:171","msg":"trace[124659940] range","detail":"{range_begin:/registry/secrets/openstack/valkey-server-8zjt4; range_end:; response_count:1; response_revision:2831; }","duration":"117.33775ms","start":"2026-07-17T05:34:17.625364Z","end":"2026-07-17T05:34:17.742701Z","steps":["trace[124659940] 'agreement among raft nodes before linearized reading' (duration: 116.956951ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:17.742937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.492076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/valkey-server-certs\" ","response":"range_response_count:1 size:5410"} {"level":"info","ts":"2026-07-17T05:34:17.742981Z","caller":"traceutil/trace.go:171","msg":"trace[1041734901] range","detail":"{range_begin:/registry/secrets/openstack/valkey-server-certs; range_end:; response_count:1; response_revision:2831; }","duration":"114.581357ms","start":"2026-07-17T05:34:17.62839Z","end":"2026-07-17T05:34:17.742971Z","steps":["trace[1041734901] 'agreement among raft nodes before linearized reading' (duration: 114.255379ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:34:24.523352Z","caller":"traceutil/trace.go:171","msg":"trace[445424937] transaction","detail":"{read_only:false; response_revision:2903; number_of_response:1; }","duration":"104.348391ms","start":"2026-07-17T05:34:24.418981Z","end":"2026-07-17T05:34:24.523329Z","steps":["trace[445424937] 'process raft request' (duration: 63.397069ms)","trace[445424937] 'compare' (duration: 40.784178ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:34:36.790983Z","caller":"traceutil/trace.go:171","msg":"trace[858102972] transaction","detail":"{read_only:false; response_revision:3028; number_of_response:1; }","duration":"227.725378ms","start":"2026-07-17T05:34:36.563229Z","end":"2026-07-17T05:34:36.790954Z","steps":["trace[858102972] 'process raft request' (duration: 227.551334ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:34:59.876049Z","caller":"traceutil/trace.go:171","msg":"trace[234618562] linearizableReadLoop","detail":"{readStateIndex:3357; appliedIndex:3356; }","duration":"284.292289ms","start":"2026-07-17T05:34:59.591724Z","end":"2026-07-17T05:34:59.876017Z","steps":["trace[234618562] 'read index received' (duration: 284.206307ms)","trace[234618562] 'applied index is now lower than readState.Index' (duration: 84.352µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:34:59.876164Z","caller":"traceutil/trace.go:171","msg":"trace[1812616797] transaction","detail":"{read_only:false; response_revision:3239; number_of_response:1; }","duration":"292.843544ms","start":"2026-07-17T05:34:59.583282Z","end":"2026-07-17T05:34:59.876126Z","steps":["trace[1812616797] 'process raft request' (duration: 292.531485ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:34:59.876504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.748901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-07-17T05:34:59.876674Z","caller":"traceutil/trace.go:171","msg":"trace[1859935711] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:3239; }","duration":"284.910665ms","start":"2026-07-17T05:34:59.591673Z","end":"2026-07-17T05:34:59.876583Z","steps":["trace[1859935711] 'agreement among raft nodes before linearized reading' (duration: 284.504935ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:35:00.412512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.544611ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-17T05:35:00.412773Z","caller":"traceutil/trace.go:171","msg":"trace[1178213279] transaction","detail":"{read_only:false; response_revision:3241; number_of_response:1; }","duration":"199.92789ms","start":"2026-07-17T05:35:00.212823Z","end":"2026-07-17T05:35:00.41275Z","steps":["trace[1178213279] 'process raft request' (duration: 199.817698ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:35:00.412728Z","caller":"traceutil/trace.go:171","msg":"trace[1195077900] transaction","detail":"{read_only:false; response_revision:3240; number_of_response:1; }","duration":"760.263704ms","start":"2026-07-17T05:34:59.652413Z","end":"2026-07-17T05:35:00.412677Z","steps":["trace[1195077900] 'process raft request' (duration: 599.207629ms)","trace[1195077900] 'compare' (duration: 160.159352ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:35:00.412995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:34:59.652379Z","time spent":"760.471878ms","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T05:35:00.41309Z","caller":"traceutil/trace.go:171","msg":"trace[1161219661] linearizableReadLoop","detail":"{readStateIndex:3358; appliedIndex:3357; }","duration":"332.436158ms","start":"2026-07-17T05:35:00.080634Z","end":"2026-07-17T05:35:00.41307Z","steps":["trace[1161219661] 'read index received' (duration: 171.010334ms)","trace[1161219661] 'applied index is now lower than readState.Index' (duration: 161.423634ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:35:00.413448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.640553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-07-17T05:35:00.413438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.427788ms","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-07-17T05:35:00.413467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.561399ms","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-07-17T05:35:00.413471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.817058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-17T05:35:00.413523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.272178ms","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-07-17T05:35:00.413473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.923468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T05:35:00.413559Z","caller":"traceutil/trace.go:171","msg":"trace[552148872] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3241; }","duration":"311.566213ms","start":"2026-07-17T05:35:00.10196Z","end":"2026-07-17T05:35:00.413526Z","steps":["trace[552148872] 'agreement among raft nodes before linearized reading' (duration: 311.270285ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:35:00.413567Z","caller":"traceutil/trace.go:171","msg":"trace[2036292016] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3241; }","duration":"325.702372ms","start":"2026-07-17T05:35:00.087836Z","end":"2026-07-17T05:35:00.413539Z","steps":["trace[2036292016] 'agreement among raft nodes before linearized reading' (duration: 325.382034ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:35:00.413478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.588609ms","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-07-17T05:35:00.413586Z","caller":"traceutil/trace.go:171","msg":"trace[914960209] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3241; }","duration":"331.36068ms","start":"2026-07-17T05:35:00.082208Z","end":"2026-07-17T05:35:00.413568Z","steps":["trace[914960209] 'agreement among raft nodes before linearized reading' (duration: 331.017471ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:35:00.413613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:35:00.101954Z","time spent":"311.649765ms","remote":"127.0.0.1:33374","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-07-17T05:35:00.413635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:35:00.082197Z","time spent":"331.430332ms","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-17T05:35:00.413627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:35:00.087813Z","time spent":"325.799235ms","remote":"127.0.0.1:33374","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-07-17T05:35:00.413631Z","caller":"traceutil/trace.go:171","msg":"trace[708663963] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3241; }","duration":"313.120343ms","start":"2026-07-17T05:35:00.100472Z","end":"2026-07-17T05:35:00.413592Z","steps":["trace[708663963] 'agreement among raft nodes before linearized reading' (duration: 312.812976ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:35:00.413645Z","caller":"traceutil/trace.go:171","msg":"trace[691932720] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3241; }","duration":"325.782054ms","start":"2026-07-17T05:35:00.087836Z","end":"2026-07-17T05:35:00.413618Z","steps":["trace[691932720] 'agreement among raft nodes before linearized reading' (duration: 325.385004ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:35:00.413534Z","caller":"traceutil/trace.go:171","msg":"trace[1165270238] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3241; }","duration":"327.738285ms","start":"2026-07-17T05:35:00.085771Z","end":"2026-07-17T05:35:00.41351Z","steps":["trace[1165270238] 'agreement among raft nodes before linearized reading' (duration: 327.496629ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:35:00.413699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:35:00.087823Z","time spent":"325.866976ms","remote":"127.0.0.1:33374","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-07-17T05:35:00.413702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:35:00.100461Z","time spent":"313.230126ms","remote":"127.0.0.1:33132","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-07-17T05:35:00.413739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:35:00.08574Z","time spent":"327.980031ms","remote":"127.0.0.1:33374","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-07-17T05:35:00.413602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.049023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/postgresql.cnpg.io/clusters/auth-system/keycloak-db\" ","response":"range_response_count:1 size:7482"} {"level":"info","ts":"2026-07-17T05:35:00.413866Z","caller":"traceutil/trace.go:171","msg":"trace[1604512596] range","detail":"{range_begin:/registry/postgresql.cnpg.io/clusters/auth-system/keycloak-db; range_end:; response_count:1; response_revision:3241; }","duration":"255.345792ms","start":"2026-07-17T05:35:00.158479Z","end":"2026-07-17T05:35:00.413825Z","steps":["trace[1604512596] 'agreement among raft nodes before linearized reading' (duration: 254.739176ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:35:00.413995Z","caller":"traceutil/trace.go:171","msg":"trace[360499531] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:3241; }","duration":"333.015863ms","start":"2026-07-17T05:35:00.080535Z","end":"2026-07-17T05:35:00.413551Z","steps":["trace[360499531] 'agreement among raft nodes before linearized reading' (duration: 332.650814ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:35:00.414192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:35:00.080498Z","time spent":"333.672501ms","remote":"127.0.0.1:33254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":2,"response size":30,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-07-17T05:35:12.849355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.580147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/postgresql.cnpg.io/clusters/auth-system/keycloak-db\" ","response":"range_response_count:1 size:7482"} {"level":"info","ts":"2026-07-17T05:35:12.849458Z","caller":"traceutil/trace.go:171","msg":"trace[705011890] range","detail":"{range_begin:/registry/postgresql.cnpg.io/clusters/auth-system/keycloak-db; range_end:; response_count:1; response_revision:3350; }","duration":"114.733381ms","start":"2026-07-17T05:35:12.7347Z","end":"2026-07-17T05:35:12.849433Z","steps":["trace[705011890] 'range keys from in-memory index tree' (duration: 114.365172ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:35:17.861636Z","caller":"traceutil/trace.go:171","msg":"trace[681693061] transaction","detail":"{read_only:false; response_revision:3401; number_of_response:1; }","duration":"160.998942ms","start":"2026-07-17T05:35:17.700607Z","end":"2026-07-17T05:35:17.861606Z","steps":["trace[681693061] 'process raft request' (duration: 160.496378ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:35:40.649688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.047411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T05:35:40.649871Z","caller":"traceutil/trace.go:171","msg":"trace[1997215200] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3603; }","duration":"555.307248ms","start":"2026-07-17T05:35:40.09453Z","end":"2026-07-17T05:35:40.649838Z","steps":["trace[1997215200] 'range keys from in-memory index tree' (duration: 554.922098ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:35:40.649943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:35:40.094497Z","time spent":"555.429121ms","remote":"127.0.0.1:33132","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-07-17T05:36:04.333566Z","caller":"traceutil/trace.go:171","msg":"trace[544607040] transaction","detail":"{read_only:false; response_revision:3778; number_of_response:1; }","duration":"217.459639ms","start":"2026-07-17T05:36:04.116076Z","end":"2026-07-17T05:36:04.333536Z","steps":["trace[544607040] 'process raft request' (duration: 217.182252ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:36:04.333518Z","caller":"traceutil/trace.go:171","msg":"trace[429257926] linearizableReadLoop","detail":"{readStateIndex:3937; appliedIndex:3936; }","duration":"214.611764ms","start":"2026-07-17T05:36:04.118874Z","end":"2026-07-17T05:36:04.333486Z","steps":["trace[429257926] 'read index received' (duration: 214.41232ms)","trace[429257926] 'applied index is now lower than readState.Index' (duration: 197.964µs)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:36:04.333773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.878351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:coredns\" ","response":"range_response_count:1 size:415"} {"level":"info","ts":"2026-07-17T05:36:04.333868Z","caller":"traceutil/trace.go:171","msg":"trace[1847787736] range","detail":"{range_begin:/registry/clusterrolebindings/system:coredns; range_end:; response_count:1; response_revision:3778; }","duration":"214.984804ms","start":"2026-07-17T05:36:04.118859Z","end":"2026-07-17T05:36:04.333844Z","steps":["trace[1847787736] 'agreement among raft nodes before linearized reading' (duration: 214.796929ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:36:04.333951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.55221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:discovery\" ","response":"range_response_count:1 size:694"} {"level":"info","ts":"2026-07-17T05:36:04.334023Z","caller":"traceutil/trace.go:171","msg":"trace[29904014] range","detail":"{range_begin:/registry/clusterrolebindings/system:discovery; range_end:; response_count:1; response_revision:3778; }","duration":"142.638542ms","start":"2026-07-17T05:36:04.191367Z","end":"2026-07-17T05:36:04.334006Z","steps":["trace[29904014] 'agreement among raft nodes before linearized reading' (duration: 142.501889ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:36:04.864412Z","caller":"traceutil/trace.go:171","msg":"trace[1046417948] transaction","detail":"{read_only:false; response_revision:3779; number_of_response:1; }","duration":"110.035238ms","start":"2026-07-17T05:36:04.754355Z","end":"2026-07-17T05:36:04.86439Z","steps":["trace[1046417948] 'process raft request' (duration: 109.896785ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:36:05.248546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.860722ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-17T05:36:05.248663Z","caller":"traceutil/trace.go:171","msg":"trace[1693678352] linearizableReadLoop","detail":"{readStateIndex:3939; appliedIndex:3938; }","duration":"478.726904ms","start":"2026-07-17T05:36:04.769918Z","end":"2026-07-17T05:36:05.248645Z","steps":["trace[1693678352] 'read index received' (duration: 95.048267ms)","trace[1693678352] 'applied index is now lower than readState.Index' (duration: 383.677197ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T05:36:05.248743Z","caller":"traceutil/trace.go:171","msg":"trace[818663738] transaction","detail":"{read_only:false; response_revision:3780; number_of_response:1; }","duration":"492.924495ms","start":"2026-07-17T05:36:04.75581Z","end":"2026-07-17T05:36:05.248735Z","steps":["trace[818663738] 'process raft request' (duration: 220.771906ms)","trace[818663738] 'compare' (duration: 271.610296ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T05:36:05.248791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:36:04.755783Z","time spent":"492.986317ms","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T05:36:05.248951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.026182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:kube-scheduler\" ","response":"range_response_count:1 size:709"} {"level":"info","ts":"2026-07-17T05:36:05.248977Z","caller":"traceutil/trace.go:171","msg":"trace[1162869972] range","detail":"{range_begin:/registry/clusterrolebindings/system:kube-scheduler; range_end:; response_count:1; response_revision:3780; }","duration":"479.091414ms","start":"2026-07-17T05:36:04.769879Z","end":"2026-07-17T05:36:05.24897Z","steps":["trace[1162869972] 'agreement among raft nodes before linearized reading' (duration: 479.014182ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:36:05.249001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:36:04.769859Z","time spent":"479.136856ms","remote":"127.0.0.1:33464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":732,"request content":"key:\"/registry/clusterrolebindings/system:kube-scheduler\" "} {"level":"warn","ts":"2026-07-17T05:36:05.249249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.909239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-17T05:36:05.249278Z","caller":"traceutil/trace.go:171","msg":"trace[129046209] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3780; }","duration":"470.939079ms","start":"2026-07-17T05:36:04.778332Z","end":"2026-07-17T05:36:05.249271Z","steps":["trace[129046209] 'agreement among raft nodes before linearized reading' (duration: 470.814626ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:36:05.249299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:36:04.778267Z","time spent":"471.025523ms","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-17T05:36:05.249459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.291164ms","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-07-17T05:36:05.249492Z","caller":"traceutil/trace.go:171","msg":"trace[9773079] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3780; }","duration":"303.361936ms","start":"2026-07-17T05:36:04.946124Z","end":"2026-07-17T05:36:05.249486Z","steps":["trace[9773079] 'agreement among raft nodes before linearized reading' (duration: 303.291384ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:36:05.249513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:36:04.946099Z","time spent":"303.407138ms","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-17T05:36:05.24964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.574772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-07-17T05:36:05.249646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.8894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T05:36:05.249714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.806204ms","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-07-17T05:36:05.249738Z","caller":"traceutil/trace.go:171","msg":"trace[2139208376] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3780; }","duration":"330.860166ms","start":"2026-07-17T05:36:04.918873Z","end":"2026-07-17T05:36:05.249733Z","steps":["trace[2139208376] 'agreement among raft nodes before linearized reading' (duration: 330.805244ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T05:36:05.249729Z","caller":"traceutil/trace.go:171","msg":"trace[1997190428] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:3780; }","duration":"147.988232ms","start":"2026-07-17T05:36:05.101712Z","end":"2026-07-17T05:36:05.2497Z","steps":["trace[1997190428] 'agreement among raft nodes before linearized reading' (duration: 147.865699ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:36:05.249767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:36:04.918852Z","time spent":"330.905797ms","remote":"127.0.0.1:33374","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-07-17T05:36:05.249938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.013609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:kube-dns\" ","response":"range_response_count:1 size:674"} {"level":"info","ts":"2026-07-17T05:36:05.249969Z","caller":"traceutil/trace.go:171","msg":"trace[1750990535] range","detail":"{range_begin:/registry/clusterrolebindings/system:kube-dns; range_end:; response_count:1; response_revision:3780; }","duration":"373.07557ms","start":"2026-07-17T05:36:04.876885Z","end":"2026-07-17T05:36:05.249961Z","steps":["trace[1750990535] 'agreement among raft nodes before linearized reading' (duration: 373.020469ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:36:05.249975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.156993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T05:36:05.250002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:36:04.876865Z","time spent":"373.131321ms","remote":"127.0.0.1:33464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":697,"request content":"key:\"/registry/clusterrolebindings/system:kube-dns\" "} {"level":"info","ts":"2026-07-17T05:36:05.250016Z","caller":"traceutil/trace.go:171","msg":"trace[1142013188] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3780; }","duration":"154.192333ms","start":"2026-07-17T05:36:05.095808Z","end":"2026-07-17T05:36:05.250001Z","steps":["trace[1142013188] 'agreement among raft nodes before linearized reading' (duration: 154.138372ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:36:05.249428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.816413ms","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-07-17T05:36:05.249664Z","caller":"traceutil/trace.go:171","msg":"trace[1857875893] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3780; }","duration":"303.624404ms","start":"2026-07-17T05:36:04.946034Z","end":"2026-07-17T05:36:05.249659Z","steps":["trace[1857875893] 'agreement among raft nodes before linearized reading' (duration: 303.560222ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:36:05.250216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:36:04.946013Z","time spent":"304.190119ms","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-17T05:36:05.250167Z","caller":"traceutil/trace.go:171","msg":"trace[1631949881] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3780; }","duration":"300.593993ms","start":"2026-07-17T05:36:04.949562Z","end":"2026-07-17T05:36:05.250156Z","steps":["trace[1631949881] 'agreement among raft nodes before linearized reading' (duration: 299.69645ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T05:36:05.250541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T05:36:04.949551Z","time spent":"300.977624ms","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}