{"level":"warn","ts":"2026-02-07T03:54:42.504245Z","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-07T03:54:42.504342Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.169: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.169:2380","--initial-cluster=instance=https://199.204.45.169:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.169:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.169: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-07T03:54:42.504493Z","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-07T03:54:42.50451Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-02-07T03:54:42.504602Z","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-07T03:54:42.505274Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"]} {"level":"info","ts":"2026-02-07T03:54:42.505399Z","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.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.169: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-07T03:54:42.509611Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.993269ms"} {"level":"info","ts":"2026-02-07T03:54:42.520084Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1c917701ce165bac","cluster-id":"bfb5247022b87cb1"} {"level":"info","ts":"2026-02-07T03:54:42.520223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=()"} {"level":"info","ts":"2026-02-07T03:54:42.520249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 0"} {"level":"info","ts":"2026-02-07T03:54:42.520294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1c917701ce165bac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-07T03:54:42.520309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 1"} {"level":"info","ts":"2026-02-07T03:54:42.520373Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"warn","ts":"2026-02-07T03:54:42.540029Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-07T03:54:42.546666Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-07T03:54:42.548252Z","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-07T03:54:42.553357Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1c917701ce165bac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-07T03:54:42.553693Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1c917701ce165bac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-07T03:54:42.553833Z","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-07T03:54:42.553876Z","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-07T03:54:42.553885Z","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-07T03:54:42.555294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"info","ts":"2026-02-07T03:54:42.555435Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","added-peer-id":"1c917701ce165bac","added-peer-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-02-07T03:54:42.567734Z","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-07T03:54:42.56796Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-02-07T03:54:42.568067Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-02-07T03:54:42.568043Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1c917701ce165bac","initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-07T03:54:42.568187Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-07T03:54:43.224044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac is starting a new election at term 1"} {"level":"info","ts":"2026-02-07T03:54:43.22409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became pre-candidate at term 1"} {"level":"info","ts":"2026-02-07T03:54:43.22411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgPreVoteResp from 1c917701ce165bac at term 1"} {"level":"info","ts":"2026-02-07T03:54:43.22412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became candidate at term 2"} {"level":"info","ts":"2026-02-07T03:54:43.224125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgVoteResp from 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-02-07T03:54:43.224134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became leader at term 2"} {"level":"info","ts":"2026-02-07T03:54:43.22414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1c917701ce165bac elected leader 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-02-07T03:54:43.23566Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-07T03:54:43.243593Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1c917701ce165bac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.169:2379]}","request-path":"/0/members/1c917701ce165bac/attributes","cluster-id":"bfb5247022b87cb1","publish-timeout":"7s"} {"level":"info","ts":"2026-02-07T03:54:43.248125Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-07T03:54:43.248464Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-07T03:54:43.249267Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-07T03:54:43.24928Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-07T03:54:43.250093Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.169:2379"} {"level":"info","ts":"2026-02-07T03:54:43.258376Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","cluster-version":"3.5"} {"level":"info","ts":"2026-02-07T03:54:43.258449Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-07T03:54:43.258475Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-07T03:54:43.275047Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-07T03:55:07.532308Z","caller":"traceutil/trace.go:171","msg":"trace[808514664] linearizableReadLoop","detail":"{readStateIndex:477; appliedIndex:476; }","duration":"298.369684ms","start":"2026-02-07T03:55:07.233914Z","end":"2026-02-07T03:55:07.532284Z","steps":["trace[808514664] 'read index received' (duration: 298.204593ms)","trace[808514664] 'applied index is now lower than readState.Index' (duration: 164.271µs)"],"step_count":2} {"level":"info","ts":"2026-02-07T03:55:07.532567Z","caller":"traceutil/trace.go:171","msg":"trace[529132116] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"379.768175ms","start":"2026-02-07T03:55:07.152786Z","end":"2026-02-07T03:55:07.532554Z","steps":["trace[529132116] 'process raft request' (duration: 379.385473ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:07.533056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:07.152765Z","time spent":"379.828765ms","remote":"127.0.0.1:50070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-07T03:55:07.533251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.33945ms","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-07T03:55:07.533292Z","caller":"traceutil/trace.go:171","msg":"trace[815028822] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:463; }","duration":"299.41687ms","start":"2026-02-07T03:55:07.233864Z","end":"2026-02-07T03:55:07.533281Z","steps":["trace[815028822] 'agreement among raft nodes before linearized reading' (duration: 299.34958ms)"],"step_count":1} {"level":"info","ts":"2026-02-07T03:55:09.699098Z","caller":"traceutil/trace.go:171","msg":"trace[2114246213] linearizableReadLoop","detail":"{readStateIndex:483; appliedIndex:482; }","duration":"139.900814ms","start":"2026-02-07T03:55:09.559178Z","end":"2026-02-07T03:55:09.699079Z","steps":["trace[2114246213] 'read index received' (duration: 129.43896ms)","trace[2114246213] 'applied index is now lower than readState.Index' (duration: 10.461174ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T03:55:09.699215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.019695ms","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-07T03:55:09.699233Z","caller":"traceutil/trace.go:171","msg":"trace[1950855725] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:469; }","duration":"140.080345ms","start":"2026-02-07T03:55:09.559146Z","end":"2026-02-07T03:55:09.699226Z","steps":["trace[1950855725] 'agreement among raft nodes before linearized reading' (duration: 140.007995ms)"],"step_count":1} {"level":"info","ts":"2026-02-07T03:55:09.699286Z","caller":"traceutil/trace.go:171","msg":"trace[669662341] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"140.491658ms","start":"2026-02-07T03:55:09.558772Z","end":"2026-02-07T03:55:09.699264Z","steps":["trace[669662341] 'process raft request' (duration: 129.885233ms)","trace[669662341] 'compare' (duration: 10.352744ms)"],"step_count":2} {"level":"info","ts":"2026-02-07T03:55:14.64327Z","caller":"traceutil/trace.go:171","msg":"trace[534397959] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:567; }","duration":"271.062387ms","start":"2026-02-07T03:55:14.37219Z","end":"2026-02-07T03:55:14.643252Z","steps":["trace[534397959] 'read index received' (duration: 265.196291ms)","trace[534397959] 'applied index is now lower than readState.Index' (duration: 5.865346ms)"],"step_count":2} {"level":"info","ts":"2026-02-07T03:55:14.643493Z","caller":"traceutil/trace.go:171","msg":"trace[370473813] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"386.903718ms","start":"2026-02-07T03:55:14.256582Z","end":"2026-02-07T03:55:14.643486Z","steps":["trace[370473813] 'process raft request' (duration: 380.869526ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:14.643567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:14.256559Z","time spent":"386.95957ms","remote":"127.0.0.1:49866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-07T03:55:14.643692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.505393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:55:14.643719Z","caller":"traceutil/trace.go:171","msg":"trace[209668779] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:552; }","duration":"271.556245ms","start":"2026-02-07T03:55:14.372155Z","end":"2026-02-07T03:55:14.643711Z","steps":["trace[209668779] 'agreement among raft nodes before linearized reading' (duration: 271.518603ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:14.643852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.787386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-07T03:55:14.643874Z","caller":"traceutil/trace.go:171","msg":"trace[1021104959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:552; }","duration":"191.843858ms","start":"2026-02-07T03:55:14.452025Z","end":"2026-02-07T03:55:14.643869Z","steps":["trace[1021104959] 'agreement among raft nodes before linearized reading' (duration: 191.772586ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:17.427126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.492747ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-07T03:55:17.427218Z","caller":"traceutil/trace.go:171","msg":"trace[1460008069] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"687.700677ms","start":"2026-02-07T03:55:16.739502Z","end":"2026-02-07T03:55:17.427202Z","steps":["trace[1460008069] 'read index received' (duration: 290.20188ms)","trace[1460008069] 'applied index is now lower than readState.Index' (duration: 397.497807ms)"],"step_count":2} {"level":"info","ts":"2026-02-07T03:55:17.427278Z","caller":"traceutil/trace.go:171","msg":"trace[1616909125] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"688.015128ms","start":"2026-02-07T03:55:16.739252Z","end":"2026-02-07T03:55:17.427267Z","steps":["trace[1616909125] 'process raft request' (duration: 290.18392ms)","trace[1616909125] 'compare' (duration: 397.364693ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T03:55:17.427336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:16.739236Z","time spent":"688.07262ms","remote":"127.0.0.1:49854","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-07T03:55:17.427662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"688.155482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-07T03:55:17.427691Z","caller":"traceutil/trace.go:171","msg":"trace[1612543174] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:582; }","duration":"688.197514ms","start":"2026-02-07T03:55:16.739484Z","end":"2026-02-07T03:55:17.427682Z","steps":["trace[1612543174] 'agreement among raft nodes before linearized reading' (duration: 688.07306ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:17.427718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:16.739479Z","time spent":"688.232975ms","remote":"127.0.0.1:50070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-07T03:55:18.106904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.784397ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-07T03:55:18.107101Z","caller":"traceutil/trace.go:171","msg":"trace[540078255] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:599; }","duration":"679.849189ms","start":"2026-02-07T03:55:17.42724Z","end":"2026-02-07T03:55:18.10709Z","steps":["trace[540078255] 'read index received' (duration: 486.840244ms)","trace[540078255] 'applied index is now lower than readState.Index' (duration: 193.008465ms)"],"step_count":2} {"level":"info","ts":"2026-02-07T03:55:18.107512Z","caller":"traceutil/trace.go:171","msg":"trace[353850102] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"1.343639789s","start":"2026-02-07T03:55:16.763865Z","end":"2026-02-07T03:55:18.107505Z","steps":["trace[353850102] 'process raft request' (duration: 1.150208341s)","trace[353850102] 'compare' (duration: 192.628632ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T03:55:18.10755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:16.76385Z","time spent":"1.34367732s","remote":"127.0.0.1:49866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-07T03:55:18.107634Z","caller":"traceutil/trace.go:171","msg":"trace[1857604373] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"1.305417064s","start":"2026-02-07T03:55:16.802213Z","end":"2026-02-07T03:55:18.10763Z","steps":["trace[1857604373] 'process raft request' (duration: 1.304783403s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:18.107662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:16.802197Z","time spent":"1.305446334s","remote":"127.0.0.1:49866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188228,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-07T03:55:18.107825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.015534488s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188243"} {"level":"info","ts":"2026-02-07T03:55:18.107841Z","caller":"traceutil/trace.go:171","msg":"trace[1501987889] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:584; }","duration":"1.015570619s","start":"2026-02-07T03:55:17.092265Z","end":"2026-02-07T03:55:18.107835Z","steps":["trace[1501987889] 'agreement among raft nodes before linearized reading' (duration: 1.015458686s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:18.107856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:17.092248Z","time spent":"1.01560479s","remote":"127.0.0.1:49866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":1,"response size":188266,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-07T03:55:18.108019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.276630809s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:55:18.108037Z","caller":"traceutil/trace.go:171","msg":"trace[1201729539] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:584; }","duration":"1.276672511s","start":"2026-02-07T03:55:16.83136Z","end":"2026-02-07T03:55:18.108033Z","steps":["trace[1201729539] 'agreement among raft nodes before linearized reading' (duration: 1.27664335s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:18.108128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:16.831347Z","time spent":"1.276773775s","remote":"127.0.0.1:49810","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-07T03:55:18.108244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.316023875s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-02-07T03:55:18.108263Z","caller":"traceutil/trace.go:171","msg":"trace[2023377879] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:584; }","duration":"1.316063095s","start":"2026-02-07T03:55:16.792195Z","end":"2026-02-07T03:55:18.108258Z","steps":["trace[2023377879] 'agreement among raft nodes before linearized reading' (duration: 1.316001833s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:18.108277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:16.792181Z","time spent":"1.316091397s","remote":"127.0.0.1:49866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":24267,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"warn","ts":"2026-02-07T03:55:18.108367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.368840359s","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-07T03:55:18.108384Z","caller":"traceutil/trace.go:171","msg":"trace[1614696351] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:584; }","duration":"1.368863229s","start":"2026-02-07T03:55:16.739517Z","end":"2026-02-07T03:55:18.10838Z","steps":["trace[1614696351] 'agreement among raft nodes before linearized reading' (duration: 1.368822258s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:18.108396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:16.739514Z","time spent":"1.36887867s","remote":"127.0.0.1:50070","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-07T03:55:18.108899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.198275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-02-07T03:55:18.108921Z","caller":"traceutil/trace.go:171","msg":"trace[611444802] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:585; }","duration":"679.277598ms","start":"2026-02-07T03:55:17.429639Z","end":"2026-02-07T03:55:18.108917Z","steps":["trace[611444802] 'agreement among raft nodes before linearized reading' (duration: 679.230246ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:18.108935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:17.42962Z","time spent":"679.31144ms","remote":"127.0.0.1:49948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":445,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"info","ts":"2026-02-07T03:55:18.109034Z","caller":"traceutil/trace.go:171","msg":"trace[552600626] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"676.266817ms","start":"2026-02-07T03:55:17.432763Z","end":"2026-02-07T03:55:18.10903Z","steps":["trace[552600626] 'process raft request' (duration: 676.07469ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:18.109104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:17.432742Z","time spent":"676.309689ms","remote":"127.0.0.1:50070","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-07T03:55:18.10923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.756314ms","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-07T03:55:18.109248Z","caller":"traceutil/trace.go:171","msg":"trace[2076635422] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:585; }","duration":"357.798636ms","start":"2026-02-07T03:55:17.751445Z","end":"2026-02-07T03:55:18.109244Z","steps":["trace[2076635422] 'agreement among raft nodes before linearized reading' (duration: 357.757685ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:18.109261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:17.751432Z","time spent":"357.825037ms","remote":"127.0.0.1:50070","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-07T03:55:18.109331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.118765ms","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-07T03:55:18.109347Z","caller":"traceutil/trace.go:171","msg":"trace[1981915860] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:585; }","duration":"376.172087ms","start":"2026-02-07T03:55:17.733172Z","end":"2026-02-07T03:55:18.109344Z","steps":["trace[1981915860] 'agreement among raft nodes before linearized reading' (duration: 376.133136ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:18.109359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:17.733151Z","time spent":"376.205298ms","remote":"127.0.0.1:50070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-07T03:55:18.1098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.01843ms","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-07T03:55:18.109979Z","caller":"traceutil/trace.go:171","msg":"trace[777998765] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:585; }","duration":"485.218117ms","start":"2026-02-07T03:55:17.624714Z","end":"2026-02-07T03:55:18.109932Z","steps":["trace[777998765] 'agreement among raft nodes before linearized reading' (duration: 484.750421ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:18.110099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:17.624695Z","time spent":"485.389753ms","remote":"127.0.0.1:50070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-07T03:55:22.35388Z","caller":"traceutil/trace.go:171","msg":"trace[1868460742] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"216.53225ms","start":"2026-02-07T03:55:22.137324Z","end":"2026-02-07T03:55:22.353856Z","steps":["trace[1868460742] 'read index received' (duration: 197.790482ms)","trace[1868460742] 'applied index is now lower than readState.Index' (duration: 18.740778ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T03:55:22.354071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.727256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-07T03:55:22.354092Z","caller":"traceutil/trace.go:171","msg":"trace[475853899] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:603; }","duration":"216.794748ms","start":"2026-02-07T03:55:22.137291Z","end":"2026-02-07T03:55:22.354086Z","steps":["trace[475853899] 'agreement among raft nodes before linearized reading' (duration: 216.675794ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:22.354295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.652793ms","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-07T03:55:22.354313Z","caller":"traceutil/trace.go:171","msg":"trace[1040811169] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:603; }","duration":"216.695175ms","start":"2026-02-07T03:55:22.137612Z","end":"2026-02-07T03:55:22.354308Z","steps":["trace[1040811169] 'agreement among raft nodes before linearized reading' (duration: 216.643243ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:22.354566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.524976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:55:22.354587Z","caller":"traceutil/trace.go:171","msg":"trace[1074151780] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:603; }","duration":"112.556047ms","start":"2026-02-07T03:55:22.242024Z","end":"2026-02-07T03:55:22.35458Z","steps":["trace[1074151780] 'agreement among raft nodes before linearized reading' (duration: 112.522805ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:22.354675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.650149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:55:22.354691Z","caller":"traceutil/trace.go:171","msg":"trace[687726010] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:603; }","duration":"112.66792ms","start":"2026-02-07T03:55:22.242019Z","end":"2026-02-07T03:55:22.354686Z","steps":["trace[687726010] 'agreement among raft nodes before linearized reading' (duration: 112.642319ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:22.354757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.753133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:55:22.354776Z","caller":"traceutil/trace.go:171","msg":"trace[771093191] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:603; }","duration":"112.791774ms","start":"2026-02-07T03:55:22.24198Z","end":"2026-02-07T03:55:22.354772Z","steps":["trace[771093191] 'agreement among raft nodes before linearized reading' (duration: 112.765253ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:22.354851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.941965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:55:22.35487Z","caller":"traceutil/trace.go:171","msg":"trace[59157984] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:603; }","duration":"121.968666ms","start":"2026-02-07T03:55:22.232895Z","end":"2026-02-07T03:55:22.354863Z","steps":["trace[59157984] 'agreement among raft nodes before linearized reading' (duration: 121.940846ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:22.354954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.578495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:55:22.354971Z","caller":"traceutil/trace.go:171","msg":"trace[1106000141] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:603; }","duration":"122.601606ms","start":"2026-02-07T03:55:22.232363Z","end":"2026-02-07T03:55:22.354965Z","steps":["trace[1106000141] 'agreement among raft nodes before linearized reading' (duration: 122.574815ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:22.355037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.686759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:55:22.355052Z","caller":"traceutil/trace.go:171","msg":"trace[1066272560] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:603; }","duration":"122.72366ms","start":"2026-02-07T03:55:22.232324Z","end":"2026-02-07T03:55:22.355047Z","steps":["trace[1066272560] 'agreement among raft nodes before linearized reading' (duration: 122.70057ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:22.35512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.837138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:55:22.355137Z","caller":"traceutil/trace.go:171","msg":"trace[2101624683] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:603; }","duration":"130.861089ms","start":"2026-02-07T03:55:22.22427Z","end":"2026-02-07T03:55:22.355131Z","steps":["trace[2101624683] 'agreement among raft nodes before linearized reading' (duration: 130.834588ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:22.355223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.970253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:55:22.35524Z","caller":"traceutil/trace.go:171","msg":"trace[320034831] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:603; }","duration":"131.000143ms","start":"2026-02-07T03:55:22.224235Z","end":"2026-02-07T03:55:22.355235Z","steps":["trace[320034831] 'agreement among raft nodes before linearized reading' (duration: 130.973262ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:22.355313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.086396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:55:22.355329Z","caller":"traceutil/trace.go:171","msg":"trace[150563742] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:603; }","duration":"131.123297ms","start":"2026-02-07T03:55:22.224201Z","end":"2026-02-07T03:55:22.355324Z","steps":["trace[150563742] 'agreement among raft nodes before linearized reading' (duration: 131.095166ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:22.355401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.158384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:55:22.355417Z","caller":"traceutil/trace.go:171","msg":"trace[527998012] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:603; }","duration":"145.182085ms","start":"2026-02-07T03:55:22.21023Z","end":"2026-02-07T03:55:22.355412Z","steps":["trace[527998012] 'agreement among raft nodes before linearized reading' (duration: 145.155624ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:22.355494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.264798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:55:22.355511Z","caller":"traceutil/trace.go:171","msg":"trace[321374773] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:603; }","duration":"145.300669ms","start":"2026-02-07T03:55:22.210205Z","end":"2026-02-07T03:55:22.355505Z","steps":["trace[321374773] 'agreement among raft nodes before linearized reading' (duration: 145.277428ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:22.355576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.379172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:55:22.355594Z","caller":"traceutil/trace.go:171","msg":"trace[1821551596] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:603; }","duration":"145.413333ms","start":"2026-02-07T03:55:22.210175Z","end":"2026-02-07T03:55:22.355588Z","steps":["trace[1821551596] 'agreement among raft nodes before linearized reading' (duration: 145.389251ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:22.355686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.719252ms","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-07T03:55:22.355701Z","caller":"traceutil/trace.go:171","msg":"trace[1292068814] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:603; }","duration":"176.757454ms","start":"2026-02-07T03:55:22.178939Z","end":"2026-02-07T03:55:22.355696Z","steps":["trace[1292068814] 'agreement among raft nodes before linearized reading' (duration: 176.707582ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:22.355792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.032657ms","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-07T03:55:22.355975Z","caller":"traceutil/trace.go:171","msg":"trace[1621172402] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:603; }","duration":"196.229462ms","start":"2026-02-07T03:55:22.15974Z","end":"2026-02-07T03:55:22.355969Z","steps":["trace[1621172402] 'agreement among raft nodes before linearized reading' (duration: 196.019106ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:22.356439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.964414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-07T03:55:22.356458Z","caller":"traceutil/trace.go:171","msg":"trace[1906199583] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:603; }","duration":"216.992894ms","start":"2026-02-07T03:55:22.139459Z","end":"2026-02-07T03:55:22.356452Z","steps":["trace[1906199583] 'agreement among raft nodes before linearized reading' (duration: 216.939493ms)"],"step_count":1} {"level":"info","ts":"2026-02-07T03:55:22.711768Z","caller":"traceutil/trace.go:171","msg":"trace[944786144] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"343.184527ms","start":"2026-02-07T03:55:22.368566Z","end":"2026-02-07T03:55:22.71175Z","steps":["trace[944786144] 'process raft request' (duration: 342.992981ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:22.711911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:22.368555Z","time spent":"343.282839ms","remote":"127.0.0.1:50070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-07T03:55:22.752713Z","caller":"traceutil/trace.go:171","msg":"trace[252057635] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"373.011976ms","start":"2026-02-07T03:55:22.379667Z","end":"2026-02-07T03:55:22.752679Z","steps":["trace[252057635] 'process raft request' (duration: 372.922953ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:22.752892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:22.37966Z","time spent":"373.105379ms","remote":"127.0.0.1:49964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-07T03:55:22.753281Z","caller":"traceutil/trace.go:171","msg":"trace[1841823636] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"374.796582ms","start":"2026-02-07T03:55:22.378448Z","end":"2026-02-07T03:55:22.753245Z","steps":["trace[1841823636] 'process raft request' (duration: 374.122141ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:22.753409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:22.37843Z","time spent":"374.917356ms","remote":"127.0.0.1:50070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-07T03:55:22.753555Z","caller":"traceutil/trace.go:171","msg":"trace[586286687] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"384.42031ms","start":"2026-02-07T03:55:22.369127Z","end":"2026-02-07T03:55:22.753547Z","steps":["trace[586286687] 'process raft request' (duration: 383.376727ms)"],"step_count":1} {"level":"info","ts":"2026-02-07T03:55:22.753608Z","caller":"traceutil/trace.go:171","msg":"trace[2130562354] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"382.340534ms","start":"2026-02-07T03:55:22.37126Z","end":"2026-02-07T03:55:22.753601Z","steps":["trace[2130562354] 'process raft request' (duration: 381.266329ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:22.7536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:22.369121Z","time spent":"384.457321ms","remote":"127.0.0.1:50070","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-07T03:55:22.753639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:22.371254Z","time spent":"382.367815ms","remote":"127.0.0.1:50070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-07T03:55:22.753686Z","caller":"traceutil/trace.go:171","msg":"trace[1772038560] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"384.695079ms","start":"2026-02-07T03:55:22.368987Z","end":"2026-02-07T03:55:22.753682Z","steps":["trace[1772038560] 'process raft request' (duration: 383.407677ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:22.753708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:22.368963Z","time spent":"384.73161ms","remote":"127.0.0.1:50070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-07T03:55:25.162548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.708639ms","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-07T03:55:25.162604Z","caller":"traceutil/trace.go:171","msg":"trace[2124378243] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:609; }","duration":"446.848055ms","start":"2026-02-07T03:55:24.715745Z","end":"2026-02-07T03:55:25.162593Z","steps":["trace[2124378243] 'range keys from in-memory index tree' (duration: 446.651268ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:25.162626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:24.715731Z","time spent":"446.889886ms","remote":"127.0.0.1:50070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-07T03:55:25.162602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.330453865s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:55:25.162675Z","caller":"traceutil/trace.go:171","msg":"trace[988471269] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"2.3305701s","start":"2026-02-07T03:55:22.832084Z","end":"2026-02-07T03:55:25.162654Z","steps":["trace[988471269] 'range keys from in-memory index tree' (duration: 2.330391484s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:25.162712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:22.832069Z","time spent":"2.330635742s","remote":"127.0.0.1:49810","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-07T03:55:25.162752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.519174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-07T03:55:25.162768Z","caller":"traceutil/trace.go:171","msg":"trace[73541057] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:609; }","duration":"402.542954ms","start":"2026-02-07T03:55:24.76022Z","end":"2026-02-07T03:55:25.162763Z","steps":["trace[73541057] 'range keys from in-memory index tree' (duration: 402.487292ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:25.162779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:24.760216Z","time spent":"402.560174ms","remote":"127.0.0.1:50070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-07T03:55:25.162847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.662408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-07T03:55:25.162869Z","caller":"traceutil/trace.go:171","msg":"trace[1832084423] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:609; }","duration":"402.701239ms","start":"2026-02-07T03:55:24.760156Z","end":"2026-02-07T03:55:25.162857Z","steps":["trace[1832084423] 'range keys from in-memory index tree' (duration: 402.574645ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:25.162884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:24.760142Z","time spent":"402.73861ms","remote":"127.0.0.1:50070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-07T03:55:25.162945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.265185ms","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-07T03:55:25.162957Z","caller":"traceutil/trace.go:171","msg":"trace[1049576096] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:609; }","duration":"401.288606ms","start":"2026-02-07T03:55:24.761665Z","end":"2026-02-07T03:55:25.162953Z","steps":["trace[1049576096] 'range keys from in-memory index tree' (duration: 401.234413ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:25.162969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:24.76166Z","time spent":"401.306046ms","remote":"127.0.0.1:50070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-07T03:55:25.163028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.397079ms","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-07T03:55:25.163039Z","caller":"traceutil/trace.go:171","msg":"trace[155222369] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:609; }","duration":"401.422119ms","start":"2026-02-07T03:55:24.761614Z","end":"2026-02-07T03:55:25.163036Z","steps":["trace[155222369] 'range keys from in-memory index tree' (duration: 401.304286ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:25.16305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:24.761606Z","time spent":"401.44119ms","remote":"127.0.0.1:50070","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-07T03:55:25.163104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.148428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:55:25.163118Z","caller":"traceutil/trace.go:171","msg":"trace[515084565] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"330.1879ms","start":"2026-02-07T03:55:24.832924Z","end":"2026-02-07T03:55:25.163112Z","steps":["trace[515084565] 'range keys from in-memory index tree' (duration: 330.103577ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:55:25.163128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:55:24.832908Z","time spent":"330.217691ms","remote":"127.0.0.1:49820","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-07T03:56:49.931635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.433212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-07T03:56:49.933554Z","caller":"traceutil/trace.go:171","msg":"trace[1063412180] linearizableReadLoop","detail":"{readStateIndex:1031; appliedIndex:1030; }","duration":"128.92452ms","start":"2026-02-07T03:56:49.801176Z","end":"2026-02-07T03:56:49.930101Z","steps":["trace[1063412180] 'read index received' (duration: 64.298053ms)","trace[1063412180] 'applied index is now lower than readState.Index' (duration: 64.625427ms)"],"step_count":2} {"level":"info","ts":"2026-02-07T03:56:49.933887Z","caller":"traceutil/trace.go:171","msg":"trace[1728041535] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"165.592298ms","start":"2026-02-07T03:56:49.76511Z","end":"2026-02-07T03:56:49.930702Z","steps":["trace[1728041535] 'process raft request' (duration: 100.411473ms)","trace[1728041535] 'compare' (duration: 64.470094ms)"],"step_count":2} {"level":"info","ts":"2026-02-07T03:56:49.935397Z","caller":"traceutil/trace.go:171","msg":"trace[875843410] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:993; }","duration":"131.66913ms","start":"2026-02-07T03:56:49.801161Z","end":"2026-02-07T03:56:49.93283Z","steps":["trace[875843410] 'agreement among raft nodes before linearized reading' (duration: 130.33254ms)"],"step_count":1}