{"level":"warn","ts":"2026-02-08T16:59:42.451392Z","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-08T16:59:42.451678Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.62: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://162.253.55.62:2380","--initial-cluster=instance=https://162.253.55.62:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.62:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.62: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-08T16:59:42.451839Z","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-08T16:59:42.451949Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.62:2380"]} {"level":"info","ts":"2026-02-08T16:59:42.45205Z","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-08T16:59:42.452899Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"]} {"level":"info","ts":"2026-02-08T16:59:42.453092Z","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://162.253.55.62:2380"],"listen-peer-urls":["https://162.253.55.62:2380"],"advertise-client-urls":["https://162.253.55.62:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.62: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-08T16:59:42.458198Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.712548ms"} {"level":"info","ts":"2026-02-08T16:59:42.496499Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"791a7e25b533cd26","cluster-id":"be484d2748da72cd"} {"level":"info","ts":"2026-02-08T16:59:42.496638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=()"} {"level":"info","ts":"2026-02-08T16:59:42.4967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became follower at term 0"} {"level":"info","ts":"2026-02-08T16:59:42.496786Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 791a7e25b533cd26 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-08T16:59:42.49684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became follower at term 1"} {"level":"info","ts":"2026-02-08T16:59:42.496948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=(8726425928402717990)"} {"level":"warn","ts":"2026-02-08T16:59:42.504919Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-08T16:59:42.51331Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-08T16:59:42.518978Z","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-08T16:59:42.525234Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"791a7e25b533cd26","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-08T16:59:42.525557Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"791a7e25b533cd26","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-08T16:59:42.525783Z","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-08T16:59:42.525862Z","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-08T16:59:42.525923Z","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-08T16:59:42.533619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=(8726425928402717990)"} {"level":"info","ts":"2026-02-08T16:59:42.533918Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"be484d2748da72cd","local-member-id":"791a7e25b533cd26","added-peer-id":"791a7e25b533cd26","added-peer-peer-urls":["https://162.253.55.62:2380"]} {"level":"info","ts":"2026-02-08T16:59:42.534552Z","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-08T16:59:42.534725Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.62:2380"} {"level":"info","ts":"2026-02-08T16:59:42.538698Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.62:2380"} {"level":"info","ts":"2026-02-08T16:59:42.538793Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"791a7e25b533cd26","initial-advertise-peer-urls":["https://162.253.55.62:2380"],"listen-peer-urls":["https://162.253.55.62:2380"],"advertise-client-urls":["https://162.253.55.62:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-08T16:59:42.539959Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-08T16:59:43.397773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 is starting a new election at term 1"} {"level":"info","ts":"2026-02-08T16:59:43.397864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-08T16:59:43.397919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 received MsgPreVoteResp from 791a7e25b533cd26 at term 1"} {"level":"info","ts":"2026-02-08T16:59:43.397974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became candidate at term 2"} {"level":"info","ts":"2026-02-08T16:59:43.398002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 received MsgVoteResp from 791a7e25b533cd26 at term 2"} {"level":"info","ts":"2026-02-08T16:59:43.398021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became leader at term 2"} {"level":"info","ts":"2026-02-08T16:59:43.398066Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 791a7e25b533cd26 elected leader 791a7e25b533cd26 at term 2"} {"level":"info","ts":"2026-02-08T16:59:43.399352Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"791a7e25b533cd26","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.62:2379]}","request-path":"/0/members/791a7e25b533cd26/attributes","cluster-id":"be484d2748da72cd","publish-timeout":"7s"} {"level":"info","ts":"2026-02-08T16:59:43.399567Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-08T16:59:43.399593Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-08T16:59:43.400138Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-08T16:59:43.399608Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-08T16:59:43.39962Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-08T16:59:43.401843Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-08T16:59:43.405783Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.62:2379"} {"level":"info","ts":"2026-02-08T16:59:43.43067Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"be484d2748da72cd","local-member-id":"791a7e25b533cd26","cluster-version":"3.5"} {"level":"info","ts":"2026-02-08T16:59:43.435653Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-08T16:59:43.4357Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-08T17:00:07.533956Z","caller":"traceutil/trace.go:171","msg":"trace[700535960] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"182.509538ms","start":"2026-02-08T17:00:07.351225Z","end":"2026-02-08T17:00:07.533734Z","steps":["trace[700535960] 'process raft request' (duration: 182.354134ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:00:17.385135Z","caller":"traceutil/trace.go:171","msg":"trace[1246003729] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"243.170509ms","start":"2026-02-08T17:00:17.141922Z","end":"2026-02-08T17:00:17.385092Z","steps":["trace[1246003729] 'process raft request' (duration: 242.985355ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:00:17.752706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.894241ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-08T17:00:17.752923Z","caller":"traceutil/trace.go:171","msg":"trace[367159742] linearizableReadLoop","detail":"{readStateIndex:567; appliedIndex:565; }","duration":"519.57686ms","start":"2026-02-08T17:00:17.233326Z","end":"2026-02-08T17:00:17.752903Z","steps":["trace[367159742] 'read index received' (duration: 151.622779ms)","trace[367159742] 'applied index is now lower than readState.Index' (duration: 367.952271ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T17:00:17.753221Z","caller":"traceutil/trace.go:171","msg":"trace[632281225] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"610.950626ms","start":"2026-02-08T17:00:17.14226Z","end":"2026-02-08T17:00:17.75321Z","steps":["trace[632281225] 'process raft request' (duration: 466.008814ms)","trace[632281225] 'compare' (duration: 143.727575ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T17:00:17.75328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:00:17.142252Z","time spent":"610.998137ms","remote":"127.0.0.1:47086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T17:00:17.753506Z","caller":"traceutil/trace.go:171","msg":"trace[1703301062] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"466.235408ms","start":"2026-02-08T17:00:17.287261Z","end":"2026-02-08T17:00:17.753496Z","steps":["trace[1703301062] 'process raft request' (duration: 465.558093ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:00:17.753538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:00:17.287216Z","time spent":"466.305341ms","remote":"127.0.0.1:46880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-08T17:00:17.753715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.386528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-08T17:00:17.753735Z","caller":"traceutil/trace.go:171","msg":"trace[1769617290] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:552; }","duration":"520.455529ms","start":"2026-02-08T17:00:17.233272Z","end":"2026-02-08T17:00:17.753728Z","steps":["trace[1769617290] 'agreement among raft nodes before linearized reading' (duration: 520.335557ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:00:17.753757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:00:17.233245Z","time spent":"520.505501ms","remote":"127.0.0.1:47086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-08T17:00:17.890612Z","caller":"traceutil/trace.go:171","msg":"trace[1087668630] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:568; }","duration":"137.634382ms","start":"2026-02-08T17:00:17.752948Z","end":"2026-02-08T17:00:17.890582Z","steps":["trace[1087668630] 'read index received' (duration: 132.376177ms)","trace[1087668630] 'applied index is now lower than readState.Index' (duration: 5.256695ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T17:00:17.89078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.721748ms","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-08T17:00:17.890886Z","caller":"traceutil/trace.go:171","msg":"trace[2139164515] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:553; }","duration":"205.859981ms","start":"2026-02-08T17:00:17.685002Z","end":"2026-02-08T17:00:17.890862Z","steps":["trace[2139164515] 'agreement among raft nodes before linearized reading' (duration: 205.619424ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:00:17.891053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.491874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-02-08T17:00:17.891127Z","caller":"traceutil/trace.go:171","msg":"trace[534110686] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:553; }","duration":"655.639847ms","start":"2026-02-08T17:00:17.235473Z","end":"2026-02-08T17:00:17.891113Z","steps":["trace[534110686] 'agreement among raft nodes before linearized reading' (duration: 655.31495ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:00:17.891201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:00:17.235466Z","time spent":"655.700789ms","remote":"127.0.0.1:47086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-08T17:00:17.891348Z","caller":"traceutil/trace.go:171","msg":"trace[757093919] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"499.358926ms","start":"2026-02-08T17:00:17.391974Z","end":"2026-02-08T17:00:17.891333Z","steps":["trace[757093919] 'process raft request' (duration: 493.332033ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:00:17.891473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:00:17.391952Z","time spent":"499.440238ms","remote":"127.0.0.1:46880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5162,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-08T17:00:17.891712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.846792ms","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-08T17:00:17.892443Z","caller":"traceutil/trace.go:171","msg":"trace[382596057] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:553; }","duration":"314.66305ms","start":"2026-02-08T17:00:17.577769Z","end":"2026-02-08T17:00:17.892432Z","steps":["trace[382596057] 'agreement among raft nodes before linearized reading' (duration: 313.876802ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:00:17.89258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:00:17.577746Z","time spent":"314.806884ms","remote":"127.0.0.1:47086","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-08T17:00:17.891971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.514237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T17:00:17.892693Z","caller":"traceutil/trace.go:171","msg":"trace[1561717893] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:553; }","duration":"407.267483ms","start":"2026-02-08T17:00:17.485406Z","end":"2026-02-08T17:00:17.892674Z","steps":["trace[1561717893] 'agreement among raft nodes before linearized reading' (duration: 406.529566ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:00:17.892834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:00:17.48538Z","time spent":"407.438417ms","remote":"127.0.0.1:46880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"info","ts":"2026-02-08T17:00:17.893857Z","caller":"traceutil/trace.go:171","msg":"trace[2058664249] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"133.38541ms","start":"2026-02-08T17:00:17.760459Z","end":"2026-02-08T17:00:17.893845Z","steps":["trace[2058664249] 'process raft request' (duration: 133.344199ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:00:17.893866Z","caller":"traceutil/trace.go:171","msg":"trace[370487158] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"133.515422ms","start":"2026-02-08T17:00:17.760341Z","end":"2026-02-08T17:00:17.893856Z","steps":["trace[370487158] 'process raft request' (duration: 133.39323ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:00:26.132162Z","caller":"traceutil/trace.go:171","msg":"trace[1097928264] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"822.335739ms","start":"2026-02-08T17:00:25.309785Z","end":"2026-02-08T17:00:26.132121Z","steps":["trace[1097928264] 'process raft request' (duration: 822.160945ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:00:26.133884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:00:25.309757Z","time spent":"824.024366ms","remote":"127.0.0.1:46998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T17:00:26.137725Z","caller":"traceutil/trace.go:171","msg":"trace[252655875] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"227.927746ms","start":"2026-02-08T17:00:25.909753Z","end":"2026-02-08T17:00:26.137681Z","steps":["trace[252655875] 'process raft request' (duration: 227.67238ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:00:26.139958Z","caller":"traceutil/trace.go:171","msg":"trace[1041975871] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:606; }","duration":"208.55861ms","start":"2026-02-08T17:00:25.931378Z","end":"2026-02-08T17:00:26.139937Z","steps":["trace[1041975871] 'read index received' (duration: 200.524283ms)","trace[1041975871] 'applied index is now lower than readState.Index' (duration: 8.032607ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T17:00:26.140498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.118153ms","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-08T17:00:26.140594Z","caller":"traceutil/trace.go:171","msg":"trace[839566175] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:591; }","duration":"209.278757ms","start":"2026-02-08T17:00:25.931304Z","end":"2026-02-08T17:00:26.140582Z","steps":["trace[839566175] 'agreement among raft nodes before linearized reading' (duration: 209.039551ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:00:38.674439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.381947ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-08T17:00:38.674604Z","caller":"traceutil/trace.go:171","msg":"trace[1756345798] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"375.797622ms","start":"2026-02-08T17:00:38.298788Z","end":"2026-02-08T17:00:38.674586Z","steps":["trace[1756345798] 'process raft request' (duration: 85.154299ms)","trace[1756345798] 'compare' (duration: 290.224504ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T17:00:38.675117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:00:38.298766Z","time spent":"376.284823ms","remote":"127.0.0.1:47086","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-08T17:00:38.682923Z","caller":"traceutil/trace.go:171","msg":"trace[1738836860] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"353.762449ms","start":"2026-02-08T17:00:38.329128Z","end":"2026-02-08T17:00:38.68289Z","steps":["trace[1738836860] 'process raft request' (duration: 353.705917ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:00:38.683122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:00:38.329096Z","time spent":"353.914882ms","remote":"127.0.0.1:47086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T17:00:38.683372Z","caller":"traceutil/trace.go:171","msg":"trace[549214002] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"384.370371ms","start":"2026-02-08T17:00:38.29899Z","end":"2026-02-08T17:00:38.683361Z","steps":["trace[549214002] 'process raft request' (duration: 383.728926ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:00:38.68343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:00:38.298984Z","time spent":"384.413921ms","remote":"127.0.0.1:47086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T17:00:46.945154Z","caller":"traceutil/trace.go:171","msg":"trace[120301616] linearizableReadLoop","detail":"{readStateIndex:766; appliedIndex:765; }","duration":"229.880839ms","start":"2026-02-08T17:00:46.715244Z","end":"2026-02-08T17:00:46.945125Z","steps":["trace[120301616] 'read index received' (duration: 229.585462ms)","trace[120301616] 'applied index is now lower than readState.Index' (duration: 282.617µs)"],"step_count":2} {"level":"info","ts":"2026-02-08T17:00:46.945328Z","caller":"traceutil/trace.go:171","msg":"trace[726662334] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"235.262566ms","start":"2026-02-08T17:00:46.710048Z","end":"2026-02-08T17:00:46.94531Z","steps":["trace[726662334] 'process raft request' (duration: 234.909638ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:00:46.945497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.175726ms","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-08T17:00:46.945576Z","caller":"traceutil/trace.go:171","msg":"trace[1354583620] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:742; }","duration":"230.280268ms","start":"2026-02-08T17:00:46.71528Z","end":"2026-02-08T17:00:46.945561Z","steps":["trace[1354583620] 'agreement among raft nodes before linearized reading' (duration: 230.074783ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:00:46.945779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.492552ms","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-08T17:00:46.945824Z","caller":"traceutil/trace.go:171","msg":"trace[717366037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:742; }","duration":"230.584734ms","start":"2026-02-08T17:00:46.715228Z","end":"2026-02-08T17:00:46.945813Z","steps":["trace[717366037] 'agreement among raft nodes before linearized reading' (duration: 230.40737ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:00:47.412231Z","caller":"traceutil/trace.go:171","msg":"trace[960185129] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"462.356873ms","start":"2026-02-08T17:00:46.949846Z","end":"2026-02-08T17:00:47.412202Z","steps":["trace[960185129] 'process raft request' (duration: 462.139328ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:00:47.413146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:00:46.949813Z","time spent":"462.522867ms","remote":"127.0.0.1:47086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T17:00:47.442765Z","caller":"traceutil/trace.go:171","msg":"trace[367667237] linearizableReadLoop","detail":"{readStateIndex:768; appliedIndex:766; }","duration":"171.339531ms","start":"2026-02-08T17:00:47.271404Z","end":"2026-02-08T17:00:47.442744Z","steps":["trace[367667237] 'read index received' (duration: 140.550966ms)","trace[367667237] 'applied index is now lower than readState.Index' (duration: 30.787275ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T17:00:47.443027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.584198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T17:00:47.443069Z","caller":"traceutil/trace.go:171","msg":"trace[1625791153] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:744; }","duration":"171.683679ms","start":"2026-02-08T17:00:47.271373Z","end":"2026-02-08T17:00:47.443057Z","steps":["trace[1625791153] 'agreement among raft nodes before linearized reading' (duration: 171.439174ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:00:47.444082Z","caller":"traceutil/trace.go:171","msg":"trace[958582084] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"490.40869ms","start":"2026-02-08T17:00:46.953204Z","end":"2026-02-08T17:00:47.443613Z","steps":["trace[958582084] 'process raft request' (duration: 489.446998ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:00:47.444205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:00:46.95318Z","time spent":"490.941821ms","remote":"127.0.0.1:47086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T17:01:03.390945Z","caller":"traceutil/trace.go:171","msg":"trace[834251445] linearizableReadLoop","detail":"{readStateIndex:820; appliedIndex:819; }","duration":"118.221596ms","start":"2026-02-08T17:01:03.272702Z","end":"2026-02-08T17:01:03.390923Z","steps":["trace[834251445] 'read index received' (duration: 118.063893ms)","trace[834251445] 'applied index is now lower than readState.Index' (duration: 157.063µs)"],"step_count":2} {"level":"warn","ts":"2026-02-08T17:01:03.391071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.34872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T17:01:03.391093Z","caller":"traceutil/trace.go:171","msg":"trace[1250879075] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:793; }","duration":"118.419451ms","start":"2026-02-08T17:01:03.272667Z","end":"2026-02-08T17:01:03.391087Z","steps":["trace[1250879075] 'agreement among raft nodes before linearized reading' (duration: 118.335879ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:01:03.391223Z","caller":"traceutil/trace.go:171","msg":"trace[791116196] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"363.557894ms","start":"2026-02-08T17:01:03.027645Z","end":"2026-02-08T17:01:03.391203Z","steps":["trace[791116196] 'process raft request' (duration: 363.174385ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:01:03.391333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:01:03.027627Z","time spent":"363.643816ms","remote":"127.0.0.1:47086","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-08T17:01:03.632255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.864783ms","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-08T17:01:03.632328Z","caller":"traceutil/trace.go:171","msg":"trace[620329597] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:793; }","duration":"114.981906ms","start":"2026-02-08T17:01:03.517328Z","end":"2026-02-08T17:01:03.632309Z","steps":["trace[620329597] 'range keys from in-memory index tree' (duration: 114.708899ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:01:03.841503Z","caller":"traceutil/trace.go:171","msg":"trace[1387662169] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"201.099996ms","start":"2026-02-08T17:01:03.640383Z","end":"2026-02-08T17:01:03.841483Z","steps":["trace[1387662169] 'process raft request' (duration: 200.981103ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:01:03.859685Z","caller":"traceutil/trace.go:171","msg":"trace[1807620463] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"218.11647ms","start":"2026-02-08T17:01:03.641553Z","end":"2026-02-08T17:01:03.85967Z","steps":["trace[1807620463] 'process raft request' (duration: 218.053309ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:01:07.544477Z","caller":"traceutil/trace.go:171","msg":"trace[1843136912] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"139.164875ms","start":"2026-02-08T17:01:07.40529Z","end":"2026-02-08T17:01:07.544455Z","steps":["trace[1843136912] 'process raft request' (duration: 139.052723ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:01:20.593293Z","caller":"traceutil/trace.go:171","msg":"trace[93562033] linearizableReadLoop","detail":"{readStateIndex:924; appliedIndex:923; }","duration":"105.963562ms","start":"2026-02-08T17:01:20.487306Z","end":"2026-02-08T17:01:20.593269Z","steps":["trace[93562033] 'read index received' (duration: 105.712056ms)","trace[93562033] 'applied index is now lower than readState.Index' (duration: 250.526µs)"],"step_count":2} {"level":"warn","ts":"2026-02-08T17:01:20.593521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.186696ms","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-08T17:01:20.593555Z","caller":"traceutil/trace.go:171","msg":"trace[331785522] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:893; }","duration":"106.264978ms","start":"2026-02-08T17:01:20.487278Z","end":"2026-02-08T17:01:20.593543Z","steps":["trace[331785522] 'agreement among raft nodes before linearized reading' (duration: 106.085274ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:01:20.593865Z","caller":"traceutil/trace.go:171","msg":"trace[79206969] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"110.850083ms","start":"2026-02-08T17:01:20.483004Z","end":"2026-02-08T17:01:20.593854Z","steps":["trace[79206969] 'process raft request' (duration: 110.137829ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:01:26.081601Z","caller":"traceutil/trace.go:171","msg":"trace[707965140] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"460.471345ms","start":"2026-02-08T17:01:25.621103Z","end":"2026-02-08T17:01:26.081575Z","steps":["trace[707965140] 'process raft request' (duration: 459.188909ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:01:26.081848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:01:25.621086Z","time spent":"460.66273ms","remote":"127.0.0.1:47086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-08T17:01:34.964676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.413669ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T17:01:34.964774Z","caller":"traceutil/trace.go:171","msg":"trace[1174115914] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:932; }","duration":"143.521131ms","start":"2026-02-08T17:01:34.821241Z","end":"2026-02-08T17:01:34.964762Z","steps":["trace[1174115914] 'range keys from in-memory index tree' (duration: 143.401649ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:01:36.809683Z","caller":"traceutil/trace.go:171","msg":"trace[2089768284] linearizableReadLoop","detail":"{readStateIndex:972; appliedIndex:971; }","duration":"142.716005ms","start":"2026-02-08T17:01:36.666948Z","end":"2026-02-08T17:01:36.809664Z","steps":["trace[2089768284] 'read index received' (duration: 129.842507ms)","trace[2089768284] 'applied index is now lower than readState.Index' (duration: 12.872808ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T17:01:36.81154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.579033ms","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-08T17:01:36.811613Z","caller":"traceutil/trace.go:171","msg":"trace[1302315040] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:937; }","duration":"144.686565ms","start":"2026-02-08T17:01:36.666915Z","end":"2026-02-08T17:01:36.811602Z","steps":["trace[1302315040] 'agreement among raft nodes before linearized reading' (duration: 144.528072ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:01:36.809949Z","caller":"traceutil/trace.go:171","msg":"trace[459039560] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"166.967238ms","start":"2026-02-08T17:01:36.642972Z","end":"2026-02-08T17:01:36.809939Z","steps":["trace[459039560] 'process raft request' (duration: 153.881346ms)","trace[459039560] 'compare' (duration: 12.604552ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T17:01:39.419746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.717217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T17:01:39.419815Z","caller":"traceutil/trace.go:171","msg":"trace[1341180130] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:944; }","duration":"145.838299ms","start":"2026-02-08T17:01:39.273959Z","end":"2026-02-08T17:01:39.419798Z","steps":["trace[1341180130] 'range keys from in-memory index tree' (duration: 145.624235ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:01:44.532632Z","caller":"traceutil/trace.go:171","msg":"trace[606889525] linearizableReadLoop","detail":"{readStateIndex:1013; appliedIndex:1012; }","duration":"198.010434ms","start":"2026-02-08T17:01:44.334597Z","end":"2026-02-08T17:01:44.532607Z","steps":["trace[606889525] 'read index received' (duration: 192.878927ms)","trace[606889525] 'applied index is now lower than readState.Index' (duration: 5.130347ms)"],"step_count":2} {"level":"warn","ts":"2026-02-08T17:01:44.532939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.3193ms","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-08T17:01:44.532995Z","caller":"traceutil/trace.go:171","msg":"trace[233726847] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:977; }","duration":"198.410802ms","start":"2026-02-08T17:01:44.334574Z","end":"2026-02-08T17:01:44.532985Z","steps":["trace[233726847] 'agreement among raft nodes before linearized reading' (duration: 198.144366ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:01:44.533968Z","caller":"traceutil/trace.go:171","msg":"trace[1011772569] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"201.650699ms","start":"2026-02-08T17:01:44.332302Z","end":"2026-02-08T17:01:44.533952Z","steps":["trace[1011772569] 'process raft request' (duration: 195.199926ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:01:45.098533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.075672ms","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-08T17:01:45.098613Z","caller":"traceutil/trace.go:171","msg":"trace[1462227967] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:978; }","duration":"219.206535ms","start":"2026-02-08T17:01:44.879391Z","end":"2026-02-08T17:01:45.098598Z","steps":["trace[1462227967] 'range keys from in-memory index tree' (duration: 218.914619ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:01:45.098992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.269772ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T17:01:45.099046Z","caller":"traceutil/trace.go:171","msg":"trace[389180355] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:978; }","duration":"278.326453ms","start":"2026-02-08T17:01:44.820712Z","end":"2026-02-08T17:01:45.099039Z","steps":["trace[389180355] 'range keys from in-memory index tree' (duration: 278.233941ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:01:45.09923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.157703ms","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-08T17:01:45.099248Z","caller":"traceutil/trace.go:171","msg":"trace[914113509] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:978; }","duration":"245.179944ms","start":"2026-02-08T17:01:44.854063Z","end":"2026-02-08T17:01:45.099243Z","steps":["trace[914113509] 'range keys from in-memory index tree' (duration: 244.930809ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:01:45.355082Z","caller":"traceutil/trace.go:171","msg":"trace[2118679730] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"248.740427ms","start":"2026-02-08T17:01:45.106304Z","end":"2026-02-08T17:01:45.355044Z","steps":["trace[2118679730] 'process raft request' (duration: 248.521403ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:01:45.481351Z","caller":"traceutil/trace.go:171","msg":"trace[1256205484] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"372.241613ms","start":"2026-02-08T17:01:45.109088Z","end":"2026-02-08T17:01:45.48133Z","steps":["trace[1256205484] 'process raft request' (duration: 372.100741ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:01:45.481491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:01:45.109067Z","time spent":"372.349235ms","remote":"127.0.0.1:47086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T17:01:47.012521Z","caller":"traceutil/trace.go:171","msg":"trace[722548671] linearizableReadLoop","detail":"{readStateIndex:1027; appliedIndex:1026; }","duration":"421.851544ms","start":"2026-02-08T17:01:46.590631Z","end":"2026-02-08T17:01:47.012482Z","steps":["trace[722548671] 'read index received' (duration: 421.517656ms)","trace[722548671] 'applied index is now lower than readState.Index' (duration: 332.498µs)"],"step_count":2} {"level":"warn","ts":"2026-02-08T17:01:47.013211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.778033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T17:01:47.013264Z","caller":"traceutil/trace.go:171","msg":"trace[1913279317] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:990; }","duration":"111.902114ms","start":"2026-02-08T17:01:46.901347Z","end":"2026-02-08T17:01:47.013249Z","steps":["trace[1913279317] 'agreement among raft nodes before linearized reading' (duration: 111.772282ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:01:47.01392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.278933ms","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-08T17:01:47.013959Z","caller":"traceutil/trace.go:171","msg":"trace[2021344222] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:990; }","duration":"423.338705ms","start":"2026-02-08T17:01:46.590607Z","end":"2026-02-08T17:01:47.013945Z","steps":["trace[2021344222] 'agreement among raft nodes before linearized reading' (duration: 423.158572ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:01:47.013991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:01:46.590596Z","time spent":"423.386546ms","remote":"127.0.0.1:47086","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-08T17:01:47.015156Z","caller":"traceutil/trace.go:171","msg":"trace[2119914970] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"424.713333ms","start":"2026-02-08T17:01:46.59041Z","end":"2026-02-08T17:01:47.015123Z","steps":["trace[2119914970] 'process raft request' (duration: 421.840273ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:01:47.015291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:01:46.590385Z","time spent":"424.810795ms","remote":"127.0.0.1:47086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T17:01:47.232533Z","caller":"traceutil/trace.go:171","msg":"trace[658246925] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"212.31744ms","start":"2026-02-08T17:01:47.020188Z","end":"2026-02-08T17:01:47.232505Z","steps":["trace[658246925] 'process raft request' (duration: 117.759636ms)","trace[658246925] 'compare' (duration: 94.098145ms)"],"step_count":2} {"level":"info","ts":"2026-02-08T17:01:52.714221Z","caller":"traceutil/trace.go:171","msg":"trace[1299898451] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"392.911953ms","start":"2026-02-08T17:01:52.321252Z","end":"2026-02-08T17:01:52.714164Z","steps":["trace[1299898451] 'process raft request' (duration: 392.587126ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:01:52.714531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:01:52.321239Z","time spent":"393.102296ms","remote":"127.0.0.1:47086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-08T17:01:53.932484Z","caller":"traceutil/trace.go:171","msg":"trace[2137361696] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"152.370116ms","start":"2026-02-08T17:01:53.780095Z","end":"2026-02-08T17:01:53.932465Z","steps":["trace[2137361696] 'process raft request' (duration: 152.247063ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:01:54.064004Z","caller":"traceutil/trace.go:171","msg":"trace[1937808083] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"116.01116ms","start":"2026-02-08T17:01:53.947975Z","end":"2026-02-08T17:01:54.063986Z","steps":["trace[1937808083] 'process raft request' (duration: 115.961969ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:01:54.064281Z","caller":"traceutil/trace.go:171","msg":"trace[1335722296] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"117.726875ms","start":"2026-02-08T17:01:53.946481Z","end":"2026-02-08T17:01:54.064208Z","steps":["trace[1335722296] 'process raft request' (duration: 117.398839ms)"],"step_count":1} {"level":"warn","ts":"2026-02-08T17:01:54.386058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.065965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-02-08T17:01:54.386321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.366336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-08T17:01:54.386357Z","caller":"traceutil/trace.go:171","msg":"trace[1194587202] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1046; }","duration":"114.424776ms","start":"2026-02-08T17:01:54.271919Z","end":"2026-02-08T17:01:54.386343Z","steps":["trace[1194587202] 'range keys from in-memory index tree' (duration: 114.314624ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:01:54.387467Z","caller":"traceutil/trace.go:171","msg":"trace[810804518] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1046; }","duration":"211.191178ms","start":"2026-02-08T17:01:54.174926Z","end":"2026-02-08T17:01:54.386118Z","steps":["trace[810804518] 'count revisions from in-memory index tree' (duration: 210.980764ms)"],"step_count":1} {"level":"info","ts":"2026-02-08T17:05:02.311016Z","caller":"traceutil/trace.go:171","msg":"trace[1569483294] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"144.137896ms","start":"2026-02-08T17:05:02.166863Z","end":"2026-02-08T17:05:02.311001Z","steps":["trace[1569483294] 'process raft request' (duration: 143.964733ms)"],"step_count":1}