{"level":"warn","ts":"2026-05-25T14:25:11.459616Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-25T14:25:11.459706Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.138: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.138:2380","--initial-cluster=instance=https://199.204.45.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.138: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-05-25T14:25:11.459771Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-25T14:25:11.459779Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-05-25T14:25:11.459798Z","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-05-25T14:25:11.460464Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"]} {"level":"info","ts":"2026-05-25T14:25:11.460542Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.138: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-05-25T14:25:11.492571Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"31.68965ms"} {"level":"info","ts":"2026-05-25T14:25:11.518403Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3d52791b64f7591","cluster-id":"90076b89649fe294"} {"level":"info","ts":"2026-05-25T14:25:11.518518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=()"} {"level":"info","ts":"2026-05-25T14:25:11.518544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 0"} {"level":"info","ts":"2026-05-25T14:25:11.518597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3d52791b64f7591 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-25T14:25:11.518613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 1"} {"level":"info","ts":"2026-05-25T14:25:11.518699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"warn","ts":"2026-05-25T14:25:11.530063Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-25T14:25:11.535537Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-25T14:25:11.537606Z","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-05-25T14:25:11.541234Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3d52791b64f7591","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-25T14:25:11.541434Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3d52791b64f7591","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-25T14:25:11.541699Z","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-05-25T14:25:11.541792Z","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-05-25T14:25:11.541857Z","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-05-25T14:25:11.542561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"info","ts":"2026-05-25T14:25:11.542694Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","added-peer-id":"f3d52791b64f7591","added-peer-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-05-25T14:25:11.547084Z","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-05-25T14:25:11.547222Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-05-25T14:25:11.547252Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-05-25T14:25:11.547532Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3d52791b64f7591","initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-25T14:25:11.547574Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-25T14:25:12.519997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 is starting a new election at term 1"} {"level":"info","ts":"2026-05-25T14:25:12.520055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-25T14:25:12.520088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgPreVoteResp from f3d52791b64f7591 at term 1"} {"level":"info","ts":"2026-05-25T14:25:12.520108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became candidate at term 2"} {"level":"info","ts":"2026-05-25T14:25:12.52012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgVoteResp from f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-05-25T14:25:12.520135Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became leader at term 2"} {"level":"info","ts":"2026-05-25T14:25:12.520149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3d52791b64f7591 elected leader f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-05-25T14:25:12.521085Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3d52791b64f7591","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.138:2379]}","request-path":"/0/members/f3d52791b64f7591/attributes","cluster-id":"90076b89649fe294","publish-timeout":"7s"} {"level":"info","ts":"2026-05-25T14:25:12.521222Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-25T14:25:12.521373Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-25T14:25:12.521383Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-25T14:25:12.521775Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-25T14:25:12.521859Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-25T14:25:12.522292Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","cluster-version":"3.5"} {"level":"info","ts":"2026-05-25T14:25:12.522408Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-25T14:25:12.522439Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-25T14:25:12.523158Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-25T14:25:12.526019Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.138:2379"} {"level":"warn","ts":"2026-05-25T14:25:15.544674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.872594ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-25T14:25:15.544818Z","caller":"traceutil/trace.go:171","msg":"trace[1585649189] transaction","detail":"{read_only:false; response_revision:109; number_of_response:1; }","duration":"619.942141ms","start":"2026-05-25T14:25:14.924857Z","end":"2026-05-25T14:25:15.544799Z","steps":["trace[1585649189] 'process raft request' (duration: 259.361994ms)","trace[1585649189] 'compare' (duration: 359.729411ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T14:25:15.544919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:25:14.924837Z","time spent":"620.058983ms","remote":"127.0.0.1:34090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-25T14:25:15.984394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.494299ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-25T14:25:15.9845Z","caller":"traceutil/trace.go:171","msg":"trace[762496213] linearizableReadLoop","detail":"{readStateIndex:114; appliedIndex:113; }","duration":"160.176879ms","start":"2026-05-25T14:25:15.824307Z","end":"2026-05-25T14:25:15.984484Z","steps":["trace[762496213] 'read index received' (duration: 29.641µs)","trace[762496213] 'applied index is now lower than readState.Index' (duration: 160.145838ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:25:15.984549Z","caller":"traceutil/trace.go:171","msg":"trace[2017298105] transaction","detail":"{read_only:false; response_revision:110; number_of_response:1; }","duration":"434.047038ms","start":"2026-05-25T14:25:15.550459Z","end":"2026-05-25T14:25:15.984506Z","steps":["trace[2017298105] 'process raft request' (duration: 158.370245ms)","trace[2017298105] 'compare' (duration: 275.346477ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T14:25:15.984636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.295943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-25T14:25:15.984672Z","caller":"traceutil/trace.go:171","msg":"trace[322778247] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:110; }","duration":"160.382534ms","start":"2026-05-25T14:25:15.824279Z","end":"2026-05-25T14:25:15.984661Z","steps":["trace[322778247] 'agreement among raft nodes before linearized reading' (duration: 160.24803ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:25:15.984731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:25:15.550424Z","time spent":"434.215812ms","remote":"127.0.0.1:34090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":741,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-25T14:25:46.814701Z","caller":"traceutil/trace.go:171","msg":"trace[1374785536] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"134.996287ms","start":"2026-05-25T14:25:46.679679Z","end":"2026-05-25T14:25:46.814675Z","steps":["trace[1374785536] 'process raft request' (duration: 134.850354ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:25:48.880195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.109363ms","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-05-25T14:25:48.880308Z","caller":"traceutil/trace.go:171","msg":"trace[772313905] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:482; }","duration":"278.244086ms","start":"2026-05-25T14:25:48.602026Z","end":"2026-05-25T14:25:48.88027Z","steps":["trace[772313905] 'range keys from in-memory index tree' (duration: 278.00745ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:25:48.881986Z","caller":"traceutil/trace.go:171","msg":"trace[1782360659] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"192.464863ms","start":"2026-05-25T14:25:48.689503Z","end":"2026-05-25T14:25:48.881968Z","steps":["trace[1782360659] 'process raft request' (duration: 192.34554ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:25:48.888514Z","caller":"traceutil/trace.go:171","msg":"trace[1464167186] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"198.068953ms","start":"2026-05-25T14:25:48.690418Z","end":"2026-05-25T14:25:48.888487Z","steps":["trace[1464167186] 'process raft request' (duration: 197.788878ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:25:48.888635Z","caller":"traceutil/trace.go:171","msg":"trace[378789931] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"194.473643ms","start":"2026-05-25T14:25:48.694088Z","end":"2026-05-25T14:25:48.888561Z","steps":["trace[378789931] 'process raft request' (duration: 194.27796ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:25:48.888801Z","caller":"traceutil/trace.go:171","msg":"trace[1651142541] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"182.772793ms","start":"2026-05-25T14:25:48.706008Z","end":"2026-05-25T14:25:48.888781Z","steps":["trace[1651142541] 'process raft request' (duration: 182.454517ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:25:48.889092Z","caller":"traceutil/trace.go:171","msg":"trace[1311535660] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"183.025728ms","start":"2026-05-25T14:25:48.706045Z","end":"2026-05-25T14:25:48.889071Z","steps":["trace[1311535660] 'process raft request' (duration: 182.572069ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:25:48.890068Z","caller":"traceutil/trace.go:171","msg":"trace[1319994755] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"183.992207ms","start":"2026-05-25T14:25:48.706061Z","end":"2026-05-25T14:25:48.890053Z","steps":["trace[1319994755] 'process raft request' (duration: 182.690202ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:25:48.890607Z","caller":"traceutil/trace.go:171","msg":"trace[755709901] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"174.434581ms","start":"2026-05-25T14:25:48.716159Z","end":"2026-05-25T14:25:48.890594Z","steps":["trace[755709901] 'process raft request' (duration: 174.239836ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:25:48.890646Z","caller":"traceutil/trace.go:171","msg":"trace[752920490] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"171.283929ms","start":"2026-05-25T14:25:48.719337Z","end":"2026-05-25T14:25:48.890621Z","steps":["trace[752920490] 'process raft request' (duration: 171.132715ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:25:48.890836Z","caller":"traceutil/trace.go:171","msg":"trace[75091777] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"145.218348ms","start":"2026-05-25T14:25:48.745595Z","end":"2026-05-25T14:25:48.890813Z","steps":["trace[75091777] 'process raft request' (duration: 144.922931ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:25:48.89117Z","caller":"traceutil/trace.go:171","msg":"trace[1347921927] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"180.657142ms","start":"2026-05-25T14:25:48.710498Z","end":"2026-05-25T14:25:48.891155Z","steps":["trace[1347921927] 'process raft request' (duration: 179.5295ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:25:48.893161Z","caller":"traceutil/trace.go:171","msg":"trace[329692879] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"184.497788ms","start":"2026-05-25T14:25:48.706098Z","end":"2026-05-25T14:25:48.890595Z","steps":["trace[329692879] 'process raft request' (duration: 183.880225ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:25:55.516342Z","caller":"traceutil/trace.go:171","msg":"trace[1097105254] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"288.526967ms","start":"2026-05-25T14:25:55.227789Z","end":"2026-05-25T14:25:55.516316Z","steps":["trace[1097105254] 'process raft request' (duration: 288.018966ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:25:56.011744Z","caller":"traceutil/trace.go:171","msg":"trace[551262886] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:618; }","duration":"268.016605ms","start":"2026-05-25T14:25:55.743705Z","end":"2026-05-25T14:25:56.011722Z","steps":["trace[551262886] 'read index received' (duration: 267.764249ms)","trace[551262886] 'applied index is now lower than readState.Index' (duration: 250.946µs)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:25:56.011803Z","caller":"traceutil/trace.go:171","msg":"trace[634348293] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"431.146693ms","start":"2026-05-25T14:25:55.580633Z","end":"2026-05-25T14:25:56.01178Z","steps":["trace[634348293] 'process raft request' (duration: 430.885877ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:25:56.011905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:25:55.580609Z","time spent":"431.245305ms","remote":"127.0.0.1:34006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-25T14:25:56.012008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.28698ms","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-05-25T14:25:56.012051Z","caller":"traceutil/trace.go:171","msg":"trace[317346249] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:595; }","duration":"268.376192ms","start":"2026-05-25T14:25:55.743662Z","end":"2026-05-25T14:25:56.012038Z","steps":["trace[317346249] 'agreement among raft nodes before linearized reading' (duration: 268.179298ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:25:56.292607Z","caller":"traceutil/trace.go:171","msg":"trace[1162771058] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"274.603384ms","start":"2026-05-25T14:25:56.017967Z","end":"2026-05-25T14:25:56.292571Z","steps":["trace[1162771058] 'read index received' (duration: 226.016501ms)","trace[1162771058] 'applied index is now lower than readState.Index' (duration: 48.585573ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:25:56.292671Z","caller":"traceutil/trace.go:171","msg":"trace[2075029613] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"276.669844ms","start":"2026-05-25T14:25:56.015955Z","end":"2026-05-25T14:25:56.292625Z","steps":["trace[2075029613] 'process raft request' (duration: 228.04885ms)","trace[2075029613] 'compare' (duration: 48.258897ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T14:25:56.292755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.767817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-25T14:25:56.292781Z","caller":"traceutil/trace.go:171","msg":"trace[44398599] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:596; }","duration":"274.818657ms","start":"2026-05-25T14:25:56.017955Z","end":"2026-05-25T14:25:56.292773Z","steps":["trace[44398599] 'agreement among raft nodes before linearized reading' (duration: 274.724946ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:26:12.561925Z","caller":"traceutil/trace.go:171","msg":"trace[200397342] linearizableReadLoop","detail":"{readStateIndex:787; appliedIndex:786; }","duration":"202.218364ms","start":"2026-05-25T14:26:12.359679Z","end":"2026-05-25T14:26:12.561898Z","steps":["trace[200397342] 'read index received' (duration: 202.032041ms)","trace[200397342] 'applied index is now lower than readState.Index' (duration: 185.113µs)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:26:12.561985Z","caller":"traceutil/trace.go:171","msg":"trace[869564161] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"306.188763ms","start":"2026-05-25T14:26:12.255763Z","end":"2026-05-25T14:26:12.561951Z","steps":["trace[869564161] 'process raft request' (duration: 305.973089ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:26:12.56216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.471339ms","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-05-25T14:26:12.562204Z","caller":"traceutil/trace.go:171","msg":"trace[1438612576] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:758; }","duration":"202.587671ms","start":"2026-05-25T14:26:12.359606Z","end":"2026-05-25T14:26:12.562193Z","steps":["trace[1438612576] 'agreement among raft nodes before linearized reading' (duration: 202.404838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:26:12.562513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:26:12.255724Z","time spent":"306.349017ms","remote":"127.0.0.1:33962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T14:26:12.686094Z","caller":"traceutil/trace.go:171","msg":"trace[1851239609] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"118.121506ms","start":"2026-05-25T14:26:12.567946Z","end":"2026-05-25T14:26:12.686068Z","steps":["trace[1851239609] 'process raft request' (duration: 109.035217ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:26:47.634381Z","caller":"traceutil/trace.go:171","msg":"trace[1382288883] linearizableReadLoop","detail":"{readStateIndex:1010; appliedIndex:1009; }","duration":"173.699886ms","start":"2026-05-25T14:26:47.460654Z","end":"2026-05-25T14:26:47.634353Z","steps":["trace[1382288883] 'read index received' (duration: 173.339909ms)","trace[1382288883] 'applied index is now lower than readState.Index' (duration: 358.777µs)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:26:47.634454Z","caller":"traceutil/trace.go:171","msg":"trace[544351904] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"182.198782ms","start":"2026-05-25T14:26:47.45223Z","end":"2026-05-25T14:26:47.634429Z","steps":["trace[544351904] 'process raft request' (duration: 181.849436ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:26:47.634613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.264774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T14:26:47.634635Z","caller":"traceutil/trace.go:171","msg":"trace[1089359301] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:972; }","duration":"129.343536ms","start":"2026-05-25T14:26:47.505285Z","end":"2026-05-25T14:26:47.634628Z","steps":["trace[1089359301] 'agreement among raft nodes before linearized reading' (duration: 129.285245ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:26:47.634677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.995972ms","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-05-25T14:26:47.634721Z","caller":"traceutil/trace.go:171","msg":"trace[159822285] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:972; }","duration":"174.072994ms","start":"2026-05-25T14:26:47.460636Z","end":"2026-05-25T14:26:47.634708Z","steps":["trace[159822285] 'agreement among raft nodes before linearized reading' (duration: 173.888269ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:26:48.048396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.13151ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-25T14:26:48.048495Z","caller":"traceutil/trace.go:171","msg":"trace[1615976977] linearizableReadLoop","detail":"{readStateIndex:1011; appliedIndex:1010; }","duration":"358.954688ms","start":"2026-05-25T14:26:47.689524Z","end":"2026-05-25T14:26:48.048479Z","steps":["trace[1615976977] 'read index received' (duration: 147.689755ms)","trace[1615976977] 'applied index is now lower than readState.Index' (duration: 211.263573ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:26:48.048921Z","caller":"traceutil/trace.go:171","msg":"trace[96451242] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"410.337426ms","start":"2026-05-25T14:26:47.638559Z","end":"2026-05-25T14:26:48.048897Z","steps":["trace[96451242] 'process raft request' (duration: 198.631685ms)","trace[96451242] 'compare' (duration: 210.58159ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T14:26:48.048999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:26:47.638539Z","time spent":"410.422227ms","remote":"127.0.0.1:34026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T14:26:48.049278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.740664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-25T14:26:48.04932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.800914ms","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-05-25T14:26:48.049361Z","caller":"traceutil/trace.go:171","msg":"trace[187698554] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:973; }","duration":"236.903276ms","start":"2026-05-25T14:26:47.812447Z","end":"2026-05-25T14:26:48.04935Z","steps":["trace[187698554] 'agreement among raft nodes before linearized reading' (duration: 236.785704ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:26:48.049343Z","caller":"traceutil/trace.go:171","msg":"trace[1073479407] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:973; }","duration":"359.848385ms","start":"2026-05-25T14:26:47.689481Z","end":"2026-05-25T14:26:48.04933Z","steps":["trace[1073479407] 'agreement among raft nodes before linearized reading' (duration: 359.739403ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:26:48.049391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:26:47.689461Z","time spent":"359.923437ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":29,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-05-25T14:27:10.370268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.163014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T14:27:10.370351Z","caller":"traceutil/trace.go:171","msg":"trace[269566511] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1044; }","duration":"408.299007ms","start":"2026-05-25T14:27:09.962033Z","end":"2026-05-25T14:27:10.370332Z","steps":["trace[269566511] 'range keys from in-memory index tree' (duration: 408.080743ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:10.370391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:27:09.962013Z","time spent":"408.369568ms","remote":"127.0.0.1:33772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-25T14:27:10.383588Z","caller":"traceutil/trace.go:171","msg":"trace[424293017] linearizableReadLoop","detail":"{readStateIndex:1087; appliedIndex:1086; }","duration":"235.918951ms","start":"2026-05-25T14:27:10.147657Z","end":"2026-05-25T14:27:10.383576Z","steps":["trace[424293017] 'read index received' (duration: 235.786389ms)","trace[424293017] 'applied index is now lower than readState.Index' (duration: 131.982µs)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:27:10.383658Z","caller":"traceutil/trace.go:171","msg":"trace[893044860] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"268.300411ms","start":"2026-05-25T14:27:10.115347Z","end":"2026-05-25T14:27:10.383648Z","steps":["trace[893044860] 'process raft request' (duration: 268.135318ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:10.383837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.197272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-25T14:27:10.383916Z","caller":"traceutil/trace.go:171","msg":"trace[1610052021] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1045; }","duration":"208.329863ms","start":"2026-05-25T14:27:10.175569Z","end":"2026-05-25T14:27:10.383899Z","steps":["trace[1610052021] 'agreement among raft nodes before linearized reading' (duration: 208.119129ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:10.384005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.31443ms","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-05-25T14:27:10.384078Z","caller":"traceutil/trace.go:171","msg":"trace[809747472] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1045; }","duration":"236.435571ms","start":"2026-05-25T14:27:10.147625Z","end":"2026-05-25T14:27:10.384061Z","steps":["trace[809747472] 'agreement among raft nodes before linearized reading' (duration: 236.169795ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:11.567699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.064906ms","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-05-25T14:27:11.567762Z","caller":"traceutil/trace.go:171","msg":"trace[12326889] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1048; }","duration":"251.180598ms","start":"2026-05-25T14:27:11.316567Z","end":"2026-05-25T14:27:11.567748Z","steps":["trace[12326889] 'range keys from in-memory index tree' (duration: 250.892583ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:11.568382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.735639ms","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-05-25T14:27:11.568491Z","caller":"traceutil/trace.go:171","msg":"trace[195062478] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1048; }","duration":"251.898103ms","start":"2026-05-25T14:27:11.316567Z","end":"2026-05-25T14:27:11.568465Z","steps":["trace[195062478] 'range keys from in-memory index tree' (duration: 251.478414ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:27:29.468635Z","caller":"traceutil/trace.go:171","msg":"trace[1358021870] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"274.842239ms","start":"2026-05-25T14:27:29.193773Z","end":"2026-05-25T14:27:29.468615Z","steps":["trace[1358021870] 'process raft request' (duration: 274.744517ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:29.771229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.731014ms","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-05-25T14:27:29.771323Z","caller":"traceutil/trace.go:171","msg":"trace[1629293167] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1159; }","duration":"112.870646ms","start":"2026-05-25T14:27:29.658438Z","end":"2026-05-25T14:27:29.771308Z","steps":["trace[1629293167] 'range keys from in-memory index tree' (duration: 112.370477ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:27:45.810214Z","caller":"traceutil/trace.go:171","msg":"trace[944670720] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"272.145007ms","start":"2026-05-25T14:27:45.538048Z","end":"2026-05-25T14:27:45.810193Z","steps":["trace[944670720] 'process raft request' (duration: 272.015044ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:46.41302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.213226ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-25T14:27:46.413273Z","caller":"traceutil/trace.go:171","msg":"trace[549952712] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"517.785178ms","start":"2026-05-25T14:27:45.89547Z","end":"2026-05-25T14:27:46.413255Z","steps":["trace[549952712] 'process raft request' (duration: 517.695036ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:46.413339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:27:45.895448Z","time spent":"517.858999ms","remote":"127.0.0.1:34026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T14:27:46.413438Z","caller":"traceutil/trace.go:171","msg":"trace[1819665817] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"574.891558ms","start":"2026-05-25T14:27:45.838517Z","end":"2026-05-25T14:27:46.413409Z","steps":["trace[1819665817] 'process raft request' (duration: 261.017479ms)","trace[1819665817] 'compare' (duration: 313.032303ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T14:27:46.413641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:27:45.838491Z","time spent":"575.056742ms","remote":"127.0.0.1:34026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T14:27:46.413646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.977697ms","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-05-25T14:27:46.413476Z","caller":"traceutil/trace.go:171","msg":"trace[864394] linearizableReadLoop","detail":"{readStateIndex:1283; appliedIndex:1282; }","duration":"563.61961ms","start":"2026-05-25T14:27:45.849666Z","end":"2026-05-25T14:27:46.413285Z","steps":["trace[864394] 'read index received' (duration: 249.863833ms)","trace[864394] 'applied index is now lower than readState.Index' (duration: 313.751727ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:27:46.413685Z","caller":"traceutil/trace.go:171","msg":"trace[727707986] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1233; }","duration":"564.049369ms","start":"2026-05-25T14:27:45.849623Z","end":"2026-05-25T14:27:46.413673Z","steps":["trace[727707986] 'agreement among raft nodes before linearized reading' (duration: 563.911165ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:46.413716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:27:45.849608Z","time spent":"564.10118ms","remote":"127.0.0.1:34026","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-05-25T14:27:46.417989Z","caller":"traceutil/trace.go:171","msg":"trace[921957743] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"170.712213ms","start":"2026-05-25T14:27:46.247249Z","end":"2026-05-25T14:27:46.417961Z","steps":["trace[921957743] 'process raft request' (duration: 170.433167ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:46.418038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.609137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-25T14:27:46.4181Z","caller":"traceutil/trace.go:171","msg":"trace[1053282953] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1234; }","duration":"457.720258ms","start":"2026-05-25T14:27:45.960362Z","end":"2026-05-25T14:27:46.418082Z","steps":["trace[1053282953] 'agreement among raft nodes before linearized reading' (duration: 457.466234ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:46.418146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:27:45.960345Z","time spent":"457.78792ms","remote":"127.0.0.1:33848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":113,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-05-25T14:27:46.418241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.496903ms","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":"info","ts":"2026-05-25T14:27:46.418354Z","caller":"traceutil/trace.go:171","msg":"trace[971970108] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1234; }","duration":"423.669196ms","start":"2026-05-25T14:27:45.994665Z","end":"2026-05-25T14:27:46.418335Z","steps":["trace[971970108] 'agreement among raft nodes before linearized reading' (duration: 423.485093ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:46.418404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:27:45.994642Z","time spent":"423.744518ms","remote":"127.0.0.1:48048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-25T14:27:46.418429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.729799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T14:27:46.418479Z","caller":"traceutil/trace.go:171","msg":"trace[2007428065] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1234; }","duration":"456.805361ms","start":"2026-05-25T14:27:45.961658Z","end":"2026-05-25T14:27:46.418463Z","steps":["trace[2007428065] 'agreement among raft nodes before linearized reading' (duration: 456.689518ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:46.418521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:27:45.961643Z","time spent":"456.867541ms","remote":"127.0.0.1:33772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-25T14:27:46.64Z","caller":"traceutil/trace.go:171","msg":"trace[179141516] linearizableReadLoop","detail":"{readStateIndex:1286; appliedIndex:1285; }","duration":"215.423343ms","start":"2026-05-25T14:27:46.424558Z","end":"2026-05-25T14:27:46.639981Z","steps":["trace[179141516] 'read index received' (duration: 151.155332ms)","trace[179141516] 'applied index is now lower than readState.Index' (duration: 64.267301ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:27:46.640191Z","caller":"traceutil/trace.go:171","msg":"trace[153065545] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"219.616194ms","start":"2026-05-25T14:27:46.420564Z","end":"2026-05-25T14:27:46.64018Z","steps":["trace[153065545] 'process raft request' (duration: 155.239292ms)","trace[153065545] 'compare' (duration: 64.029376ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T14:27:46.640353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.77761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T14:27:46.64038Z","caller":"traceutil/trace.go:171","msg":"trace[1252762291] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1235; }","duration":"215.824711ms","start":"2026-05-25T14:27:46.424547Z","end":"2026-05-25T14:27:46.640372Z","steps":["trace[1252762291] 'agreement among raft nodes before linearized reading' (duration: 215.75958ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:46.640437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.511418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-25T14:27:46.640466Z","caller":"traceutil/trace.go:171","msg":"trace[1987725981] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:1; response_revision:1235; }","duration":"209.570539ms","start":"2026-05-25T14:27:46.430886Z","end":"2026-05-25T14:27:46.640457Z","steps":["trace[1987725981] 'agreement among raft nodes before linearized reading' (duration: 209.464536ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:27:46.838041Z","caller":"traceutil/trace.go:171","msg":"trace[947409187] linearizableReadLoop","detail":"{readStateIndex:1289; appliedIndex:1287; }","duration":"126.035323ms","start":"2026-05-25T14:27:46.711983Z","end":"2026-05-25T14:27:46.838019Z","steps":["trace[947409187] 'read index received' (duration: 59.61693ms)","trace[947409187] 'applied index is now lower than readState.Index' (duration: 66.417233ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:27:46.838049Z","caller":"traceutil/trace.go:171","msg":"trace[1789158827] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"141.432672ms","start":"2026-05-25T14:27:46.696575Z","end":"2026-05-25T14:27:46.838008Z","steps":["trace[1789158827] 'process raft request' (duration: 74.718414ms)","trace[1789158827] 'compare' (duration: 66.473483ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:27:46.839601Z","caller":"traceutil/trace.go:171","msg":"trace[1181559225] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"121.377343ms","start":"2026-05-25T14:27:46.718192Z","end":"2026-05-25T14:27:46.839569Z","steps":["trace[1181559225] 'process raft request' (duration: 119.787252ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:27:46.839584Z","caller":"traceutil/trace.go:171","msg":"trace[2076441420] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"140.969984ms","start":"2026-05-25T14:27:46.69854Z","end":"2026-05-25T14:27:46.83951Z","steps":["trace[2076441420] 'process raft request' (duration: 139.392053ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:46.840024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.012372ms","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-05-25T14:27:46.840096Z","caller":"traceutil/trace.go:171","msg":"trace[661271978] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1238; }","duration":"128.133143ms","start":"2026-05-25T14:27:46.711947Z","end":"2026-05-25T14:27:46.84008Z","steps":["trace[661271978] 'agreement among raft nodes before linearized reading' (duration: 127.654594ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:27:47.217973Z","caller":"traceutil/trace.go:171","msg":"trace[1995872909] linearizableReadLoop","detail":"{readStateIndex:1291; appliedIndex:1290; }","duration":"372.572721ms","start":"2026-05-25T14:27:46.845376Z","end":"2026-05-25T14:27:47.217949Z","steps":["trace[1995872909] 'read index received' (duration: 315.96602ms)","trace[1995872909] 'applied index is now lower than readState.Index' (duration: 56.605871ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:27:47.218123Z","caller":"traceutil/trace.go:171","msg":"trace[652900870] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"373.187332ms","start":"2026-05-25T14:27:46.844903Z","end":"2026-05-25T14:27:47.218091Z","steps":["trace[652900870] 'process raft request' (duration: 316.462489ms)","trace[652900870] 'compare' (duration: 56.464138ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T14:27:47.21822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.769877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T14:27:47.218258Z","caller":"traceutil/trace.go:171","msg":"trace[1300453033] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1239; }","duration":"255.945391ms","start":"2026-05-25T14:27:46.962305Z","end":"2026-05-25T14:27:47.218251Z","steps":["trace[1300453033] 'agreement among raft nodes before linearized reading' (duration: 255.87049ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:47.218264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:27:46.844878Z","time spent":"373.320345ms","remote":"127.0.0.1:34026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T14:27:47.218152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.776735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-05-25T14:27:47.218336Z","caller":"traceutil/trace.go:171","msg":"trace[247246022] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1239; }","duration":"372.975169ms","start":"2026-05-25T14:27:46.845349Z","end":"2026-05-25T14:27:47.218324Z","steps":["trace[247246022] 'agreement among raft nodes before linearized reading' (duration: 372.738434ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:47.218327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.946979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-25T14:27:47.218383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:27:46.845306Z","time spent":"373.063629ms","remote":"127.0.0.1:34036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"info","ts":"2026-05-25T14:27:47.218438Z","caller":"traceutil/trace.go:171","msg":"trace[1755869639] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1239; }","duration":"130.164753ms","start":"2026-05-25T14:27:47.088245Z","end":"2026-05-25T14:27:47.21841Z","steps":["trace[1755869639] 'agreement among raft nodes before linearized reading' (duration: 129.942429ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:48.097922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.156011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T14:27:48.098016Z","caller":"traceutil/trace.go:171","msg":"trace[649786974] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1240; }","duration":"135.282104ms","start":"2026-05-25T14:27:47.962689Z","end":"2026-05-25T14:27:48.097971Z","steps":["trace[649786974] 'range keys from in-memory index tree' (duration: 135.010007ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:48.817577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.116323ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-25T14:27:48.817692Z","caller":"traceutil/trace.go:171","msg":"trace[1769051777] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"418.72853ms","start":"2026-05-25T14:27:48.398935Z","end":"2026-05-25T14:27:48.817664Z","steps":["trace[1769051777] 'process raft request' (duration: 178.443603ms)","trace[1769051777] 'compare' (duration: 239.996611ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T14:27:48.81782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:27:48.398924Z","time spent":"418.834203ms","remote":"127.0.0.1:34026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-25T14:27:48.818241Z","caller":"traceutil/trace.go:171","msg":"trace[88384046] linearizableReadLoop","detail":"{readStateIndex:1294; appliedIndex:1293; }","duration":"401.580036ms","start":"2026-05-25T14:27:48.416647Z","end":"2026-05-25T14:27:48.818227Z","steps":["trace[88384046] 'read index received' (duration: 160.746598ms)","trace[88384046] 'applied index is now lower than readState.Index' (duration: 240.831998ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:27:48.818239Z","caller":"traceutil/trace.go:171","msg":"trace[791024880] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"399.275291ms","start":"2026-05-25T14:27:48.418944Z","end":"2026-05-25T14:27:48.81822Z","steps":["trace[791024880] 'process raft request' (duration: 398.729841ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:48.818409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:27:48.41893Z","time spent":"399.398033ms","remote":"127.0.0.1:34026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T14:27:48.818458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.539548ms","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-05-25T14:27:48.818472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.80182ms","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-05-25T14:27:48.818496Z","caller":"traceutil/trace.go:171","msg":"trace[776520669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1243; }","duration":"174.612869ms","start":"2026-05-25T14:27:48.643873Z","end":"2026-05-25T14:27:48.818486Z","steps":["trace[776520669] 'agreement among raft nodes before linearized reading' (duration: 174.468626ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:27:48.818537Z","caller":"traceutil/trace.go:171","msg":"trace[925081641] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1243; }","duration":"401.902132ms","start":"2026-05-25T14:27:48.416619Z","end":"2026-05-25T14:27:48.818521Z","steps":["trace[925081641] 'agreement among raft nodes before linearized reading' (duration: 401.665158ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:48.818581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:27:48.416609Z","time spent":"401.962373ms","remote":"127.0.0.1:34026","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":"info","ts":"2026-05-25T14:27:49.076188Z","caller":"traceutil/trace.go:171","msg":"trace[1105290584] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"253.330341ms","start":"2026-05-25T14:27:48.822834Z","end":"2026-05-25T14:27:49.076164Z","steps":["trace[1105290584] 'process raft request' (duration: 253.124247ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:27:49.076467Z","caller":"traceutil/trace.go:171","msg":"trace[1422112924] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"253.568495ms","start":"2026-05-25T14:27:48.822877Z","end":"2026-05-25T14:27:49.076446Z","steps":["trace[1422112924] 'process raft request' (duration: 253.248999ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:27:49.076457Z","caller":"traceutil/trace.go:171","msg":"trace[253742748] linearizableReadLoop","detail":"{readStateIndex:1298; appliedIndex:1295; }","duration":"253.473114ms","start":"2026-05-25T14:27:48.822951Z","end":"2026-05-25T14:27:49.076424Z","steps":["trace[253742748] 'read index received' (duration: 48.553905ms)","trace[253742748] 'applied index is now lower than readState.Index' (duration: 204.916999ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T14:27:49.076691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.735289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-05-25T14:27:49.076757Z","caller":"traceutil/trace.go:171","msg":"trace[173189857] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1246; }","duration":"253.886542ms","start":"2026-05-25T14:27:48.822855Z","end":"2026-05-25T14:27:49.076741Z","steps":["trace[173189857] 'agreement among raft nodes before linearized reading' (duration: 253.658046ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:27:49.106824Z","caller":"traceutil/trace.go:171","msg":"trace[303348291] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"170.712652ms","start":"2026-05-25T14:27:48.936091Z","end":"2026-05-25T14:27:49.106804Z","steps":["trace[303348291] 'process raft request' (duration: 170.60741ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:49.107316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.439958ms","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-05-25T14:27:49.107354Z","caller":"traceutil/trace.go:171","msg":"trace[1693079318] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1247; }","duration":"262.521219ms","start":"2026-05-25T14:27:48.844821Z","end":"2026-05-25T14:27:49.107343Z","steps":["trace[1693079318] 'agreement among raft nodes before linearized reading' (duration: 262.336316ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:49.107534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.5324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T14:27:49.107565Z","caller":"traceutil/trace.go:171","msg":"trace[425979009] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1247; }","duration":"131.602821ms","start":"2026-05-25T14:27:48.975953Z","end":"2026-05-25T14:27:49.107555Z","steps":["trace[425979009] 'agreement among raft nodes before linearized reading' (duration: 131.5325ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:27:59.192464Z","caller":"traceutil/trace.go:171","msg":"trace[690499382] linearizableReadLoop","detail":"{readStateIndex:1374; appliedIndex:1373; }","duration":"283.107838ms","start":"2026-05-25T14:27:58.909331Z","end":"2026-05-25T14:27:59.192438Z","steps":["trace[690499382] 'read index received' (duration: 282.892014ms)","trace[690499382] 'applied index is now lower than readState.Index' (duration: 214.584µs)"],"step_count":2} {"level":"warn","ts":"2026-05-25T14:27:59.192666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.655108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T14:27:59.192701Z","caller":"traceutil/trace.go:171","msg":"trace[106059747] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1320; }","duration":"230.75472ms","start":"2026-05-25T14:27:58.961935Z","end":"2026-05-25T14:27:59.19269Z","steps":["trace[106059747] 'agreement among raft nodes before linearized reading' (duration: 230.670069ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:59.192841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.435925ms","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-05-25T14:27:59.19294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.343709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-25T14:27:59.192955Z","caller":"traceutil/trace.go:171","msg":"trace[2137713658] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1320; }","duration":"283.66647ms","start":"2026-05-25T14:27:58.909264Z","end":"2026-05-25T14:27:59.19293Z","steps":["trace[2137713658] 'agreement among raft nodes before linearized reading' (duration: 283.317072ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:27:59.193014Z","caller":"traceutil/trace.go:171","msg":"trace[1402634988] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1320; }","duration":"106.462821ms","start":"2026-05-25T14:27:59.086535Z","end":"2026-05-25T14:27:59.192997Z","steps":["trace[1402634988] 'agreement among raft nodes before linearized reading' (duration: 106.320288ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:59.193028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.448375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-05-25T14:27:59.193062Z","caller":"traceutil/trace.go:171","msg":"trace[531889259] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1320; }","duration":"117.530137ms","start":"2026-05-25T14:27:59.075522Z","end":"2026-05-25T14:27:59.193052Z","steps":["trace[531889259] 'agreement among raft nodes before linearized reading' (duration: 117.435365ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:27:59.193673Z","caller":"traceutil/trace.go:171","msg":"trace[969731799] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"338.787901ms","start":"2026-05-25T14:27:58.85378Z","end":"2026-05-25T14:27:59.192568Z","steps":["trace[969731799] 'process raft request' (duration: 338.464725ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:27:59.193913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T14:27:58.853733Z","time spent":"340.076977ms","remote":"127.0.0.1:34026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T14:28:27.564237Z","caller":"traceutil/trace.go:171","msg":"trace[2053596807] transaction","detail":"{read_only:false; response_revision:1454; number_of_response:1; }","duration":"200.015552ms","start":"2026-05-25T14:28:27.364194Z","end":"2026-05-25T14:28:27.56421Z","steps":["trace[2053596807] 'process raft request' (duration: 199.9094ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:28:27.564272Z","caller":"traceutil/trace.go:171","msg":"trace[2143282346] transaction","detail":"{read_only:false; response_revision:1453; number_of_response:1; }","duration":"200.720646ms","start":"2026-05-25T14:28:27.363518Z","end":"2026-05-25T14:28:27.564239Z","steps":["trace[2143282346] 'process raft request' (duration: 190.241582ms)","trace[2143282346] 'compare' (duration: 10.209259ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:28:27.564408Z","caller":"traceutil/trace.go:171","msg":"trace[2088216681] linearizableReadLoop","detail":"{readStateIndex:1515; appliedIndex:1512; }","duration":"162.206957ms","start":"2026-05-25T14:28:27.402154Z","end":"2026-05-25T14:28:27.564361Z","steps":["trace[2088216681] 'read index received' (duration: 151.583681ms)","trace[2088216681] 'applied index is now lower than readState.Index' (duration: 10.621126ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T14:28:27.564453Z","caller":"traceutil/trace.go:171","msg":"trace[307174317] transaction","detail":"{read_only:false; response_revision:1455; number_of_response:1; }","duration":"186.823365ms","start":"2026-05-25T14:28:27.377604Z","end":"2026-05-25T14:28:27.564427Z","steps":["trace[307174317] 'process raft request' (duration: 186.55338ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T14:28:27.564628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.461611ms","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-05-25T14:28:27.564697Z","caller":"traceutil/trace.go:171","msg":"trace[2033674974] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1455; }","duration":"162.580914ms","start":"2026-05-25T14:28:27.402096Z","end":"2026-05-25T14:28:27.564677Z","steps":["trace[2033674974] 'agreement among raft nodes before linearized reading' (duration: 162.39501ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T14:28:29.384668Z","caller":"traceutil/trace.go:171","msg":"trace[655203641] transaction","detail":"{read_only:false; response_revision:1459; number_of_response:1; }","duration":"122.161277ms","start":"2026-05-25T14:28:29.262485Z","end":"2026-05-25T14:28:29.384646Z","steps":["trace[655203641] 'process raft request' (duration: 121.991904ms)"],"step_count":1}