{"level":"warn","ts":"2026-09-18T02:27:34.875386Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-18T02:27:34.875508Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.112: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.112:2380","--initial-cluster=instance=https://162.253.55.112:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.112:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.112: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-09-18T02:27:34.875591Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-18T02:27:34.875606Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.112:2380"]} {"level":"info","ts":"2026-09-18T02:27:34.875626Z","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-09-18T02:27:34.876464Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.112:2379"]} {"level":"info","ts":"2026-09-18T02:27:34.876556Z","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.112:2380"],"listen-peer-urls":["https://162.253.55.112:2380"],"advertise-client-urls":["https://162.253.55.112:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.112:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.112: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-09-18T02:27:34.87973Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.896045ms"} {"level":"info","ts":"2026-09-18T02:27:34.891326Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1b80133015df7bbe","cluster-id":"96c35284d1622e20"} {"level":"info","ts":"2026-09-18T02:27:34.891389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe switched to configuration voters=()"} {"level":"info","ts":"2026-09-18T02:27:34.891408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe became follower at term 0"} {"level":"info","ts":"2026-09-18T02:27:34.891416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1b80133015df7bbe [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-18T02:27:34.891422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe became follower at term 1"} {"level":"info","ts":"2026-09-18T02:27:34.891459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe switched to configuration voters=(1981604933289343934)"} {"level":"warn","ts":"2026-09-18T02:27:34.896777Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-18T02:27:34.898145Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-18T02:27:34.899282Z","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-09-18T02:27:34.9016Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1b80133015df7bbe","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-18T02:27:34.90482Z","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-09-18T02:27:34.904909Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.112:2380"} {"level":"info","ts":"2026-09-18T02:27:34.904928Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.112:2380"} {"level":"info","ts":"2026-09-18T02:27:34.905397Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1b80133015df7bbe","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-18T02:27:34.9057Z","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-09-18T02:27:34.905743Z","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-09-18T02:27:34.905753Z","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-09-18T02:27:34.906014Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1b80133015df7bbe","initial-advertise-peer-urls":["https://162.253.55.112:2380"],"listen-peer-urls":["https://162.253.55.112:2380"],"advertise-client-urls":["https://162.253.55.112:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.112:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-18T02:27:34.906068Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-18T02:27:34.906623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe switched to configuration voters=(1981604933289343934)"} {"level":"info","ts":"2026-09-18T02:27:34.906736Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"96c35284d1622e20","local-member-id":"1b80133015df7bbe","added-peer-id":"1b80133015df7bbe","added-peer-peer-urls":["https://162.253.55.112:2380"]} {"level":"info","ts":"2026-09-18T02:27:35.392522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe is starting a new election at term 1"} {"level":"info","ts":"2026-09-18T02:27:35.392604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe became pre-candidate at term 1"} {"level":"info","ts":"2026-09-18T02:27:35.392656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe received MsgPreVoteResp from 1b80133015df7bbe at term 1"} {"level":"info","ts":"2026-09-18T02:27:35.392906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe became candidate at term 2"} {"level":"info","ts":"2026-09-18T02:27:35.392941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe received MsgVoteResp from 1b80133015df7bbe at term 2"} {"level":"info","ts":"2026-09-18T02:27:35.392969Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe became leader at term 2"} {"level":"info","ts":"2026-09-18T02:27:35.393032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1b80133015df7bbe elected leader 1b80133015df7bbe at term 2"} {"level":"info","ts":"2026-09-18T02:27:35.3943Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T02:27:35.396476Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"96c35284d1622e20","local-member-id":"1b80133015df7bbe","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T02:27:35.396658Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T02:27:35.396768Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T02:27:35.396811Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1b80133015df7bbe","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.112:2379]}","request-path":"/0/members/1b80133015df7bbe/attributes","cluster-id":"96c35284d1622e20","publish-timeout":"7s"} {"level":"info","ts":"2026-09-18T02:27:35.397061Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T02:27:35.39963Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T02:27:35.399853Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-18T02:27:35.399931Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-18T02:27:35.400879Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-18T02:27:35.401121Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.112:2379"} {"level":"info","ts":"2026-09-18T02:27:52.888151Z","caller":"traceutil/trace.go:171","msg":"trace[1599974870] linearizableReadLoop","detail":"{readStateIndex:385; appliedIndex:384; }","duration":"142.158697ms","start":"2026-09-18T02:27:52.745963Z","end":"2026-09-18T02:27:52.888121Z","steps":["trace[1599974870] 'read index received' (duration: 141.90635ms)","trace[1599974870] 'applied index is now lower than readState.Index' (duration: 250.887µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:27:52.888225Z","caller":"traceutil/trace.go:171","msg":"trace[1450444630] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"555.565176ms","start":"2026-09-18T02:27:52.332641Z","end":"2026-09-18T02:27:52.888206Z","steps":["trace[1450444630] 'process raft request' (duration: 555.328749ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:27:52.888311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.318472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-18T02:27:52.8884Z","caller":"traceutil/trace.go:171","msg":"trace[154172433] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:374; }","duration":"142.469196ms","start":"2026-09-18T02:27:52.745917Z","end":"2026-09-18T02:27:52.888386Z","steps":["trace[154172433] 'agreement among raft nodes before linearized reading' (duration: 142.320432ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:27:52.889103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:27:52.332625Z","time spent":"555.676428ms","remote":"127.0.0.1:49108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:27:53.325384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.996145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-09-18T02:27:53.325481Z","caller":"traceutil/trace.go:171","msg":"trace[2106168115] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:375; }","duration":"104.127079ms","start":"2026-09-18T02:27:53.221331Z","end":"2026-09-18T02:27:53.325458Z","steps":["trace[2106168115] 'range keys from in-memory index tree' (duration: 103.878062ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:28:23.809499Z","caller":"traceutil/trace.go:171","msg":"trace[578099260] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"129.775104ms","start":"2026-09-18T02:28:23.679696Z","end":"2026-09-18T02:28:23.809471Z","steps":["trace[578099260] 'process raft request' (duration: 111.52271ms)","trace[578099260] 'compare' (duration: 18.071148ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:28:23.809988Z","caller":"traceutil/trace.go:171","msg":"trace[1892276160] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"126.772316ms","start":"2026-09-18T02:28:23.683196Z","end":"2026-09-18T02:28:23.809969Z","steps":["trace[1892276160] 'process raft request' (duration: 126.378795ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:28:23.810123Z","caller":"traceutil/trace.go:171","msg":"trace[1937909261] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"126.790546ms","start":"2026-09-18T02:28:23.683312Z","end":"2026-09-18T02:28:23.810103Z","steps":["trace[1937909261] 'process raft request' (duration: 126.59606ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:28:23.810976Z","caller":"traceutil/trace.go:171","msg":"trace[1302911055] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"126.113466ms","start":"2026-09-18T02:28:23.684035Z","end":"2026-09-18T02:28:23.810149Z","steps":["trace[1302911055] 'process raft request' (duration: 126.006133ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:28:23.825181Z","caller":"traceutil/trace.go:171","msg":"trace[714123659] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"118.164014ms","start":"2026-09-18T02:28:23.706997Z","end":"2026-09-18T02:28:23.825161Z","steps":["trace[714123659] 'process raft request' (duration: 118.086862ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:28:23.82531Z","caller":"traceutil/trace.go:171","msg":"trace[720970337] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"132.537975ms","start":"2026-09-18T02:28:23.692744Z","end":"2026-09-18T02:28:23.825282Z","steps":["trace[720970337] 'process raft request' (duration: 131.024471ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:28:30.504652Z","caller":"traceutil/trace.go:171","msg":"trace[1020568752] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"419.831664ms","start":"2026-09-18T02:28:30.084797Z","end":"2026-09-18T02:28:30.504629Z","steps":["trace[1020568752] 'process raft request' (duration: 419.304798ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:28:30.504811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:28:30.084772Z","time spent":"419.974127ms","remote":"127.0.0.1:48936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:28:30.69584Z","caller":"traceutil/trace.go:171","msg":"trace[1071823891] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"112.501159ms","start":"2026-09-18T02:28:30.5833Z","end":"2026-09-18T02:28:30.695801Z","steps":["trace[1071823891] 'process raft request' (duration: 90.481065ms)","trace[1071823891] 'compare' (duration: 21.618282ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:28:46.314779Z","caller":"traceutil/trace.go:171","msg":"trace[1905629215] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"209.494425ms","start":"2026-09-18T02:28:46.105262Z","end":"2026-09-18T02:28:46.314757Z","steps":["trace[1905629215] 'process raft request' (duration: 209.33672ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:28:46.514448Z","caller":"traceutil/trace.go:171","msg":"trace[1070823844] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"181.478916ms","start":"2026-09-18T02:28:46.332944Z","end":"2026-09-18T02:28:46.514422Z","steps":["trace[1070823844] 'process raft request' (duration: 168.956689ms)","trace[1070823844] 'compare' (duration: 12.032932ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:28.848148Z","caller":"traceutil/trace.go:171","msg":"trace[665833792] linearizableReadLoop","detail":"{readStateIndex:1107; appliedIndex:1106; }","duration":"269.951062ms","start":"2026-09-18T02:29:28.578171Z","end":"2026-09-18T02:29:28.848122Z","steps":["trace[665833792] 'read index received' (duration: 269.803678ms)","trace[665833792] 'applied index is now lower than readState.Index' (duration: 146.644µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:29:28.848166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:28.513128Z","time spent":"335.033107ms","remote":"127.0.0.1:48862","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-09-18T02:29:28.848304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.125337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-18T02:29:28.848338Z","caller":"traceutil/trace.go:171","msg":"trace[693118355] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1069; }","duration":"270.20364ms","start":"2026-09-18T02:29:28.578123Z","end":"2026-09-18T02:29:28.848326Z","steps":["trace[693118355] 'agreement among raft nodes before linearized reading' (duration: 270.079246ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:28.848477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.172851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-18T02:29:28.848503Z","caller":"traceutil/trace.go:171","msg":"trace[1965240064] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1069; }","duration":"110.224783ms","start":"2026-09-18T02:29:28.738271Z","end":"2026-09-18T02:29:28.848495Z","steps":["trace[1965240064] 'agreement among raft nodes before linearized reading' (duration: 110.12937ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:28.997892Z","caller":"traceutil/trace.go:171","msg":"trace[1179394305] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"147.872561ms","start":"2026-09-18T02:29:28.849993Z","end":"2026-09-18T02:29:28.997865Z","steps":["trace[1179394305] 'process raft request' (duration: 145.399738ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:28.998271Z","caller":"traceutil/trace.go:171","msg":"trace[833721503] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"146.728787ms","start":"2026-09-18T02:29:28.851526Z","end":"2026-09-18T02:29:28.998255Z","steps":["trace[833721503] 'process raft request' (duration: 145.946444ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:28.998456Z","caller":"traceutil/trace.go:171","msg":"trace[97414589] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"146.360306ms","start":"2026-09-18T02:29:28.852085Z","end":"2026-09-18T02:29:28.998445Z","steps":["trace[97414589] 'process raft request' (duration: 145.438219ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:42.947183Z","caller":"traceutil/trace.go:171","msg":"trace[1681588246] transaction","detail":"{read_only:false; response_revision:1117; number_of_response:1; }","duration":"130.548131ms","start":"2026-09-18T02:29:42.816614Z","end":"2026-09-18T02:29:42.947162Z","steps":["trace[1681588246] 'process raft request' (duration: 130.418937ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:45.286445Z","caller":"traceutil/trace.go:171","msg":"trace[2138561525] linearizableReadLoop","detail":"{readStateIndex:1175; appliedIndex:1174; }","duration":"103.984329ms","start":"2026-09-18T02:29:45.182431Z","end":"2026-09-18T02:29:45.286415Z","steps":["trace[2138561525] 'read index received' (duration: 50.923228ms)","trace[2138561525] 'applied index is now lower than readState.Index' (duration: 53.059241ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:45.286549Z","caller":"traceutil/trace.go:171","msg":"trace[286829325] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"127.651945ms","start":"2026-09-18T02:29:45.158851Z","end":"2026-09-18T02:29:45.286503Z","steps":["trace[286829325] 'process raft request' (duration: 74.533232ms)","trace[286829325] 'compare' (duration: 52.66193ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:29:45.286687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.243037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-18T02:29:45.286724Z","caller":"traceutil/trace.go:171","msg":"trace[1364010906] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1133; }","duration":"104.32731ms","start":"2026-09-18T02:29:45.182386Z","end":"2026-09-18T02:29:45.286713Z","steps":["trace[1364010906] 'agreement among raft nodes before linearized reading' (duration: 104.140314ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:46.310026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.053482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:29:46.310333Z","caller":"traceutil/trace.go:171","msg":"trace[2094943323] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1136; }","duration":"343.403783ms","start":"2026-09-18T02:29:45.966902Z","end":"2026-09-18T02:29:46.310305Z","steps":["trace[2094943323] 'range keys from in-memory index tree' (duration: 342.96819ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:46.310351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.004908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-09-18T02:29:46.310405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:45.966883Z","time spent":"343.502956ms","remote":"127.0.0.1:48842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-18T02:29:46.310131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.244624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:29:46.310443Z","caller":"traceutil/trace.go:171","msg":"trace[347082992] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1136; }","duration":"417.163404ms","start":"2026-09-18T02:29:45.893257Z","end":"2026-09-18T02:29:46.31042Z","steps":["trace[347082992] 'range keys from in-memory index tree' (duration: 416.811723ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:46.310509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:45.893235Z","time spent":"417.260666ms","remote":"127.0.0.1:49108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-18T02:29:46.310524Z","caller":"traceutil/trace.go:171","msg":"trace[759695595] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1136; }","duration":"196.642495ms","start":"2026-09-18T02:29:46.113838Z","end":"2026-09-18T02:29:46.310481Z","steps":["trace[759695595] 'count revisions from in-memory index tree' (duration: 196.186291ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:46.73329Z","caller":"traceutil/trace.go:171","msg":"trace[1355155248] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"415.763162ms","start":"2026-09-18T02:29:46.317491Z","end":"2026-09-18T02:29:46.733254Z","steps":["trace[1355155248] 'process raft request' (duration: 415.603537ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:46.733465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:46.317463Z","time spent":"415.903606ms","remote":"127.0.0.1:49108","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-09-18T02:29:46.796596Z","caller":"traceutil/trace.go:171","msg":"trace[754768798] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"476.417187ms","start":"2026-09-18T02:29:46.320161Z","end":"2026-09-18T02:29:46.796578Z","steps":["trace[754768798] 'process raft request' (duration: 476.271963ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:46.796709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:46.320139Z","time spent":"476.514669ms","remote":"127.0.0.1:48922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":871,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T02:29:46.796725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.71642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:29:46.796594Z","caller":"traceutil/trace.go:171","msg":"trace[542722216] linearizableReadLoop","detail":"{readStateIndex:1180; appliedIndex:1179; }","duration":"415.578906ms","start":"2026-09-18T02:29:46.380985Z","end":"2026-09-18T02:29:46.796564Z","steps":["trace[542722216] 'read index received' (duration: 352.934384ms)","trace[542722216] 'applied index is now lower than readState.Index' (duration: 62.643162ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:46.796804Z","caller":"traceutil/trace.go:171","msg":"trace[1350080423] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1138; }","duration":"415.842504ms","start":"2026-09-18T02:29:46.380946Z","end":"2026-09-18T02:29:46.796788Z","steps":["trace[1350080423] 'agreement among raft nodes before linearized reading' (duration: 415.69331ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:46.796858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:46.380926Z","time spent":"415.915877ms","remote":"127.0.0.1:52224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-09-18T02:29:47.344735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.91409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:29:47.344819Z","caller":"traceutil/trace.go:171","msg":"trace[861386055] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1138; }","duration":"255.070114ms","start":"2026-09-18T02:29:47.089731Z","end":"2026-09-18T02:29:47.344801Z","steps":["trace[861386055] 'count revisions from in-memory index tree' (duration: 254.814257ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:47.344833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.618429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T02:29:47.344881Z","caller":"traceutil/trace.go:171","msg":"trace[10897933] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1138; }","duration":"516.705532ms","start":"2026-09-18T02:29:46.828162Z","end":"2026-09-18T02:29:47.344867Z","steps":["trace[10897933] 'count revisions from in-memory index tree' (duration: 516.530737ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:47.344913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:46.82814Z","time spent":"516.763364ms","remote":"127.0.0.1:48946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":17,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-09-18T02:29:47.344975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.085647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T02:29:47.344995Z","caller":"traceutil/trace.go:171","msg":"trace[252323940] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1138; }","duration":"268.140028ms","start":"2026-09-18T02:29:47.076847Z","end":"2026-09-18T02:29:47.344987Z","steps":["trace[252323940] 'count revisions from in-memory index tree' (duration: 268.011665ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:47.345054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.573135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-18T02:29:47.345089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.064955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-09-18T02:29:47.345146Z","caller":"traceutil/trace.go:171","msg":"trace[1045546987] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1138; }","duration":"168.158408ms","start":"2026-09-18T02:29:47.176971Z","end":"2026-09-18T02:29:47.345129Z","steps":["trace[1045546987] 'range keys from in-memory index tree' (duration: 167.872849ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:47.345181Z","caller":"traceutil/trace.go:171","msg":"trace[1094120206] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1138; }","duration":"210.74484ms","start":"2026-09-18T02:29:47.134375Z","end":"2026-09-18T02:29:47.34512Z","steps":["trace[1094120206] 'count revisions from in-memory index tree' (duration: 210.488913ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:47.34524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.458395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T02:29:47.345261Z","caller":"traceutil/trace.go:171","msg":"trace[678351010] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1138; }","duration":"429.532987ms","start":"2026-09-18T02:29:46.915723Z","end":"2026-09-18T02:29:47.345256Z","steps":["trace[678351010] 'count revisions from in-memory index tree' (duration: 429.371033ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:47.345278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:46.915648Z","time spent":"429.62487ms","remote":"127.0.0.1:49266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-09-18T02:29:47.345348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.684022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:29:47.345362Z","caller":"traceutil/trace.go:171","msg":"trace[1193886855] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1138; }","duration":"377.733493ms","start":"2026-09-18T02:29:46.967624Z","end":"2026-09-18T02:29:47.345358Z","steps":["trace[1193886855] 'range keys from in-memory index tree' (duration: 377.61139ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:47.345375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:46.967605Z","time spent":"377.767435ms","remote":"127.0.0.1:48842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-18T02:29:47.435974Z","caller":"traceutil/trace.go:171","msg":"trace[1977331938] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"142.582855ms","start":"2026-09-18T02:29:47.293361Z","end":"2026-09-18T02:29:47.435944Z","steps":["trace[1977331938] 'process raft request' (duration: 142.444531ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:47.603011Z","caller":"traceutil/trace.go:171","msg":"trace[1198590135] linearizableReadLoop","detail":"{readStateIndex:1182; appliedIndex:1181; }","duration":"167.082496ms","start":"2026-09-18T02:29:47.435903Z","end":"2026-09-18T02:29:47.602985Z","steps":["trace[1198590135] 'read index received' (duration: 166.918991ms)","trace[1198590135] 'applied index is now lower than readState.Index' (duration: 162.265µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:47.603116Z","caller":"traceutil/trace.go:171","msg":"trace[839414261] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"253.181889ms","start":"2026-09-18T02:29:47.349865Z","end":"2026-09-18T02:29:47.603047Z","steps":["trace[839414261] 'process raft request' (duration: 252.978083ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:47.603325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.697518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-18T02:29:47.603374Z","caller":"traceutil/trace.go:171","msg":"trace[1462300782] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1140; }","duration":"229.787341ms","start":"2026-09-18T02:29:47.373567Z","end":"2026-09-18T02:29:47.603355Z","steps":["trace[1462300782] 'agreement among raft nodes before linearized reading' (duration: 229.625516ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:48.198277Z","caller":"traceutil/trace.go:171","msg":"trace[1961031846] transaction","detail":"{read_only:false; response_revision:1144; number_of_response:1; }","duration":"157.820793ms","start":"2026-09-18T02:29:48.040427Z","end":"2026-09-18T02:29:48.198248Z","steps":["trace[1961031846] 'process raft request' (duration: 157.653168ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:48.852896Z","caller":"traceutil/trace.go:171","msg":"trace[1240549621] linearizableReadLoop","detail":"{readStateIndex:1187; appliedIndex:1186; }","duration":"340.242639ms","start":"2026-09-18T02:29:48.51263Z","end":"2026-09-18T02:29:48.852872Z","steps":["trace[1240549621] 'read index received' (duration: 340.010703ms)","trace[1240549621] 'applied index is now lower than readState.Index' (duration: 231.076µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:48.853019Z","caller":"traceutil/trace.go:171","msg":"trace[1081550938] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"617.078154ms","start":"2026-09-18T02:29:48.235931Z","end":"2026-09-18T02:29:48.853009Z","steps":["trace[1081550938] 'process raft request' (duration: 616.786575ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:48.853105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:48.235899Z","time spent":"617.144326ms","remote":"127.0.0.1:48922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":757,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T02:29:48.853597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.94309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.112\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-09-18T02:29:48.853605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.720524ms","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-09-18T02:29:48.853689Z","caller":"traceutil/trace.go:171","msg":"trace[1557485129] range","detail":"{range_begin:/registry/masterleases/162.253.55.112; range_end:; response_count:1; response_revision:1145; }","duration":"341.065684ms","start":"2026-09-18T02:29:48.512589Z","end":"2026-09-18T02:29:48.853655Z","steps":["trace[1557485129] 'agreement among raft nodes before linearized reading' (duration: 340.783545ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:48.853707Z","caller":"traceutil/trace.go:171","msg":"trace[1990161474] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1145; }","duration":"115.868528ms","start":"2026-09-18T02:29:48.737812Z","end":"2026-09-18T02:29:48.853681Z","steps":["trace[1990161474] 'agreement among raft nodes before linearized reading' (duration: 115.605451ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:48.853736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:48.512573Z","time spent":"341.151656ms","remote":"127.0.0.1:48862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.112\" "} {"level":"warn","ts":"2026-09-18T02:29:48.853748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.98119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5331"} {"level":"info","ts":"2026-09-18T02:29:48.853879Z","caller":"traceutil/trace.go:171","msg":"trace[715818232] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1145; }","duration":"241.170115ms","start":"2026-09-18T02:29:48.612684Z","end":"2026-09-18T02:29:48.853854Z","steps":["trace[715818232] 'agreement among raft nodes before linearized reading' (duration: 240.701422ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:48.983695Z","caller":"traceutil/trace.go:171","msg":"trace[821268140] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"124.626257ms","start":"2026-09-18T02:29:48.859042Z","end":"2026-09-18T02:29:48.983668Z","steps":["trace[821268140] 'process raft request' (duration: 124.39696ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:48.984293Z","caller":"traceutil/trace.go:171","msg":"trace[884992353] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"125.147972ms","start":"2026-09-18T02:29:48.859136Z","end":"2026-09-18T02:29:48.984284Z","steps":["trace[884992353] 'process raft request' (duration: 124.444541ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:48.984479Z","caller":"traceutil/trace.go:171","msg":"trace[1426005982] transaction","detail":"{read_only:false; response_revision:1148; number_of_response:1; }","duration":"120.401392ms","start":"2026-09-18T02:29:48.864057Z","end":"2026-09-18T02:29:48.984458Z","steps":["trace[1426005982] 'process raft request' (duration: 120.199386ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:49.063863Z","caller":"traceutil/trace.go:171","msg":"trace[1492540231] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"127.553983ms","start":"2026-09-18T02:29:48.936279Z","end":"2026-09-18T02:29:49.063833Z","steps":["trace[1492540231] 'process raft request' (duration: 111.45559ms)","trace[1492540231] 'compare' (duration: 15.902897ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:29:49.984532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.776828ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T02:29:49.984646Z","caller":"traceutil/trace.go:171","msg":"trace[1676359298] linearizableReadLoop","detail":"{readStateIndex:1195; appliedIndex:1194; }","duration":"376.724804ms","start":"2026-09-18T02:29:49.607904Z","end":"2026-09-18T02:29:49.984629Z","steps":["trace[1676359298] 'read index received' (duration: 73.601746ms)","trace[1676359298] 'applied index is now lower than readState.Index' (duration: 303.121657ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:29:49.985108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.909103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-18T02:29:49.985193Z","caller":"traceutil/trace.go:171","msg":"trace[115344049] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1152; }","duration":"283.048378ms","start":"2026-09-18T02:29:49.702127Z","end":"2026-09-18T02:29:49.985175Z","steps":["trace[115344049] 'agreement among raft nodes before linearized reading' (duration: 282.79126ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:49.98529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.366682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-09-18T02:29:49.985327Z","caller":"traceutil/trace.go:171","msg":"trace[2079174303] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1152; }","duration":"377.465485ms","start":"2026-09-18T02:29:49.607852Z","end":"2026-09-18T02:29:49.985317Z","steps":["trace[2079174303] 'agreement among raft nodes before linearized reading' (duration: 377.30797ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:49.985356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:49.607831Z","time spent":"377.516307ms","remote":"127.0.0.1:49108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-18T02:29:49.985382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.98477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-18T02:29:49.985403Z","caller":"traceutil/trace.go:171","msg":"trace[782602055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1152; }","duration":"259.030811ms","start":"2026-09-18T02:29:49.726365Z","end":"2026-09-18T02:29:49.985396Z","steps":["trace[782602055] 'agreement among raft nodes before linearized reading' (duration: 258.98278ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:49.985511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.966075ms","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-09-18T02:29:49.985529Z","caller":"traceutil/trace.go:171","msg":"trace[1408604307] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1152; }","duration":"283.001326ms","start":"2026-09-18T02:29:49.702523Z","end":"2026-09-18T02:29:49.985524Z","steps":["trace[1408604307] 'agreement among raft nodes before linearized reading' (duration: 282.954424ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:49.985131Z","caller":"traceutil/trace.go:171","msg":"trace[83003057] transaction","detail":"{read_only:false; response_revision:1152; number_of_response:1; }","duration":"425.827678ms","start":"2026-09-18T02:29:49.559288Z","end":"2026-09-18T02:29:49.985115Z","steps":["trace[83003057] 'process raft request' (duration: 122.164924ms)","trace[83003057] 'compare' (duration: 302.644434ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:29:49.985668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:49.559259Z","time spent":"426.345743ms","remote":"127.0.0.1:49108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:29:50.392421Z","caller":"traceutil/trace.go:171","msg":"trace[1358898947] transaction","detail":"{read_only:false; response_revision:1154; number_of_response:1; }","duration":"400.38588ms","start":"2026-09-18T02:29:49.992012Z","end":"2026-09-18T02:29:50.392398Z","steps":["trace[1358898947] 'process raft request' (duration: 400.174233ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:50.392668Z","caller":"traceutil/trace.go:171","msg":"trace[1278886487] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"399.948777ms","start":"2026-09-18T02:29:49.9927Z","end":"2026-09-18T02:29:50.392648Z","steps":["trace[1278886487] 'process raft request' (duration: 399.862334ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:50.392696Z","caller":"traceutil/trace.go:171","msg":"trace[1430483303] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"400.653008ms","start":"2026-09-18T02:29:49.992021Z","end":"2026-09-18T02:29:50.392674Z","steps":["trace[1430483303] 'process raft request' (duration: 400.337188ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:50.39279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:49.992681Z","time spent":"400.040209ms","remote":"127.0.0.1:49108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:29:50.392828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:49.991978Z","time spent":"400.768601ms","remote":"127.0.0.1:49108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:29:50.39286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:49.99198Z","time spent":"400.515613ms","remote":"127.0.0.1:49108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:29:51.176655Z","caller":"traceutil/trace.go:171","msg":"trace[504603384] transaction","detail":"{read_only:false; response_revision:1157; number_of_response:1; }","duration":"182.119278ms","start":"2026-09-18T02:29:50.994511Z","end":"2026-09-18T02:29:51.176631Z","steps":["trace[504603384] 'process raft request' (duration: 181.976344ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:53.322134Z","caller":"traceutil/trace.go:171","msg":"trace[171246966] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"138.028672ms","start":"2026-09-18T02:29:53.18407Z","end":"2026-09-18T02:29:53.322099Z","steps":["trace[171246966] 'process raft request' (duration: 133.424326ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:30:00.793891Z","caller":"traceutil/trace.go:171","msg":"trace[601858870] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"660.911454ms","start":"2026-09-18T02:30:00.132953Z","end":"2026-09-18T02:30:00.793865Z","steps":["trace[601858870] 'process raft request' (duration: 660.730699ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:00.794054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:30:00.132927Z","time spent":"661.038238ms","remote":"127.0.0.1:49108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:30:00.794862Z","caller":"traceutil/trace.go:171","msg":"trace[2015210432] linearizableReadLoop","detail":"{readStateIndex:1280; appliedIndex:1278; }","duration":"351.605895ms","start":"2026-09-18T02:30:00.443227Z","end":"2026-09-18T02:30:00.794833Z","steps":["trace[2015210432] 'read index received' (duration: 350.478722ms)","trace[2015210432] 'applied index is now lower than readState.Index' (duration: 1.125773ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:30:00.795001Z","caller":"traceutil/trace.go:171","msg":"trace[1065771434] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"469.445151ms","start":"2026-09-18T02:30:00.32554Z","end":"2026-09-18T02:30:00.794985Z","steps":["trace[1065771434] 'process raft request' (duration: 469.129802ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:00.795158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:30:00.32551Z","time spent":"469.527854ms","remote":"127.0.0.1:49108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:30:00.795383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.912205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-18T02:30:00.795446Z","caller":"traceutil/trace.go:171","msg":"trace[2088748616] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1235; }","duration":"351.017757ms","start":"2026-09-18T02:30:00.444412Z","end":"2026-09-18T02:30:00.79543Z","steps":["trace[2088748616] 'agreement among raft nodes before linearized reading' (duration: 350.76304ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:00.795489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:30:00.444392Z","time spent":"351.086649ms","remote":"127.0.0.1:49108","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-09-18T02:30:00.7955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.301805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-18T02:30:00.795549Z","caller":"traceutil/trace.go:171","msg":"trace[1821904305] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1235; }","duration":"352.388358ms","start":"2026-09-18T02:30:00.443146Z","end":"2026-09-18T02:30:00.795534Z","steps":["trace[1821904305] 'agreement among raft nodes before linearized reading' (duration: 352.232873ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:00.795595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:30:00.443126Z","time spent":"352.45862ms","remote":"127.0.0.1:49108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-18T02:30:00.795662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.622405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-09-18T02:30:00.79571Z","caller":"traceutil/trace.go:171","msg":"trace[1882544827] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1235; }","duration":"126.715598ms","start":"2026-09-18T02:30:00.668981Z","end":"2026-09-18T02:30:00.795696Z","steps":["trace[1882544827] 'agreement among raft nodes before linearized reading' (duration: 126.600255ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:00.79592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.872673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-18T02:30:00.795975Z","caller":"traceutil/trace.go:171","msg":"trace[1325553944] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1235; }","duration":"349.967226ms","start":"2026-09-18T02:30:00.445994Z","end":"2026-09-18T02:30:00.795961Z","steps":["trace[1325553944] 'agreement among raft nodes before linearized reading' (duration: 349.704668ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:00.796014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:30:00.445973Z","time spent":"350.029268ms","remote":"127.0.0.1:49108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-18T02:30:10.955643Z","caller":"traceutil/trace.go:171","msg":"trace[2121308534] linearizableReadLoop","detail":"{readStateIndex:1327; appliedIndex:1326; }","duration":"115.56953ms","start":"2026-09-18T02:30:10.840048Z","end":"2026-09-18T02:30:10.955618Z","steps":["trace[2121308534] 'read index received' (duration: 115.270352ms)","trace[2121308534] 'applied index is now lower than readState.Index' (duration: 297.788µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:30:10.956Z","caller":"traceutil/trace.go:171","msg":"trace[509443105] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"128.251033ms","start":"2026-09-18T02:30:10.827736Z","end":"2026-09-18T02:30:10.955987Z","steps":["trace[509443105] 'process raft request' (duration: 127.717858ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:10.956226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.291195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-09-18T02:30:10.956276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.927696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-09-18T02:30:10.956297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.23305ms","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-09-18T02:30:10.956355Z","caller":"traceutil/trace.go:171","msg":"trace[299724832] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1280; }","duration":"107.06753ms","start":"2026-09-18T02:30:10.849266Z","end":"2026-09-18T02:30:10.956334Z","steps":["trace[299724832] 'agreement among raft nodes before linearized reading' (duration: 106.763961ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:30:10.956392Z","caller":"traceutil/trace.go:171","msg":"trace[568102569] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1280; }","duration":"116.389524ms","start":"2026-09-18T02:30:10.839981Z","end":"2026-09-18T02:30:10.956371Z","steps":["trace[568102569] 'agreement among raft nodes before linearized reading' (duration: 116.092906ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:30:10.95632Z","caller":"traceutil/trace.go:171","msg":"trace[954086633] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1280; }","duration":"109.426669ms","start":"2026-09-18T02:30:10.846872Z","end":"2026-09-18T02:30:10.956298Z","steps":["trace[954086633] 'agreement among raft nodes before linearized reading' (duration: 109.132361ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:10.956588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.993918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-18T02:30:10.956706Z","caller":"traceutil/trace.go:171","msg":"trace[1925063743] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1280; }","duration":"107.578235ms","start":"2026-09-18T02:30:10.8491Z","end":"2026-09-18T02:30:10.956678Z","steps":["trace[1925063743] 'agreement among raft nodes before linearized reading' (duration: 106.901496ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:11.119754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.626192ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T02:30:11.120161Z","caller":"traceutil/trace.go:171","msg":"trace[1121687117] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"159.198364ms","start":"2026-09-18T02:30:10.960936Z","end":"2026-09-18T02:30:11.120134Z","steps":["trace[1121687117] 'process raft request' (duration: 159.022619ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:30:11.120231Z","caller":"traceutil/trace.go:171","msg":"trace[1752341222] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"159.567255ms","start":"2026-09-18T02:30:10.960614Z","end":"2026-09-18T02:30:11.120181Z","steps":["trace[1752341222] 'process raft request' (duration: 43.779348ms)","trace[1752341222] 'compare' (duration: 114.262672ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:30:11.120279Z","caller":"traceutil/trace.go:171","msg":"trace[366333814] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"158.917226ms","start":"2026-09-18T02:30:10.961343Z","end":"2026-09-18T02:30:11.12026Z","steps":["trace[366333814] 'process raft request' (duration: 158.653598ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:30:11.120431Z","caller":"traceutil/trace.go:171","msg":"trace[646535545] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"159.689189ms","start":"2026-09-18T02:30:10.960729Z","end":"2026-09-18T02:30:11.120419Z","steps":["trace[646535545] 'process raft request' (duration: 159.162493ms)"],"step_count":1}