{"level":"warn","ts":"2026-02-12T02:12:33.352447Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-12T02:12:33.352579Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.131: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.131:2380","--initial-cluster=instance=https://199.204.45.131:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.131:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.131: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-02-12T02:12:33.352883Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-12T02:12:33.352903Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.131:2380"]} {"level":"info","ts":"2026-02-12T02:12:33.353129Z","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-02-12T02:12:33.356445Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.131:2379"]} {"level":"info","ts":"2026-02-12T02:12:33.358531Z","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":2,"max-cpu-available":2,"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.131:2380"],"listen-peer-urls":["https://199.204.45.131:2380"],"advertise-client-urls":["https://199.204.45.131:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.131:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.131: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-02-12T02:12:33.373494Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"12.819028ms"} {"level":"info","ts":"2026-02-12T02:12:33.414229Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2fdf33955ed9ec6c","cluster-id":"e3dd6b4ed8cb907a"} {"level":"info","ts":"2026-02-12T02:12:33.41439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c switched to configuration voters=()"} {"level":"info","ts":"2026-02-12T02:12:33.414465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became follower at term 0"} {"level":"info","ts":"2026-02-12T02:12:33.414487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2fdf33955ed9ec6c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-12T02:12:33.414533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became follower at term 1"} {"level":"info","ts":"2026-02-12T02:12:33.414642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c switched to configuration voters=(3449532556223573100)"} {"level":"warn","ts":"2026-02-12T02:12:33.465209Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-12T02:12:33.469119Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-12T02:12:33.474148Z","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-02-12T02:12:33.501647Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2fdf33955ed9ec6c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-12T02:12:33.514163Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2fdf33955ed9ec6c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-12T02:12:33.51823Z","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-02-12T02:12:33.518309Z","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-02-12T02:12:33.518342Z","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-02-12T02:12:33.519276Z","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-02-12T02:12:33.519493Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2fdf33955ed9ec6c","initial-advertise-peer-urls":["https://199.204.45.131:2380"],"listen-peer-urls":["https://199.204.45.131:2380"],"advertise-client-urls":["https://199.204.45.131:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.131:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-12T02:12:33.51955Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-12T02:12:33.519694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c switched to configuration voters=(3449532556223573100)"} {"level":"info","ts":"2026-02-12T02:12:33.51981Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e3dd6b4ed8cb907a","local-member-id":"2fdf33955ed9ec6c","added-peer-id":"2fdf33955ed9ec6c","added-peer-peer-urls":["https://199.204.45.131:2380"]} {"level":"info","ts":"2026-02-12T02:12:33.519919Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.131:2380"} {"level":"info","ts":"2026-02-12T02:12:33.519946Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.131:2380"} {"level":"info","ts":"2026-02-12T02:12:33.716198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c is starting a new election at term 1"} {"level":"info","ts":"2026-02-12T02:12:33.716302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became pre-candidate at term 1"} {"level":"info","ts":"2026-02-12T02:12:33.716336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c received MsgPreVoteResp from 2fdf33955ed9ec6c at term 1"} {"level":"info","ts":"2026-02-12T02:12:33.716377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became candidate at term 2"} {"level":"info","ts":"2026-02-12T02:12:33.7164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c received MsgVoteResp from 2fdf33955ed9ec6c at term 2"} {"level":"info","ts":"2026-02-12T02:12:33.716422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became leader at term 2"} {"level":"info","ts":"2026-02-12T02:12:33.716452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2fdf33955ed9ec6c elected leader 2fdf33955ed9ec6c at term 2"} {"level":"info","ts":"2026-02-12T02:12:33.724467Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T02:12:33.725777Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2fdf33955ed9ec6c","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.131:2379]}","request-path":"/0/members/2fdf33955ed9ec6c/attributes","cluster-id":"e3dd6b4ed8cb907a","publish-timeout":"7s"} {"level":"info","ts":"2026-02-12T02:12:33.725923Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-12T02:12:33.726386Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-12T02:12:33.726589Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-12T02:12:33.726638Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-12T02:12:33.7306Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.131:2379"} {"level":"info","ts":"2026-02-12T02:12:33.733181Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e3dd6b4ed8cb907a","local-member-id":"2fdf33955ed9ec6c","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T02:12:33.737594Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-12T02:12:33.750008Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T02:12:33.750043Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T02:12:39.18498Z","caller":"traceutil/trace.go:171","msg":"trace[1550375032] transaction","detail":"{read_only:false; response_revision:276; number_of_response:1; }","duration":"105.603614ms","start":"2026-02-12T02:12:39.079352Z","end":"2026-02-12T02:12:39.184955Z","steps":["trace[1550375032] 'process raft request' (duration: 105.537971ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:12:39.185316Z","caller":"traceutil/trace.go:171","msg":"trace[1920843885] transaction","detail":"{read_only:false; response_revision:275; number_of_response:1; }","duration":"144.206892ms","start":"2026-02-12T02:12:39.04108Z","end":"2026-02-12T02:12:39.185287Z","steps":["trace[1920843885] 'process raft request' (duration: 143.725267ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:12:39.185561Z","caller":"traceutil/trace.go:171","msg":"trace[1867227129] transaction","detail":"{read_only:false; number_of_response:0; response_revision:274; }","duration":"144.529053ms","start":"2026-02-12T02:12:39.041021Z","end":"2026-02-12T02:12:39.18555Z","steps":["trace[1867227129] 'process raft request' (duration: 62.945014ms)","trace[1867227129] 'compare' (duration: 80.776343ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T02:12:39.34981Z","caller":"traceutil/trace.go:171","msg":"trace[3719973] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"101.457161ms","start":"2026-02-12T02:12:39.248333Z","end":"2026-02-12T02:12:39.34979Z","steps":["trace[3719973] 'process raft request' (duration: 101.387189ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:12:39.350082Z","caller":"traceutil/trace.go:171","msg":"trace[1146759102] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"137.107217ms","start":"2026-02-12T02:12:39.212932Z","end":"2026-02-12T02:12:39.350039Z","steps":["trace[1146759102] 'process raft request' (duration: 129.724962ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:12:39.350408Z","caller":"traceutil/trace.go:171","msg":"trace[757078690] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"104.5402ms","start":"2026-02-12T02:12:39.245808Z","end":"2026-02-12T02:12:39.350348Z","steps":["trace[757078690] 'process raft request' (duration: 103.714624ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:12:39.350719Z","caller":"traceutil/trace.go:171","msg":"trace[1660523678] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"104.723856ms","start":"2026-02-12T02:12:39.245987Z","end":"2026-02-12T02:12:39.35071Z","steps":["trace[1660523678] 'process raft request' (duration: 103.61254ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:12:39.350973Z","caller":"traceutil/trace.go:171","msg":"trace[1383658173] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"103.403664ms","start":"2026-02-12T02:12:39.24756Z","end":"2026-02-12T02:12:39.350964Z","steps":["trace[1383658173] 'process raft request' (duration: 102.081912ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:12:39.351173Z","caller":"traceutil/trace.go:171","msg":"trace[1698480647] transaction","detail":"{read_only:false; number_of_response:0; response_revision:282; }","duration":"103.561688ms","start":"2026-02-12T02:12:39.247604Z","end":"2026-02-12T02:12:39.351166Z","steps":["trace[1698480647] 'process raft request' (duration: 102.090291ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:12:40.105146Z","caller":"traceutil/trace.go:171","msg":"trace[1847260322] transaction","detail":"{read_only:false; number_of_response:0; response_revision:308; }","duration":"110.441637ms","start":"2026-02-12T02:12:39.994676Z","end":"2026-02-12T02:12:40.105118Z","steps":["trace[1847260322] 'process raft request' (duration: 110.127377ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:12:40.10586Z","caller":"traceutil/trace.go:171","msg":"trace[803956673] transaction","detail":"{read_only:false; number_of_response:0; response_revision:308; }","duration":"111.017635ms","start":"2026-02-12T02:12:39.994829Z","end":"2026-02-12T02:12:40.105846Z","steps":["trace[803956673] 'process raft request' (duration: 110.197119ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:12:40.322219Z","caller":"traceutil/trace.go:171","msg":"trace[1943869237] linearizableReadLoop","detail":"{readStateIndex:322; appliedIndex:321; }","duration":"157.479465ms","start":"2026-02-12T02:12:40.164622Z","end":"2026-02-12T02:12:40.322101Z","steps":["trace[1943869237] 'read index received' (duration: 71.58351ms)","trace[1943869237] 'applied index is now lower than readState.Index' (duration: 85.895025ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T02:12:40.322384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.731303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:12:40.322434Z","caller":"traceutil/trace.go:171","msg":"trace[753568843] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pod-garbage-collector; range_end:; response_count:0; response_revision:311; }","duration":"157.842266ms","start":"2026-02-12T02:12:40.164582Z","end":"2026-02-12T02:12:40.322424Z","steps":["trace[753568843] 'agreement among raft nodes before linearized reading' (duration: 157.707292ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:12:40.322732Z","caller":"traceutil/trace.go:171","msg":"trace[808275404] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"171.200852ms","start":"2026-02-12T02:12:40.151517Z","end":"2026-02-12T02:12:40.322718Z","steps":["trace[808275404] 'process raft request' (duration: 84.677666ms)","trace[808275404] 'compare' (duration: 85.775752ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T02:12:59.687643Z","caller":"traceutil/trace.go:171","msg":"trace[644559019] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"105.675815ms","start":"2026-02-12T02:12:59.581943Z","end":"2026-02-12T02:12:59.687619Z","steps":["trace[644559019] 'process raft request' (duration: 105.54264ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:13:02.185383Z","caller":"traceutil/trace.go:171","msg":"trace[1373605664] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"153.475568ms","start":"2026-02-12T02:13:02.031844Z","end":"2026-02-12T02:13:02.18532Z","steps":["trace[1373605664] 'process raft request' (duration: 153.22707ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:13:11.912709Z","caller":"traceutil/trace.go:171","msg":"trace[633805379] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"149.602604ms","start":"2026-02-12T02:13:11.763088Z","end":"2026-02-12T02:13:11.91269Z","steps":["trace[633805379] 'process raft request' (duration: 149.516902ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:13:11.913531Z","caller":"traceutil/trace.go:171","msg":"trace[677291082] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:598; }","duration":"130.863977ms","start":"2026-02-12T02:13:11.782658Z","end":"2026-02-12T02:13:11.913522Z","steps":["trace[677291082] 'read index received' (duration: 130.860817ms)","trace[677291082] 'applied index is now lower than readState.Index' (duration: 2.57µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T02:13:11.915374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.697535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:13:11.915429Z","caller":"traceutil/trace.go:171","msg":"trace[594571716] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:579; }","duration":"132.766487ms","start":"2026-02-12T02:13:11.782654Z","end":"2026-02-12T02:13:11.91542Z","steps":["trace[594571716] 'agreement among raft nodes before linearized reading' (duration: 132.675464ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:12.411734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:12.036694Z","time spent":"375.035192ms","remote":"127.0.0.1:33296","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-12T02:13:12.412154Z","caller":"traceutil/trace.go:171","msg":"trace[605240383] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"498.571556ms","start":"2026-02-12T02:13:11.913563Z","end":"2026-02-12T02:13:12.412135Z","steps":["trace[605240383] 'read index received' (duration: 495.657053ms)","trace[605240383] 'applied index is now lower than readState.Index' (duration: 2.913833ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T02:13:12.412382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.908917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:13:12.412417Z","caller":"traceutil/trace.go:171","msg":"trace[796247141] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:580; }","duration":"612.972799ms","start":"2026-02-12T02:13:11.799436Z","end":"2026-02-12T02:13:12.412409Z","steps":["trace[796247141] 'agreement among raft nodes before linearized reading' (duration: 612.887546ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:12.412441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:11.799434Z","time spent":"612.9996ms","remote":"127.0.0.1:33256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:10000 "} {"level":"info","ts":"2026-02-12T02:13:12.412554Z","caller":"traceutil/trace.go:171","msg":"trace[1692707601] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"539.645684ms","start":"2026-02-12T02:13:11.872901Z","end":"2026-02-12T02:13:12.412547Z","steps":["trace[1692707601] 'process raft request' (duration: 536.3641ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:12.413077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:11.872878Z","time spent":"539.696315ms","remote":"127.0.0.1:44632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4524,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T02:13:12.413278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.83479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:13:12.413331Z","caller":"traceutil/trace.go:171","msg":"trace[1762512653] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:580; }","duration":"523.869342ms","start":"2026-02-12T02:13:11.889429Z","end":"2026-02-12T02:13:12.413298Z","steps":["trace[1762512653] 'agreement among raft nodes before linearized reading' (duration: 523.824761ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:12.413358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:11.889426Z","time spent":"523.924574ms","remote":"127.0.0.1:33268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 "} {"level":"warn","ts":"2026-02-12T02:13:12.413469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.039527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:13:12.413491Z","caller":"traceutil/trace.go:171","msg":"trace[1168887334] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:580; }","duration":"524.069398ms","start":"2026-02-12T02:13:11.889416Z","end":"2026-02-12T02:13:12.413486Z","steps":["trace[1168887334] 'agreement among raft nodes before linearized reading' (duration: 524.035167ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:12.413686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.22969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:13:12.413714Z","caller":"traceutil/trace.go:171","msg":"trace[824566010] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:580; }","duration":"614.295221ms","start":"2026-02-12T02:13:11.799412Z","end":"2026-02-12T02:13:12.413707Z","steps":["trace[824566010] 'agreement among raft nodes before linearized reading' (duration: 614.233629ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:12.413733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:11.799401Z","time spent":"614.326642ms","remote":"127.0.0.1:33256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:500 "} {"level":"warn","ts":"2026-02-12T02:13:12.413871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:11.889414Z","time spent":"524.091829ms","remote":"127.0.0.1:33268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-02-12T02:13:12.413974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.566033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:13:12.41402Z","caller":"traceutil/trace.go:171","msg":"trace[1885612406] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:580; }","duration":"524.631446ms","start":"2026-02-12T02:13:11.889356Z","end":"2026-02-12T02:13:12.413988Z","steps":["trace[1885612406] 'agreement among raft nodes before linearized reading' (duration: 524.594095ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:12.414046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:11.889343Z","time spent":"524.695988ms","remote":"127.0.0.1:33268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 "} {"level":"warn","ts":"2026-02-12T02:13:12.414044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.276122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:13:12.414144Z","caller":"traceutil/trace.go:171","msg":"trace[274666646] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:580; }","duration":"631.512769ms","start":"2026-02-12T02:13:11.782595Z","end":"2026-02-12T02:13:12.414108Z","steps":["trace[274666646] 'agreement among raft nodes before linearized reading' (duration: 631.325363ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:12.414174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.150322ms","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-02-12T02:13:12.414182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:11.782583Z","time spent":"631.591552ms","remote":"127.0.0.1:33248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:500 "} {"level":"info","ts":"2026-02-12T02:13:12.414198Z","caller":"traceutil/trace.go:171","msg":"trace[867594878] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:580; }","duration":"541.190623ms","start":"2026-02-12T02:13:11.873002Z","end":"2026-02-12T02:13:12.414192Z","steps":["trace[867594878] 'agreement among raft nodes before linearized reading' (duration: 541.149821ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:12.414218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:11.872995Z","time spent":"541.217544ms","remote":"127.0.0.1:44720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-12T02:13:12.414309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.839028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:13:12.414326Z","caller":"traceutil/trace.go:171","msg":"trace[2112678159] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:580; }","duration":"614.87135ms","start":"2026-02-12T02:13:11.79945Z","end":"2026-02-12T02:13:12.414321Z","steps":["trace[2112678159] 'agreement among raft nodes before linearized reading' (duration: 614.844379ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:12.414345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:11.799442Z","time spent":"614.89817ms","remote":"127.0.0.1:33256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-02-12T02:13:12.414412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.701275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:13:12.414436Z","caller":"traceutil/trace.go:171","msg":"trace[10320533] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:580; }","duration":"631.739986ms","start":"2026-02-12T02:13:11.782689Z","end":"2026-02-12T02:13:12.414429Z","steps":["trace[10320533] 'agreement among raft nodes before linearized reading' (duration: 631.704355ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:12.414477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:11.782683Z","time spent":"631.787687ms","remote":"127.0.0.1:33248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:10000 "} {"level":"warn","ts":"2026-02-12T02:13:12.414611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.573257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:13:12.414652Z","caller":"traceutil/trace.go:171","msg":"trace[781881282] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:580; }","duration":"498.639188ms","start":"2026-02-12T02:13:11.916006Z","end":"2026-02-12T02:13:12.414645Z","steps":["trace[781881282] 'agreement among raft nodes before linearized reading' (duration: 498.582386ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:12.41467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:11.915994Z","time spent":"498.6701ms","remote":"127.0.0.1:33278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-02-12T02:13:12.415019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.364513ms","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-02-12T02:13:12.415052Z","caller":"traceutil/trace.go:171","msg":"trace[1826470843] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:580; }","duration":"152.418504ms","start":"2026-02-12T02:13:12.262627Z","end":"2026-02-12T02:13:12.415046Z","steps":["trace[1826470843] 'agreement among raft nodes before linearized reading' (duration: 152.30415ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:12.416286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.208507ms","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-02-12T02:13:12.416312Z","caller":"traceutil/trace.go:171","msg":"trace[823969501] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:580; }","duration":"402.265669ms","start":"2026-02-12T02:13:12.014039Z","end":"2026-02-12T02:13:12.416305Z","steps":["trace[823969501] 'agreement among raft nodes before linearized reading' (duration: 401.189125ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:12.416333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:12.014022Z","time spent":"402.306301ms","remote":"127.0.0.1:44720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-12T02:13:12.416482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.47695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:13:12.416504Z","caller":"traceutil/trace.go:171","msg":"trace[1275226070] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:580; }","duration":"475.538412ms","start":"2026-02-12T02:13:11.940959Z","end":"2026-02-12T02:13:12.416498Z","steps":["trace[1275226070] 'agreement among raft nodes before linearized reading' (duration: 475.496911ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:12.416539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:11.940929Z","time spent":"475.588424ms","remote":"127.0.0.1:33286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":113,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-02-12T02:13:12.416652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.685087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:13:12.416669Z","caller":"traceutil/trace.go:171","msg":"trace[1108336893] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:580; }","duration":"475.711958ms","start":"2026-02-12T02:13:11.940953Z","end":"2026-02-12T02:13:12.416665Z","steps":["trace[1108336893] 'agreement among raft nodes before linearized reading' (duration: 475.682077ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:12.416703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:11.940949Z","time spent":"475.748819ms","remote":"127.0.0.1:33286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 "} {"level":"warn","ts":"2026-02-12T02:13:12.418651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.547596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:13:12.418678Z","caller":"traceutil/trace.go:171","msg":"trace[462725567] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:580; }","duration":"477.726802ms","start":"2026-02-12T02:13:11.940944Z","end":"2026-02-12T02:13:12.418671Z","steps":["trace[462725567] 'agreement among raft nodes before linearized reading' (duration: 477.517656ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:12.418736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:11.940914Z","time spent":"477.779974ms","remote":"127.0.0.1:33286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-02-12T02:13:12.418854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.636146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:13:12.418873Z","caller":"traceutil/trace.go:171","msg":"trace[1094522230] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:580; }","duration":"502.703717ms","start":"2026-02-12T02:13:11.916163Z","end":"2026-02-12T02:13:12.418867Z","steps":["trace[1094522230] 'agreement among raft nodes before linearized reading' (duration: 502.673056ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:12.418891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:11.916077Z","time spent":"502.809101ms","remote":"127.0.0.1:33278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-02-12T02:13:12.419004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.925665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:13:12.419022Z","caller":"traceutil/trace.go:171","msg":"trace[434648475] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:580; }","duration":"502.954645ms","start":"2026-02-12T02:13:11.916062Z","end":"2026-02-12T02:13:12.419017Z","steps":["trace[434648475] 'agreement among raft nodes before linearized reading' (duration: 502.911134ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:12.419039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:11.916058Z","time spent":"502.976697ms","remote":"127.0.0.1:33278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 "} {"level":"warn","ts":"2026-02-12T02:13:19.068098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.468146ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T02:13:19.068192Z","caller":"traceutil/trace.go:171","msg":"trace[559696705] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:622; }","duration":"538.299482ms","start":"2026-02-12T02:13:18.529874Z","end":"2026-02-12T02:13:19.068173Z","steps":["trace[559696705] 'read index received' (duration: 45.947974ms)","trace[559696705] 'applied index is now lower than readState.Index' (duration: 492.350458ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T02:13:19.068411Z","caller":"traceutil/trace.go:171","msg":"trace[145464156] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"571.454318ms","start":"2026-02-12T02:13:18.496945Z","end":"2026-02-12T02:13:19.068399Z","steps":["trace[145464156] 'process raft request' (duration: 342.441885ms)","trace[145464156] 'compare' (duration: 228.380642ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T02:13:19.068468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:18.496939Z","time spent":"571.499719ms","remote":"127.0.0.1:44720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T02:13:19.068674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.774037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:13:19.068705Z","caller":"traceutil/trace.go:171","msg":"trace[272304850] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"538.8476ms","start":"2026-02-12T02:13:18.529847Z","end":"2026-02-12T02:13:19.068694Z","steps":["trace[272304850] 'agreement among raft nodes before linearized reading' (duration: 538.775358ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:19.068733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:18.529835Z","time spent":"538.891811ms","remote":"127.0.0.1:44458","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-02-12T02:13:19.068937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.645778ms","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-02-12T02:13:19.068978Z","caller":"traceutil/trace.go:171","msg":"trace[1249186433] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:603; }","duration":"346.714271ms","start":"2026-02-12T02:13:18.722255Z","end":"2026-02-12T02:13:19.068969Z","steps":["trace[1249186433] 'agreement among raft nodes before linearized reading' (duration: 346.598397ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:19.069006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:18.722231Z","time spent":"346.766543ms","remote":"127.0.0.1:44720","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-02-12T02:13:20.425846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"895.798676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:13:20.425914Z","caller":"traceutil/trace.go:171","msg":"trace[508057590] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:605; }","duration":"895.916121ms","start":"2026-02-12T02:13:19.529982Z","end":"2026-02-12T02:13:20.425898Z","steps":["trace[508057590] 'range keys from in-memory index tree' (duration: 895.659472ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:20.42594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:19.529957Z","time spent":"895.977542ms","remote":"127.0.0.1:44446","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-02-12T02:13:20.426682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.015917ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T02:13:20.426725Z","caller":"traceutil/trace.go:171","msg":"trace[603709316] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:626; }","duration":"489.407895ms","start":"2026-02-12T02:13:19.937306Z","end":"2026-02-12T02:13:20.426714Z","steps":["trace[603709316] 'read index received' (duration: 57.267633ms)","trace[603709316] 'applied index is now lower than readState.Index' (duration: 432.139652ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T02:13:20.426862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.56437ms","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-02-12T02:13:20.426879Z","caller":"traceutil/trace.go:171","msg":"trace[1106815457] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:606; }","duration":"489.623522ms","start":"2026-02-12T02:13:19.93725Z","end":"2026-02-12T02:13:20.426874Z","steps":["trace[1106815457] 'agreement among raft nodes before linearized reading' (duration: 489.488317ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:20.426896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:19.937209Z","time spent":"489.682764ms","remote":"127.0.0.1:44720","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":"info","ts":"2026-02-12T02:13:20.427047Z","caller":"traceutil/trace.go:171","msg":"trace[1485724767] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"579.017789ms","start":"2026-02-12T02:13:19.848022Z","end":"2026-02-12T02:13:20.427039Z","steps":["trace[1485724767] 'process raft request' (duration: 146.601579ms)","trace[1485724767] 'compare' (duration: 431.730318ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T02:13:20.427086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:19.847996Z","time spent":"579.068671ms","remote":"127.0.0.1:44720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T02:13:20.871293Z","caller":"traceutil/trace.go:171","msg":"trace[1973901397] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:627; }","duration":"374.122754ms","start":"2026-02-12T02:13:20.497133Z","end":"2026-02-12T02:13:20.871255Z","steps":["trace[1973901397] 'read index received' (duration: 362.734081ms)","trace[1973901397] 'applied index is now lower than readState.Index' (duration: 11.387313ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T02:13:20.871575Z","caller":"traceutil/trace.go:171","msg":"trace[1826224327] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"440.415094ms","start":"2026-02-12T02:13:20.431146Z","end":"2026-02-12T02:13:20.871561Z","steps":["trace[1826224327] 'process raft request' (duration: 428.842106ms)","trace[1826224327] 'compare' (duration: 11.161095ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T02:13:20.871678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:20.431135Z","time spent":"440.472657ms","remote":"127.0.0.1:44720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T02:13:20.871861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.725673ms","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-02-12T02:13:20.871894Z","caller":"traceutil/trace.go:171","msg":"trace[679877655] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:607; }","duration":"374.782885ms","start":"2026-02-12T02:13:20.4971Z","end":"2026-02-12T02:13:20.871883Z","steps":["trace[679877655] 'agreement among raft nodes before linearized reading' (duration: 374.723393ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:20.871922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:20.497084Z","time spent":"374.831367ms","remote":"127.0.0.1:44720","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-02-12T02:13:20.872064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.807939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-12T02:13:20.872091Z","caller":"traceutil/trace.go:171","msg":"trace[1697247765] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:607; }","duration":"273.865441ms","start":"2026-02-12T02:13:20.598218Z","end":"2026-02-12T02:13:20.872084Z","steps":["trace[1697247765] 'agreement among raft nodes before linearized reading' (duration: 273.817839ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:13:22.255089Z","caller":"traceutil/trace.go:171","msg":"trace[230517756] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"123.819452ms","start":"2026-02-12T02:13:22.127166Z","end":"2026-02-12T02:13:22.250986Z","steps":["trace[230517756] 'process raft request' (duration: 123.567954ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:13:23.29285Z","caller":"traceutil/trace.go:171","msg":"trace[800708442] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"143.444238ms","start":"2026-02-12T02:13:23.149386Z","end":"2026-02-12T02:13:23.29283Z","steps":["trace[800708442] 'process raft request' (duration: 112.706789ms)","trace[800708442] 'compare' (duration: 30.624885ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T02:13:25.756093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.126825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:13:25.756186Z","caller":"traceutil/trace.go:171","msg":"trace[593885318] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"228.27732ms","start":"2026-02-12T02:13:25.527866Z","end":"2026-02-12T02:13:25.756143Z","steps":["trace[593885318] 'range keys from in-memory index tree' (duration: 228.048342ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:13:27.008484Z","caller":"traceutil/trace.go:171","msg":"trace[1756922869] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:668; }","duration":"106.307885ms","start":"2026-02-12T02:13:26.902162Z","end":"2026-02-12T02:13:27.008469Z","steps":["trace[1756922869] 'read index received' (duration: 106.172071ms)","trace[1756922869] 'applied index is now lower than readState.Index' (duration: 135.264µs)"],"step_count":2} {"level":"info","ts":"2026-02-12T02:13:27.008563Z","caller":"traceutil/trace.go:171","msg":"trace[1038155633] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"115.448916ms","start":"2026-02-12T02:13:26.893109Z","end":"2026-02-12T02:13:27.008558Z","steps":["trace[1038155633] 'process raft request' (duration: 115.26617ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:27.008762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.581964ms","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-02-12T02:13:27.008785Z","caller":"traceutil/trace.go:171","msg":"trace[146268104] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:647; }","duration":"106.628265ms","start":"2026-02-12T02:13:26.902151Z","end":"2026-02-12T02:13:27.00878Z","steps":["trace[146268104] 'agreement among raft nodes before linearized reading' (duration: 106.490381ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:27.008855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.55759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-12T02:13:27.008899Z","caller":"traceutil/trace.go:171","msg":"trace[1376582036] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:647; }","duration":"104.632172ms","start":"2026-02-12T02:13:26.904256Z","end":"2026-02-12T02:13:27.008889Z","steps":["trace[1376582036] 'agreement among raft nodes before linearized reading' (duration: 104.535169ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:32.89681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.724417ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-12T02:13:32.896935Z","caller":"traceutil/trace.go:171","msg":"trace[329294224] linearizableReadLoop","detail":"{readStateIndex:716; appliedIndex:715; }","duration":"366.657616ms","start":"2026-02-12T02:13:32.530257Z","end":"2026-02-12T02:13:32.896915Z","steps":["trace[329294224] 'read index received' (duration: 260.767794ms)","trace[329294224] 'applied index is now lower than readState.Index' (duration: 105.880141ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T02:13:32.897004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.739219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:13:32.89703Z","caller":"traceutil/trace.go:171","msg":"trace[1014415626] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:691; }","duration":"366.7937ms","start":"2026-02-12T02:13:32.530226Z","end":"2026-02-12T02:13:32.89702Z","steps":["trace[1014415626] 'agreement among raft nodes before linearized reading' (duration: 366.736918ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:32.897062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:32.530211Z","time spent":"366.844472ms","remote":"127.0.0.1:44446","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-02-12T02:13:41.221311Z","caller":"traceutil/trace.go:171","msg":"trace[1257872968] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"112.715833ms","start":"2026-02-12T02:13:41.108581Z","end":"2026-02-12T02:13:41.221297Z","steps":["trace[1257872968] 'process raft request' (duration: 112.32868ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:13:47.130618Z","caller":"traceutil/trace.go:171","msg":"trace[192205338] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"330.872796ms","start":"2026-02-12T02:13:46.79972Z","end":"2026-02-12T02:13:47.130593Z","steps":["trace[192205338] 'process raft request' (duration: 330.176214ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:47.130787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:46.799703Z","time spent":"330.984379ms","remote":"127.0.0.1:44720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T02:13:47.58021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.763154ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T02:13:47.580331Z","caller":"traceutil/trace.go:171","msg":"trace[1572859150] linearizableReadLoop","detail":"{readStateIndex:807; appliedIndex:805; }","duration":"341.166603ms","start":"2026-02-12T02:13:47.239153Z","end":"2026-02-12T02:13:47.58032Z","steps":["trace[1572859150] 'read index received' (duration: 88.246745ms)","trace[1572859150] 'applied index is now lower than readState.Index' (duration: 252.919208ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T02:13:47.580408Z","caller":"traceutil/trace.go:171","msg":"trace[183066329] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"389.683306ms","start":"2026-02-12T02:13:47.190703Z","end":"2026-02-12T02:13:47.580387Z","steps":["trace[183066329] 'process raft request' (duration: 389.578792ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:47.580491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.34772ms","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-02-12T02:13:47.580511Z","caller":"traceutil/trace.go:171","msg":"trace[1246768540] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:777; }","duration":"341.36928ms","start":"2026-02-12T02:13:47.239136Z","end":"2026-02-12T02:13:47.580505Z","steps":["trace[1246768540] 'agreement among raft nodes before linearized reading' (duration: 341.254167ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:47.580536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:47.23907Z","time spent":"341.459663ms","remote":"127.0.0.1:44720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-12T02:13:47.580539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:47.190689Z","time spent":"389.776168ms","remote":"127.0.0.1:44488","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T02:13:47.580701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.073319ms","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-02-12T02:13:47.58072Z","caller":"traceutil/trace.go:171","msg":"trace[1720002013] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:777; }","duration":"307.127351ms","start":"2026-02-12T02:13:47.273587Z","end":"2026-02-12T02:13:47.580715Z","steps":["trace[1720002013] 'agreement among raft nodes before linearized reading' (duration: 307.073859ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:47.580736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:47.273569Z","time spent":"307.163003ms","remote":"127.0.0.1:44720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-12T02:13:47.580752Z","caller":"traceutil/trace.go:171","msg":"trace[41790950] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"446.694208ms","start":"2026-02-12T02:13:47.134043Z","end":"2026-02-12T02:13:47.580738Z","steps":["trace[41790950] 'process raft request' (duration: 193.346676ms)","trace[41790950] 'compare' (duration: 252.67462ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T02:13:47.580814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:47.13403Z","time spent":"446.751199ms","remote":"127.0.0.1:44720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T02:13:47.580945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.729887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-12T02:13:47.580967Z","caller":"traceutil/trace.go:171","msg":"trace[909849896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:777; }","duration":"305.763298ms","start":"2026-02-12T02:13:47.275198Z","end":"2026-02-12T02:13:47.580961Z","steps":["trace[909849896] 'agreement among raft nodes before linearized reading' (duration: 305.712356ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:47.580982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:47.275193Z","time spent":"305.785788ms","remote":"127.0.0.1:44720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-12T02:13:47.581095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.912043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-12T02:13:47.581111Z","caller":"traceutil/trace.go:171","msg":"trace[909426846] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:777; }","duration":"305.947884ms","start":"2026-02-12T02:13:47.275158Z","end":"2026-02-12T02:13:47.581106Z","steps":["trace[909426846] 'agreement among raft nodes before linearized reading' (duration: 305.904513ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:47.581126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:13:47.275148Z","time spent":"305.974035ms","remote":"127.0.0.1:44720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-12T02:13:47.817928Z","caller":"traceutil/trace.go:171","msg":"trace[817065095] linearizableReadLoop","detail":"{readStateIndex:808; appliedIndex:808; }","duration":"231.012592ms","start":"2026-02-12T02:13:47.586906Z","end":"2026-02-12T02:13:47.817919Z","steps":["trace[817065095] 'read index received' (duration: 231.008172ms)","trace[817065095] 'applied index is now lower than readState.Index' (duration: 3.73µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T02:13:47.818064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.143716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-12T02:13:47.818085Z","caller":"traceutil/trace.go:171","msg":"trace[2066476108] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:778; }","duration":"231.188668ms","start":"2026-02-12T02:13:47.58689Z","end":"2026-02-12T02:13:47.818079Z","steps":["trace[2066476108] 'agreement among raft nodes before linearized reading' (duration: 231.081365ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:13:47.818375Z","caller":"traceutil/trace.go:171","msg":"trace[1732619508] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"231.611751ms","start":"2026-02-12T02:13:47.586273Z","end":"2026-02-12T02:13:47.817885Z","steps":["trace[1732619508] 'process raft request' (duration: 231.522368ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:13:47.831539Z","caller":"traceutil/trace.go:171","msg":"trace[1943269377] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"243.001574ms","start":"2026-02-12T02:13:47.588526Z","end":"2026-02-12T02:13:47.831527Z","steps":["trace[1943269377] 'process raft request' (duration: 242.858269ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:13:47.831741Z","caller":"traceutil/trace.go:171","msg":"trace[1216843927] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"241.651031ms","start":"2026-02-12T02:13:47.590069Z","end":"2026-02-12T02:13:47.83172Z","steps":["trace[1216843927] 'process raft request' (duration: 241.399093ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:13:47.831844Z","caller":"traceutil/trace.go:171","msg":"trace[909571864] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"241.638801ms","start":"2026-02-12T02:13:47.590197Z","end":"2026-02-12T02:13:47.831836Z","steps":["trace[909571864] 'process raft request' (duration: 241.29599ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:13:50.069947Z","caller":"traceutil/trace.go:171","msg":"trace[1405594692] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"246.848365ms","start":"2026-02-12T02:13:49.82309Z","end":"2026-02-12T02:13:50.069938Z","steps":["trace[1405594692] 'process raft request' (duration: 246.512365ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:13:50.069755Z","caller":"traceutil/trace.go:171","msg":"trace[1062161899] linearizableReadLoop","detail":"{readStateIndex:813; appliedIndex:812; }","duration":"234.004818ms","start":"2026-02-12T02:13:49.835732Z","end":"2026-02-12T02:13:50.069737Z","steps":["trace[1062161899] 'read index received' (duration: 233.799301ms)","trace[1062161899] 'applied index is now lower than readState.Index' (duration: 204.867µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T02:13:50.070366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.07386ms","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-02-12T02:13:50.070394Z","caller":"traceutil/trace.go:171","msg":"trace[604518907] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:783; }","duration":"234.119452ms","start":"2026-02-12T02:13:49.836267Z","end":"2026-02-12T02:13:50.070386Z","steps":["trace[604518907] 'agreement among raft nodes before linearized reading' (duration: 234.024389ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:50.070511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.772482ms","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-02-12T02:13:50.070533Z","caller":"traceutil/trace.go:171","msg":"trace[713843602] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:783; }","duration":"234.806613ms","start":"2026-02-12T02:13:49.835722Z","end":"2026-02-12T02:13:50.070528Z","steps":["trace[713843602] 'agreement among raft nodes before linearized reading' (duration: 234.748991ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:50.070621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.976652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:13:50.070642Z","caller":"traceutil/trace.go:171","msg":"trace[1552663524] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:783; }","duration":"175.032424ms","start":"2026-02-12T02:13:49.895605Z","end":"2026-02-12T02:13:50.070637Z","steps":["trace[1552663524] 'agreement among raft nodes before linearized reading' (duration: 174.998733ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:13:50.07076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.462682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-12T02:13:50.070782Z","caller":"traceutil/trace.go:171","msg":"trace[708248879] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:783; }","duration":"234.492153ms","start":"2026-02-12T02:13:49.836285Z","end":"2026-02-12T02:13:50.070777Z","steps":["trace[708248879] 'agreement among raft nodes before linearized reading' (duration: 234.438471ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:13:50.234322Z","caller":"traceutil/trace.go:171","msg":"trace[1854658727] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"156.69921ms","start":"2026-02-12T02:13:50.077607Z","end":"2026-02-12T02:13:50.234306Z","steps":["trace[1854658727] 'process raft request' (duration: 156.598337ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:13:50.254435Z","caller":"traceutil/trace.go:171","msg":"trace[1076264228] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"174.063112ms","start":"2026-02-12T02:13:50.080357Z","end":"2026-02-12T02:13:50.25442Z","steps":["trace[1076264228] 'process raft request' (duration: 174.041782ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:13:50.254576Z","caller":"traceutil/trace.go:171","msg":"trace[232689994] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"174.246708ms","start":"2026-02-12T02:13:50.080324Z","end":"2026-02-12T02:13:50.254571Z","steps":["trace[232689994] 'process raft request' (duration: 173.99958ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:14:03.957989Z","caller":"traceutil/trace.go:171","msg":"trace[1893183381] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"231.030023ms","start":"2026-02-12T02:14:03.726942Z","end":"2026-02-12T02:14:03.957972Z","steps":["trace[1893183381] 'process raft request' (duration: 230.888349ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:14:06.322263Z","caller":"traceutil/trace.go:171","msg":"trace[269879919] transaction","detail":"{read_only:false; response_revision:827; number_of_response:1; }","duration":"189.264355ms","start":"2026-02-12T02:14:06.132974Z","end":"2026-02-12T02:14:06.322238Z","steps":["trace[269879919] 'process raft request' (duration: 189.133621ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:14:06.794516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.183224ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T02:14:06.794612Z","caller":"traceutil/trace.go:171","msg":"trace[2050567217] linearizableReadLoop","detail":"{readStateIndex:863; appliedIndex:862; }","duration":"264.076123ms","start":"2026-02-12T02:14:06.530519Z","end":"2026-02-12T02:14:06.794595Z","steps":["trace[2050567217] 'read index received' (duration: 118.641891ms)","trace[2050567217] 'applied index is now lower than readState.Index' (duration: 145.432742ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T02:14:06.794698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.175346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:14:06.794724Z","caller":"traceutil/trace.go:171","msg":"trace[1174905184] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:830; }","duration":"264.269589ms","start":"2026-02-12T02:14:06.530444Z","end":"2026-02-12T02:14:06.794714Z","steps":["trace[1174905184] 'agreement among raft nodes before linearized reading' (duration: 264.194077ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:14:06.795093Z","caller":"traceutil/trace.go:171","msg":"trace[681896120] transaction","detail":"{read_only:false; response_revision:830; number_of_response:1; }","duration":"398.96458ms","start":"2026-02-12T02:14:06.396106Z","end":"2026-02-12T02:14:06.79507Z","steps":["trace[681896120] 'process raft request' (duration: 253.146896ms)","trace[681896120] 'compare' (duration: 144.772441ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T02:14:06.795179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:14:06.396092Z","time spent":"399.039902ms","remote":"127.0.0.1:44720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T02:14:07.650794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.321606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-12T02:14:07.650871Z","caller":"traceutil/trace.go:171","msg":"trace[2102730374] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:831; }","duration":"435.44515ms","start":"2026-02-12T02:14:07.215408Z","end":"2026-02-12T02:14:07.650853Z","steps":["trace[2102730374] 'count revisions from in-memory index tree' (duration: 435.253894ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:14:07.650912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:14:07.21539Z","time spent":"435.511112ms","remote":"127.0.0.1:44912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":2,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"info","ts":"2026-02-12T02:14:07.717424Z","caller":"traceutil/trace.go:171","msg":"trace[73032108] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"422.146067ms","start":"2026-02-12T02:14:07.295224Z","end":"2026-02-12T02:14:07.71737Z","steps":["trace[73032108] 'process raft request' (duration: 421.61558ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:14:07.719036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:14:07.29521Z","time spent":"423.692376ms","remote":"127.0.0.1:44720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T02:14:08.35777Z","caller":"traceutil/trace.go:171","msg":"trace[1586532553] transaction","detail":"{read_only:false; response_revision:833; number_of_response:1; }","duration":"384.524111ms","start":"2026-02-12T02:14:07.973226Z","end":"2026-02-12T02:14:08.35775Z","steps":["trace[1586532553] 'process raft request' (duration: 384.064527ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:14:08.358155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:14:07.973208Z","time spent":"384.823321ms","remote":"127.0.0.1:44720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T02:14:08.977328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.292367ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T02:14:08.97744Z","caller":"traceutil/trace.go:171","msg":"trace[78725262] linearizableReadLoop","detail":"{readStateIndex:868; appliedIndex:867; }","duration":"598.669747ms","start":"2026-02-12T02:14:08.378747Z","end":"2026-02-12T02:14:08.977416Z","steps":["trace[78725262] 'read index received' (duration: 470.102941ms)","trace[78725262] 'applied index is now lower than readState.Index' (duration: 128.565266ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T02:14:08.977662Z","caller":"traceutil/trace.go:171","msg":"trace[776008761] transaction","detail":"{read_only:false; response_revision:834; number_of_response:1; }","duration":"614.741659ms","start":"2026-02-12T02:14:08.362906Z","end":"2026-02-12T02:14:08.977648Z","steps":["trace[776008761] 'process raft request' (duration: 486.035208ms)","trace[776008761] 'compare' (duration: 125.760137ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T02:14:08.97775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:14:08.362891Z","time spent":"614.824882ms","remote":"127.0.0.1:44720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T02:14:08.97799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.237835ms","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-02-12T02:14:08.978029Z","caller":"traceutil/trace.go:171","msg":"trace[853074991] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:834; }","duration":"599.295748ms","start":"2026-02-12T02:14:08.378722Z","end":"2026-02-12T02:14:08.978018Z","steps":["trace[853074991] 'agreement among raft nodes before linearized reading' (duration: 599.181184ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:14:08.978065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:14:08.378711Z","time spent":"599.345629ms","remote":"127.0.0.1:44720","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-02-12T02:14:08.978287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.893477ms","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-02-12T02:14:08.978326Z","caller":"traceutil/trace.go:171","msg":"trace[1387917817] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:834; }","duration":"582.942808ms","start":"2026-02-12T02:14:08.395372Z","end":"2026-02-12T02:14:08.978315Z","steps":["trace[1387917817] 'agreement among raft nodes before linearized reading' (duration: 582.851535ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:14:08.978352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:14:08.395364Z","time spent":"582.982629ms","remote":"127.0.0.1:44720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-12T02:14:08.978646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.825752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-12T02:14:08.978687Z","caller":"traceutil/trace.go:171","msg":"trace[947929842] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:834; }","duration":"177.899235ms","start":"2026-02-12T02:14:08.800778Z","end":"2026-02-12T02:14:08.978678Z","steps":["trace[947929842] 'agreement among raft nodes before linearized reading' (duration: 177.809692ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:14:08.97881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.846486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:14:08.978843Z","caller":"traceutil/trace.go:171","msg":"trace[416223066] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:834; }","duration":"448.904598ms","start":"2026-02-12T02:14:08.529931Z","end":"2026-02-12T02:14:08.978835Z","steps":["trace[416223066] 'agreement among raft nodes before linearized reading' (duration: 448.860996ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:14:08.978869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:14:08.529918Z","time spent":"448.945858ms","remote":"127.0.0.1:44446","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-02-12T02:14:09.141956Z","caller":"traceutil/trace.go:171","msg":"trace[1746304326] transaction","detail":"{read_only:false; response_revision:837; number_of_response:1; }","duration":"153.479038ms","start":"2026-02-12T02:14:08.988453Z","end":"2026-02-12T02:14:09.141932Z","steps":["trace[1746304326] 'process raft request' (duration: 153.422327ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:14:09.142248Z","caller":"traceutil/trace.go:171","msg":"trace[1945164095] transaction","detail":"{read_only:false; response_revision:836; number_of_response:1; }","duration":"153.83275ms","start":"2026-02-12T02:14:08.988393Z","end":"2026-02-12T02:14:09.142226Z","steps":["trace[1945164095] 'process raft request' (duration: 140.516996ms)","trace[1945164095] 'compare' (duration: 12.835208ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T02:14:34.747075Z","caller":"traceutil/trace.go:171","msg":"trace[969379859] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"264.036701ms","start":"2026-02-12T02:14:34.483018Z","end":"2026-02-12T02:14:34.747055Z","steps":["trace[969379859] 'process raft request' (duration: 263.906847ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:14:35.056163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.693568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:14:35.056229Z","caller":"traceutil/trace.go:171","msg":"trace[1178885015] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:965; }","duration":"155.795231ms","start":"2026-02-12T02:14:34.900422Z","end":"2026-02-12T02:14:35.056217Z","steps":["trace[1178885015] 'range keys from in-memory index tree' (duration: 155.622916ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:14:45.062016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.897768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:14:45.062073Z","caller":"traceutil/trace.go:171","msg":"trace[950897816] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:994; }","duration":"165.997321ms","start":"2026-02-12T02:14:44.896062Z","end":"2026-02-12T02:14:45.062059Z","steps":["trace[950897816] 'range keys from in-memory index tree' (duration: 165.819985ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:14:49.092464Z","caller":"traceutil/trace.go:171","msg":"trace[222900636] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"207.178538ms","start":"2026-02-12T02:14:48.885261Z","end":"2026-02-12T02:14:49.09244Z","steps":["trace[222900636] 'process raft request' (duration: 207.049074ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:14:49.22835Z","caller":"traceutil/trace.go:171","msg":"trace[175224652] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"336.818644ms","start":"2026-02-12T02:14:48.891513Z","end":"2026-02-12T02:14:49.228331Z","steps":["trace[175224652] 'process raft request' (duration: 294.318234ms)","trace[175224652] 'compare' (duration: 42.233001ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T02:14:49.228482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:14:48.891499Z","time spent":"336.915497ms","remote":"127.0.0.1:44720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T02:14:57.802097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.55872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:14:57.802192Z","caller":"traceutil/trace.go:171","msg":"trace[1205103039] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1031; }","duration":"275.687114ms","start":"2026-02-12T02:14:57.526488Z","end":"2026-02-12T02:14:57.802175Z","steps":["trace[1205103039] 'range keys from in-memory index tree' (duration: 275.513588ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:14:57.802499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.285495ms","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-02-12T02:14:57.802541Z","caller":"traceutil/trace.go:171","msg":"trace[1459832424] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1031; }","duration":"266.346307ms","start":"2026-02-12T02:14:57.536181Z","end":"2026-02-12T02:14:57.802527Z","steps":["trace[1459832424] 'range keys from in-memory index tree' (duration: 266.168531ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:14:59.269785Z","caller":"traceutil/trace.go:171","msg":"trace[69476368] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"122.998475ms","start":"2026-02-12T02:14:59.146762Z","end":"2026-02-12T02:14:59.26976Z","steps":["trace[69476368] 'process raft request' (duration: 122.903442ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:15:01.526958Z","caller":"traceutil/trace.go:171","msg":"trace[801696698] linearizableReadLoop","detail":"{readStateIndex:1084; appliedIndex:1083; }","duration":"225.229901ms","start":"2026-02-12T02:15:01.301713Z","end":"2026-02-12T02:15:01.526943Z","steps":["trace[801696698] 'read index received' (duration: 225.096657ms)","trace[801696698] 'applied index is now lower than readState.Index' (duration: 132.584µs)"],"step_count":2} {"level":"info","ts":"2026-02-12T02:15:01.527133Z","caller":"traceutil/trace.go:171","msg":"trace[1385768368] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"250.193393ms","start":"2026-02-12T02:15:01.276932Z","end":"2026-02-12T02:15:01.527125Z","steps":["trace[1385768368] 'process raft request' (duration: 249.918895ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:15:01.527314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.596823ms","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-02-12T02:15:01.527334Z","caller":"traceutil/trace.go:171","msg":"trace[886394982] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1039; }","duration":"225.658105ms","start":"2026-02-12T02:15:01.30167Z","end":"2026-02-12T02:15:01.527328Z","steps":["trace[886394982] 'agreement among raft nodes before linearized reading' (duration: 225.566972ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:15:01.527441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.068397ms","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-02-12T02:15:01.527457Z","caller":"traceutil/trace.go:171","msg":"trace[1346007640] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1039; }","duration":"174.085608ms","start":"2026-02-12T02:15:01.353367Z","end":"2026-02-12T02:15:01.527452Z","steps":["trace[1346007640] 'agreement among raft nodes before linearized reading' (duration: 174.040486ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T02:15:01.815135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.725742ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T02:15:01.815249Z","caller":"traceutil/trace.go:171","msg":"trace[1003479070] linearizableReadLoop","detail":"{readStateIndex:1086; appliedIndex:1084; }","duration":"274.599899ms","start":"2026-02-12T02:15:01.54064Z","end":"2026-02-12T02:15:01.81524Z","steps":["trace[1003479070] 'read index received' (duration: 165.733053ms)","trace[1003479070] 'applied index is now lower than readState.Index' (duration: 108.866286ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T02:15:01.815292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.650761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T02:15:01.815304Z","caller":"traceutil/trace.go:171","msg":"trace[1996382079] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1042; }","duration":"274.682791ms","start":"2026-02-12T02:15:01.540617Z","end":"2026-02-12T02:15:01.815299Z","steps":["trace[1996382079] 'agreement among raft nodes before linearized reading' (duration: 274.64743ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:15:01.815461Z","caller":"traceutil/trace.go:171","msg":"trace[1743958631] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"279.593397ms","start":"2026-02-12T02:15:01.535859Z","end":"2026-02-12T02:15:01.815453Z","steps":["trace[1743958631] 'process raft request' (duration: 170.501813ms)","trace[1743958631] 'compare' (duration: 108.352921ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T02:15:01.815521Z","caller":"traceutil/trace.go:171","msg":"trace[2128602889] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"279.524275ms","start":"2026-02-12T02:15:01.535992Z","end":"2026-02-12T02:15:01.815517Z","steps":["trace[2128602889] 'process raft request' (duration: 279.198455ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:15:01.815584Z","caller":"traceutil/trace.go:171","msg":"trace[804752625] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"274.432503ms","start":"2026-02-12T02:15:01.541147Z","end":"2026-02-12T02:15:01.81558Z","steps":["trace[804752625] 'process raft request' (duration: 274.073172ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:18:15.623303Z","caller":"traceutil/trace.go:171","msg":"trace[2048395513] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"205.396519ms","start":"2026-02-12T02:18:15.417874Z","end":"2026-02-12T02:18:15.623271Z","steps":["trace[2048395513] 'process raft request' (duration: 205.244344ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T02:18:50.237754Z","caller":"traceutil/trace.go:171","msg":"trace[52411932] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"108.906942ms","start":"2026-02-12T02:18:50.128821Z","end":"2026-02-12T02:18:50.237728Z","steps":["trace[52411932] 'process raft request' (duration: 47.779949ms)","trace[52411932] 'compare' (duration: 60.816723ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T02:18:52.478484Z","caller":"traceutil/trace.go:171","msg":"trace[873388246] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"135.468455ms","start":"2026-02-12T02:18:52.342981Z","end":"2026-02-12T02:18:52.478449Z","steps":["trace[873388246] 'process raft request' (duration: 77.656967ms)","trace[873388246] 'compare' (duration: 57.53268ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T02:18:52.478561Z","caller":"traceutil/trace.go:171","msg":"trace[135601762] linearizableReadLoop","detail":"{readStateIndex:2258; appliedIndex:2257; }","duration":"106.613529ms","start":"2026-02-12T02:18:52.371938Z","end":"2026-02-12T02:18:52.478552Z","steps":["trace[135601762] 'read index received' (duration: 48.857352ms)","trace[135601762] 'applied index is now lower than readState.Index' (duration: 57.754977ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T02:18:52.522156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.153903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-5d8ff44fc9-qt477\" ","response":"range_response_count:1 size:12539"} {"level":"info","ts":"2026-02-12T02:18:52.522251Z","caller":"traceutil/trace.go:171","msg":"trace[1136363446] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-5d8ff44fc9-qt477; range_end:; response_count:1; response_revision:2164; }","duration":"150.307238ms","start":"2026-02-12T02:18:52.371915Z","end":"2026-02-12T02:18:52.522223Z","steps":["trace[1136363446] 'agreement among raft nodes before linearized reading' (duration: 106.66038ms)","trace[1136363446] 'range keys from in-memory index tree' (duration: 43.41306ms)"],"step_count":2}