{"level":"warn","ts":"2026-03-01T21:10:21.170997Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-01T21:10:21.171121Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.209: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.209:2380","--initial-cluster=instance=https://162.253.55.209:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.209:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.209: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-03-01T21:10:21.171215Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-01T21:10:21.171233Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.209:2380"]} {"level":"info","ts":"2026-03-01T21:10:21.171258Z","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-03-01T21:10:21.17227Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.209:2379"]} {"level":"info","ts":"2026-03-01T21:10:21.172364Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.209:2380"],"listen-peer-urls":["https://162.253.55.209:2380"],"advertise-client-urls":["https://162.253.55.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.209: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-03-01T21:10:21.176694Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.031669ms"} {"level":"info","ts":"2026-03-01T21:10:21.188051Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"53de2bdd9aa7b793","cluster-id":"385802231390d48c"} {"level":"info","ts":"2026-03-01T21:10:21.188151Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 switched to configuration voters=()"} {"level":"info","ts":"2026-03-01T21:10:21.188366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became follower at term 0"} {"level":"info","ts":"2026-03-01T21:10:21.188393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 53de2bdd9aa7b793 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-01T21:10:21.188403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became follower at term 1"} {"level":"info","ts":"2026-03-01T21:10:21.188479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 switched to configuration voters=(6043315980760233875)"} {"level":"warn","ts":"2026-03-01T21:10:21.195898Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-01T21:10:21.199866Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-01T21:10:21.203096Z","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-03-01T21:10:21.207089Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"53de2bdd9aa7b793","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-01T21:10:21.208839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 switched to configuration voters=(6043315980760233875)"} {"level":"info","ts":"2026-03-01T21:10:21.209148Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"385802231390d48c","local-member-id":"53de2bdd9aa7b793","added-peer-id":"53de2bdd9aa7b793","added-peer-peer-urls":["https://162.253.55.209:2380"]} {"level":"info","ts":"2026-03-01T21:10:21.207802Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"53de2bdd9aa7b793","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-01T21:10:21.210685Z","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-03-01T21:10:21.210736Z","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-03-01T21:10:21.210753Z","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-03-01T21:10:21.21266Z","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-03-01T21:10:21.212853Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"53de2bdd9aa7b793","initial-advertise-peer-urls":["https://162.253.55.209:2380"],"listen-peer-urls":["https://162.253.55.209:2380"],"advertise-client-urls":["https://162.253.55.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-01T21:10:21.212881Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-01T21:10:21.213381Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.209:2380"} {"level":"info","ts":"2026-03-01T21:10:21.213405Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.209:2380"} {"level":"info","ts":"2026-03-01T21:10:22.189224Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 is starting a new election at term 1"} {"level":"info","ts":"2026-03-01T21:10:22.189287Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-01T21:10:22.189312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 received MsgPreVoteResp from 53de2bdd9aa7b793 at term 1"} {"level":"info","ts":"2026-03-01T21:10:22.189332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became candidate at term 2"} {"level":"info","ts":"2026-03-01T21:10:22.189358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 received MsgVoteResp from 53de2bdd9aa7b793 at term 2"} {"level":"info","ts":"2026-03-01T21:10:22.189382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"53de2bdd9aa7b793 became leader at term 2"} {"level":"info","ts":"2026-03-01T21:10:22.189396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 53de2bdd9aa7b793 elected leader 53de2bdd9aa7b793 at term 2"} {"level":"info","ts":"2026-03-01T21:10:22.190495Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"53de2bdd9aa7b793","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.209:2379]}","request-path":"/0/members/53de2bdd9aa7b793/attributes","cluster-id":"385802231390d48c","publish-timeout":"7s"} {"level":"info","ts":"2026-03-01T21:10:22.190525Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-01T21:10:22.190623Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-01T21:10:22.190568Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-01T21:10:22.190859Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-01T21:10:22.191103Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-01T21:10:22.1925Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"385802231390d48c","local-member-id":"53de2bdd9aa7b793","cluster-version":"3.5"} {"level":"info","ts":"2026-03-01T21:10:22.192823Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-01T21:10:22.193012Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-01T21:10:22.193721Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.209:2379"} {"level":"info","ts":"2026-03-01T21:10:22.198049Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-03-01T21:10:52.104304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.806983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-01T21:10:52.104401Z","caller":"traceutil/trace.go:171","msg":"trace[724399852] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:538; }","duration":"283.964467ms","start":"2026-03-01T21:10:51.820416Z","end":"2026-03-01T21:10:52.104381Z","steps":["trace[724399852] 'range keys from in-memory index tree' (duration: 283.718951ms)"],"step_count":1} {"level":"info","ts":"2026-03-01T21:10:52.123863Z","caller":"traceutil/trace.go:171","msg":"trace[529564109] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"293.757872ms","start":"2026-03-01T21:10:51.830073Z","end":"2026-03-01T21:10:52.123831Z","steps":["trace[529564109] 'process raft request' (duration: 293.582808ms)"],"step_count":1} {"level":"info","ts":"2026-03-01T21:10:57.855846Z","caller":"traceutil/trace.go:171","msg":"trace[216372520] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"138.55822ms","start":"2026-03-01T21:10:57.717266Z","end":"2026-03-01T21:10:57.855824Z","steps":["trace[216372520] 'process raft request' (duration: 138.394037ms)"],"step_count":1} {"level":"info","ts":"2026-03-01T21:10:57.913496Z","caller":"traceutil/trace.go:171","msg":"trace[284404731] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"195.215511ms","start":"2026-03-01T21:10:57.718255Z","end":"2026-03-01T21:10:57.913471Z","steps":["trace[284404731] 'process raft request' (duration: 194.762912ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:10:58.734039Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13228088789792393449,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-01T21:10:59.155512Z","caller":"traceutil/trace.go:171","msg":"trace[1514794737] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:596; }","duration":"921.941037ms","start":"2026-03-01T21:10:58.233533Z","end":"2026-03-01T21:10:59.155474Z","steps":["trace[1514794737] 'read index received' (duration: 921.665492ms)","trace[1514794737] 'applied index is now lower than readState.Index' (duration: 274.355µs)"],"step_count":2} {"level":"info","ts":"2026-03-01T21:10:59.155781Z","caller":"traceutil/trace.go:171","msg":"trace[2039660086] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"996.212372ms","start":"2026-03-01T21:10:58.159547Z","end":"2026-03-01T21:10:59.15576Z","steps":["trace[2039660086] 'process raft request' (duration: 995.752073ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:10:59.15602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.087238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-01T21:10:59.156084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"922.538548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-03-01T21:10:59.156148Z","caller":"traceutil/trace.go:171","msg":"trace[842913745] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:578; }","duration":"311.270341ms","start":"2026-03-01T21:10:58.844852Z","end":"2026-03-01T21:10:59.156122Z","steps":["trace[842913745] 'agreement among raft nodes before linearized reading' (duration: 311.047156ms)"],"step_count":1} {"level":"info","ts":"2026-03-01T21:10:59.156171Z","caller":"traceutil/trace.go:171","msg":"trace[1919340028] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:578; }","duration":"922.686111ms","start":"2026-03-01T21:10:58.233462Z","end":"2026-03-01T21:10:59.156148Z","steps":["trace[1919340028] 'agreement among raft nodes before linearized reading' (duration: 922.337514ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:10:59.156202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:10:58.844836Z","time spent":"311.358003ms","remote":"127.0.0.1:43452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-01T21:10:59.15605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.579136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-03-01T21:10:59.156232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:10:58.233442Z","time spent":"922.772624ms","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-03-01T21:10:59.156367Z","caller":"traceutil/trace.go:171","msg":"trace[1857748341] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:578; }","duration":"414.919353ms","start":"2026-03-01T21:10:58.741366Z","end":"2026-03-01T21:10:59.156285Z","steps":["trace[1857748341] 'agreement among raft nodes before linearized reading' (duration: 414.428953ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:10:59.156442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:10:58.741341Z","time spent":"415.084186ms","remote":"127.0.0.1:43730","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-03-01T21:10:59.157093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:10:58.159524Z","time spent":"996.488928ms","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-01T21:11:18.514045Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13228088789792393725,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-01T21:11:18.672175Z","caller":"traceutil/trace.go:171","msg":"trace[1585969316] linearizableReadLoop","detail":"{readStateIndex:746; appliedIndex:745; }","duration":"659.009702ms","start":"2026-03-01T21:11:18.013142Z","end":"2026-03-01T21:11:18.672152Z","steps":["trace[1585969316] 'read index received' (duration: 658.852289ms)","trace[1585969316] 'applied index is now lower than readState.Index' (duration: 156.803µs)"],"step_count":2} {"level":"warn","ts":"2026-03-01T21:11:18.672335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.185476ms","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-03-01T21:11:18.672359Z","caller":"traceutil/trace.go:171","msg":"trace[326626930] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:722; }","duration":"659.248307ms","start":"2026-03-01T21:11:18.013102Z","end":"2026-03-01T21:11:18.67235Z","steps":["trace[326626930] 'agreement among raft nodes before linearized reading' (duration: 659.123715ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:11:18.672389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:11:18.013084Z","time spent":"659.298978ms","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-01T21:11:18.672477Z","caller":"traceutil/trace.go:171","msg":"trace[1773089827] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"730.158435ms","start":"2026-03-01T21:11:17.942312Z","end":"2026-03-01T21:11:18.67247Z","steps":["trace[1773089827] 'process raft request' (duration: 729.732156ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:11:18.672566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:11:17.942286Z","time spent":"730.234586ms","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-01T21:11:19.36639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.635828ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-01T21:11:19.36654Z","caller":"traceutil/trace.go:171","msg":"trace[1132089760] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"688.151964ms","start":"2026-03-01T21:11:18.67837Z","end":"2026-03-01T21:11:19.366522Z","steps":["trace[1132089760] 'process raft request' (duration: 333.118219ms)","trace[1132089760] 'compare' (duration: 354.333052ms)"],"step_count":2} {"level":"warn","ts":"2026-03-01T21:11:19.366606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:11:18.678353Z","time spent":"688.224806ms","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-01T21:11:20.920943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.157115ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-03-01T21:11:20.921029Z","caller":"traceutil/trace.go:171","msg":"trace[1636246582] linearizableReadLoop","detail":"{readStateIndex:751; appliedIndex:750; }","duration":"244.845063ms","start":"2026-03-01T21:11:20.67617Z","end":"2026-03-01T21:11:20.921016Z","steps":["trace[1636246582] 'read index received' (duration: 42.891µs)","trace[1636246582] 'applied index is now lower than readState.Index' (duration: 244.801042ms)"],"step_count":2} {"level":"warn","ts":"2026-03-01T21:11:20.92115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.980736ms","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-03-01T21:11:20.921379Z","caller":"traceutil/trace.go:171","msg":"trace[149300125] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:726; }","duration":"245.229851ms","start":"2026-03-01T21:11:20.676119Z","end":"2026-03-01T21:11:20.921349Z","steps":["trace[149300125] 'agreement among raft nodes before linearized reading' (duration: 244.934325ms)"],"step_count":1} {"level":"info","ts":"2026-03-01T21:11:43.18Z","caller":"traceutil/trace.go:171","msg":"trace[1377341285] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"133.800834ms","start":"2026-03-01T21:11:43.046177Z","end":"2026-03-01T21:11:43.179978Z","steps":["trace[1377341285] 'process raft request' (duration: 133.686982ms)"],"step_count":1} {"level":"info","ts":"2026-03-01T21:11:43.746848Z","caller":"traceutil/trace.go:171","msg":"trace[64540829] linearizableReadLoop","detail":"{readStateIndex:826; appliedIndex:825; }","duration":"213.783323ms","start":"2026-03-01T21:11:43.533034Z","end":"2026-03-01T21:11:43.746817Z","steps":["trace[64540829] 'read index received' (duration: 196.63979ms)","trace[64540829] 'applied index is now lower than readState.Index' (duration: 17.142183ms)"],"step_count":2} {"level":"info","ts":"2026-03-01T21:11:43.746906Z","caller":"traceutil/trace.go:171","msg":"trace[1169342589] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"214.190041ms","start":"2026-03-01T21:11:43.532677Z","end":"2026-03-01T21:11:43.746867Z","steps":["trace[1169342589] 'process raft request' (duration: 197.007637ms)","trace[1169342589] 'compare' (duration: 16.957439ms)"],"step_count":2} {"level":"warn","ts":"2026-03-01T21:11:43.747119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.057199ms","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-03-01T21:11:43.74719Z","caller":"traceutil/trace.go:171","msg":"trace[1693579980] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:797; }","duration":"214.170571ms","start":"2026-03-01T21:11:43.533005Z","end":"2026-03-01T21:11:43.747176Z","steps":["trace[1693579980] 'agreement among raft nodes before linearized reading' (duration: 213.937075ms)"],"step_count":1} {"level":"info","ts":"2026-03-01T21:11:53.779297Z","caller":"traceutil/trace.go:171","msg":"trace[1861842741] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"132.226339ms","start":"2026-03-01T21:11:53.647051Z","end":"2026-03-01T21:11:53.779277Z","steps":["trace[1861842741] 'process raft request' (duration: 131.595505ms)"],"step_count":1} {"level":"info","ts":"2026-03-01T21:11:55.812835Z","caller":"traceutil/trace.go:171","msg":"trace[1305123077] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"190.585674ms","start":"2026-03-01T21:11:55.622195Z","end":"2026-03-01T21:11:55.812781Z","steps":["trace[1305123077] 'process raft request' (duration: 190.311318ms)"],"step_count":1} {"level":"info","ts":"2026-03-01T21:11:56.200296Z","caller":"traceutil/trace.go:171","msg":"trace[1683378767] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"384.129195ms","start":"2026-03-01T21:11:55.816142Z","end":"2026-03-01T21:11:56.200271Z","steps":["trace[1683378767] 'process raft request' (duration: 337.216479ms)","trace[1683378767] 'compare' (duration: 46.60287ms)"],"step_count":2} {"level":"warn","ts":"2026-03-01T21:11:56.200413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:11:55.816124Z","time spent":"384.228078ms","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-01T21:11:56.202589Z","caller":"traceutil/trace.go:171","msg":"trace[134214565] linearizableReadLoop","detail":"{readStateIndex:917; appliedIndex:915; }","duration":"358.062466ms","start":"2026-03-01T21:11:55.844411Z","end":"2026-03-01T21:11:56.202474Z","steps":["trace[134214565] 'read index received' (duration: 308.958455ms)","trace[134214565] 'applied index is now lower than readState.Index' (duration: 49.102591ms)"],"step_count":2} {"level":"info","ts":"2026-03-01T21:11:56.202684Z","caller":"traceutil/trace.go:171","msg":"trace[1984165901] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"386.216858ms","start":"2026-03-01T21:11:55.816442Z","end":"2026-03-01T21:11:56.202659Z","steps":["trace[1984165901] 'process raft request' (duration: 385.855481ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:11:56.2029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.478395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-01T21:11:56.202949Z","caller":"traceutil/trace.go:171","msg":"trace[503592384] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:883; }","duration":"358.578246ms","start":"2026-03-01T21:11:55.844359Z","end":"2026-03-01T21:11:56.202937Z","steps":["trace[503592384] 'agreement among raft nodes before linearized reading' (duration: 358.495524ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:11:56.202982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:11:55.844342Z","time spent":"358.631717ms","remote":"127.0.0.1:43452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-01T21:11:56.203132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.292127ms","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-03-01T21:11:56.203212Z","caller":"traceutil/trace.go:171","msg":"trace[1809941799] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:883; }","duration":"199.41183ms","start":"2026-03-01T21:11:56.003782Z","end":"2026-03-01T21:11:56.203193Z","steps":["trace[1809941799] 'agreement among raft nodes before linearized reading' (duration: 199.163785ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:11:56.203452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:11:55.816433Z","time spent":"386.669877ms","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-01T21:12:11.523147Z","caller":"traceutil/trace.go:171","msg":"trace[1806567404] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"158.81906ms","start":"2026-03-01T21:12:11.364312Z","end":"2026-03-01T21:12:11.523131Z","steps":["trace[1806567404] 'process raft request' (duration: 158.707028ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:12:12.036762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.544643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-01T21:12:12.036916Z","caller":"traceutil/trace.go:171","msg":"trace[755916307] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:944; }","duration":"157.752377ms","start":"2026-03-01T21:12:11.879144Z","end":"2026-03-01T21:12:12.036897Z","steps":["trace[755916307] 'range keys from in-memory index tree' (duration: 157.34194ms)"],"step_count":1} {"level":"info","ts":"2026-03-01T21:12:12.194071Z","caller":"traceutil/trace.go:171","msg":"trace[418998170] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"151.937122ms","start":"2026-03-01T21:12:12.042116Z","end":"2026-03-01T21:12:12.194054Z","steps":["trace[418998170] 'process raft request' (duration: 151.82834ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:12:13.462283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.502393ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-01T21:12:13.462521Z","caller":"traceutil/trace.go:171","msg":"trace[952578010] linearizableReadLoop","detail":"{readStateIndex:991; appliedIndex:989; }","duration":"473.689043ms","start":"2026-03-01T21:12:12.988809Z","end":"2026-03-01T21:12:13.462498Z","steps":["trace[952578010] 'read index received' (duration: 85.905174ms)","trace[952578010] 'applied index is now lower than readState.Index' (duration: 387.782739ms)"],"step_count":2} {"level":"info","ts":"2026-03-01T21:12:13.462645Z","caller":"traceutil/trace.go:171","msg":"trace[1679450746] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"593.534266ms","start":"2026-03-01T21:12:12.869095Z","end":"2026-03-01T21:12:13.462629Z","steps":["trace[1679450746] 'process raft request' (duration: 205.601234ms)","trace[1679450746] 'compare' (duration: 387.391901ms)"],"step_count":2} {"level":"warn","ts":"2026-03-01T21:12:13.462712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:12.869084Z","time spent":"593.598067ms","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":787,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-01T21:12:13.463031Z","caller":"traceutil/trace.go:171","msg":"trace[1970295101] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"566.331263ms","start":"2026-03-01T21:12:12.896688Z","end":"2026-03-01T21:12:13.46302Z","steps":["trace[1970295101] 'process raft request' (duration: 565.729701ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:12:13.463111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:12.896672Z","time spent":"566.390253ms","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-01T21:12:13.463348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.531371ms","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-03-01T21:12:13.463396Z","caller":"traceutil/trace.go:171","msg":"trace[923356206] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:954; }","duration":"474.584152ms","start":"2026-03-01T21:12:12.988799Z","end":"2026-03-01T21:12:13.463383Z","steps":["trace[923356206] 'agreement among raft nodes before linearized reading' (duration: 474.50257ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:12:13.463434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:12.988711Z","time spent":"474.714104ms","remote":"127.0.0.1:50960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"info","ts":"2026-03-01T21:12:13.962356Z","caller":"traceutil/trace.go:171","msg":"trace[1520891311] linearizableReadLoop","detail":"{readStateIndex:992; appliedIndex:991; }","duration":"436.187894ms","start":"2026-03-01T21:12:13.526144Z","end":"2026-03-01T21:12:13.962331Z","steps":["trace[1520891311] 'read index received' (duration: 435.97841ms)","trace[1520891311] 'applied index is now lower than readState.Index' (duration: 208.354µs)"],"step_count":2} {"level":"info","ts":"2026-03-01T21:12:13.96242Z","caller":"traceutil/trace.go:171","msg":"trace[786254578] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"480.565949ms","start":"2026-03-01T21:12:13.481791Z","end":"2026-03-01T21:12:13.962357Z","steps":["trace[786254578] 'process raft request' (duration: 480.356625ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:12:13.962559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.011672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-01T21:12:13.962599Z","caller":"traceutil/trace.go:171","msg":"trace[351974464] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:955; }","duration":"409.141636ms","start":"2026-03-01T21:12:13.553446Z","end":"2026-03-01T21:12:13.962587Z","steps":["trace[351974464] 'agreement among raft nodes before linearized reading' (duration: 409.029483ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:12:13.962602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.44049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-03-01T21:12:13.962607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.530886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-01T21:12:13.962636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:13.553407Z","time spent":"409.218108ms","remote":"127.0.0.1:43844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":29,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"info","ts":"2026-03-01T21:12:13.962641Z","caller":"traceutil/trace.go:171","msg":"trace[1634118346] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:955; }","duration":"436.526472ms","start":"2026-03-01T21:12:13.526103Z","end":"2026-03-01T21:12:13.96263Z","steps":["trace[1634118346] 'agreement among raft nodes before linearized reading' (duration: 436.325527ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:12:13.962678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:13.526088Z","time spent":"436.584753ms","remote":"127.0.0.1:43730","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-03-01T21:12:13.962696Z","caller":"traceutil/trace.go:171","msg":"trace[1771291832] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:955; }","duration":"117.660088ms","start":"2026-03-01T21:12:13.845002Z","end":"2026-03-01T21:12:13.962662Z","steps":["trace[1771291832] 'agreement among raft nodes before linearized reading' (duration: 117.528055ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:12:13.962766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:13.481769Z","time spent":"480.821086ms","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":835,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-01T21:12:14.541527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.44121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-01T21:12:14.541629Z","caller":"traceutil/trace.go:171","msg":"trace[1910210312] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:957; }","duration":"229.611063ms","start":"2026-03-01T21:12:14.311993Z","end":"2026-03-01T21:12:14.541605Z","steps":["trace[1910210312] 'count revisions from in-memory index tree' (duration: 229.341947ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:12:14.542052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.838408ms","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-03-01T21:12:14.542104Z","caller":"traceutil/trace.go:171","msg":"trace[599963853] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:957; }","duration":"210.91297ms","start":"2026-03-01T21:12:14.331179Z","end":"2026-03-01T21:12:14.542092Z","steps":["trace[599963853] 'range keys from in-memory index tree' (duration: 210.732495ms)"],"step_count":1} {"level":"info","ts":"2026-03-01T21:12:14.693421Z","caller":"traceutil/trace.go:171","msg":"trace[333709512] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"147.073275ms","start":"2026-03-01T21:12:14.546322Z","end":"2026-03-01T21:12:14.693395Z","steps":["trace[333709512] 'process raft request' (duration: 146.892721ms)"],"step_count":1} {"level":"info","ts":"2026-03-01T21:12:14.860857Z","caller":"traceutil/trace.go:171","msg":"trace[538746993] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"305.17018ms","start":"2026-03-01T21:12:14.555666Z","end":"2026-03-01T21:12:14.860836Z","steps":["trace[538746993] 'process raft request' (duration: 290.401115ms)","trace[538746993] 'compare' (duration: 14.264385ms)"],"step_count":2} {"level":"info","ts":"2026-03-01T21:12:14.860964Z","caller":"traceutil/trace.go:171","msg":"trace[1957740754] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"305.067849ms","start":"2026-03-01T21:12:14.555867Z","end":"2026-03-01T21:12:14.860935Z","steps":["trace[1957740754] 'process raft request' (duration: 304.560489ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:12:14.861071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:14.555861Z","time spent":"305.15149ms","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-01T21:12:14.862936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:14.555651Z","time spent":"305.268142ms","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-01T21:12:27.097606Z","caller":"traceutil/trace.go:171","msg":"trace[300502884] linearizableReadLoop","detail":"{readStateIndex:1073; appliedIndex:1072; }","duration":"479.366956ms","start":"2026-03-01T21:12:26.618211Z","end":"2026-03-01T21:12:27.097578Z","steps":["trace[300502884] 'read index received' (duration: 479.143881ms)","trace[300502884] 'applied index is now lower than readState.Index' (duration: 222.035µs)"],"step_count":2} {"level":"warn","ts":"2026-03-01T21:12:27.097948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.577374ms","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-03-01T21:12:27.098002Z","caller":"traceutil/trace.go:171","msg":"trace[897184634] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1033; }","duration":"155.667586ms","start":"2026-03-01T21:12:26.942319Z","end":"2026-03-01T21:12:27.097987Z","steps":["trace[897184634] 'agreement among raft nodes before linearized reading' (duration: 155.480822ms)"],"step_count":1} {"level":"info","ts":"2026-03-01T21:12:27.097913Z","caller":"traceutil/trace.go:171","msg":"trace[15549402] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"809.602927ms","start":"2026-03-01T21:12:26.288248Z","end":"2026-03-01T21:12:27.097851Z","steps":["trace[15549402] 'process raft request' (duration: 809.170859ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:12:27.097998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.763474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-03-01T21:12:27.098197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.434214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-03-01T21:12:27.098233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.001683ms","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-03-01T21:12:27.098271Z","caller":"traceutil/trace.go:171","msg":"trace[284171905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1033; }","duration":"350.578237ms","start":"2026-03-01T21:12:26.747673Z","end":"2026-03-01T21:12:27.098251Z","steps":["trace[284171905] 'agreement among raft nodes before linearized reading' (duration: 350.101967ms)"],"step_count":1} {"level":"info","ts":"2026-03-01T21:12:27.098303Z","caller":"traceutil/trace.go:171","msg":"trace[1877687117] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1033; }","duration":"156.117506ms","start":"2026-03-01T21:12:26.942166Z","end":"2026-03-01T21:12:27.098283Z","steps":["trace[1877687117] 'agreement among raft nodes before linearized reading' (duration: 155.645375ms)"],"step_count":1} {"level":"info","ts":"2026-03-01T21:12:27.098254Z","caller":"traceutil/trace.go:171","msg":"trace[1170004891] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1033; }","duration":"479.965969ms","start":"2026-03-01T21:12:26.618193Z","end":"2026-03-01T21:12:27.098159Z","steps":["trace[1170004891] 'agreement among raft nodes before linearized reading' (duration: 479.55214ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:12:27.098418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:26.618112Z","time spent":"480.289375ms","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-03-01T21:12:27.098319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:26.747654Z","time spent":"350.655389ms","remote":"127.0.0.1:43730","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":"warn","ts":"2026-03-01T21:12:27.099239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T21:12:26.288227Z","time spent":"809.885952ms","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-01T21:12:27.328623Z","caller":"traceutil/trace.go:171","msg":"trace[1925026561] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"225.213806ms","start":"2026-03-01T21:12:27.103377Z","end":"2026-03-01T21:12:27.328591Z","steps":["trace[1925026561] 'process raft request' (duration: 156.334951ms)","trace[1925026561] 'compare' (duration: 68.64283ms)"],"step_count":2} {"level":"info","ts":"2026-03-01T21:12:27.329011Z","caller":"traceutil/trace.go:171","msg":"trace[468136432] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"225.215734ms","start":"2026-03-01T21:12:27.10375Z","end":"2026-03-01T21:12:27.328965Z","steps":["trace[468136432] 'process raft request' (duration: 224.787726ms)"],"step_count":1} {"level":"info","ts":"2026-03-01T21:12:27.329041Z","caller":"traceutil/trace.go:171","msg":"trace[1468083865] linearizableReadLoop","detail":"{readStateIndex:1077; appliedIndex:1073; }","duration":"116.136548ms","start":"2026-03-01T21:12:27.21288Z","end":"2026-03-01T21:12:27.329016Z","steps":["trace[1468083865] 'read index received' (duration: 46.996748ms)","trace[1468083865] 'applied index is now lower than readState.Index' (duration: 69.13877ms)"],"step_count":2} {"level":"info","ts":"2026-03-01T21:12:27.329075Z","caller":"traceutil/trace.go:171","msg":"trace[408852011] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"225.056302ms","start":"2026-03-01T21:12:27.103984Z","end":"2026-03-01T21:12:27.32904Z","steps":["trace[408852011] 'process raft request' (duration: 224.801077ms)"],"step_count":1} {"level":"info","ts":"2026-03-01T21:12:27.329227Z","caller":"traceutil/trace.go:171","msg":"trace[360385032] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"225.142403ms","start":"2026-03-01T21:12:27.104053Z","end":"2026-03-01T21:12:27.329195Z","steps":["trace[360385032] 'process raft request' (duration: 224.904578ms)"],"step_count":1} {"level":"warn","ts":"2026-03-01T21:12:27.32928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.384923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-03-01T21:12:27.329334Z","caller":"traceutil/trace.go:171","msg":"trace[1738877026] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1037; }","duration":"116.491955ms","start":"2026-03-01T21:12:27.212827Z","end":"2026-03-01T21:12:27.329319Z","steps":["trace[1738877026] 'agreement among raft nodes before linearized reading' (duration: 116.278451ms)"],"step_count":1} {"level":"info","ts":"2026-03-01T21:14:56.230971Z","caller":"traceutil/trace.go:171","msg":"trace[235793935] transaction","detail":"{read_only:false; response_revision:1644; number_of_response:1; }","duration":"118.66738ms","start":"2026-03-01T21:14:56.112265Z","end":"2026-03-01T21:14:56.230933Z","steps":["trace[235793935] 'process raft request' (duration: 53.391022ms)","trace[235793935] 'compare' (duration: 65.129295ms)"],"step_count":2} {"level":"info","ts":"2026-03-01T21:14:56.231268Z","caller":"traceutil/trace.go:171","msg":"trace[1122717891] transaction","detail":"{read_only:false; response_revision:1645; number_of_response:1; }","duration":"115.785813ms","start":"2026-03-01T21:14:56.11545Z","end":"2026-03-01T21:14:56.231236Z","steps":["trace[1122717891] 'process raft request' (duration: 115.563588ms)"],"step_count":1}