{"level":"warn","ts":"2026-07-24T04:46:56.284188Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-24T04:46:56.284285Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.29:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.29:2380","--initial-cluster=instance=https://199.19.213.29:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.29:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.29: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-07-24T04:46:56.284361Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-24T04:46:56.284437Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.29:2380"]} {"level":"info","ts":"2026-07-24T04:46:56.284466Z","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-07-24T04:46:56.285366Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.29:2379"]} {"level":"info","ts":"2026-07-24T04:46:56.285698Z","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://199.19.213.29:2380"],"listen-peer-urls":["https://199.19.213.29:2380"],"advertise-client-urls":["https://199.19.213.29:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.29:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.29: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-07-24T04:46:56.289203Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.251335ms"} {"level":"info","ts":"2026-07-24T04:46:56.293699Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b1ecbac2f2214dbd","cluster-id":"94b127ce9c24156a"} {"level":"info","ts":"2026-07-24T04:46:56.29381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd switched to configuration voters=()"} {"level":"info","ts":"2026-07-24T04:46:56.293846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd became follower at term 0"} {"level":"info","ts":"2026-07-24T04:46:56.293869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b1ecbac2f2214dbd [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-24T04:46:56.29389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd became follower at term 1"} {"level":"info","ts":"2026-07-24T04:46:56.293949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd switched to configuration voters=(12820827585665650109)"} {"level":"warn","ts":"2026-07-24T04:46:56.299031Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-24T04:46:56.301683Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-24T04:46:56.302744Z","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-07-24T04:46:56.307568Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b1ecbac2f2214dbd","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-24T04:46:56.308326Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b1ecbac2f2214dbd","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-24T04:46:56.308471Z","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-07-24T04:46:56.308543Z","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-07-24T04:46:56.308559Z","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-07-24T04:46:56.309878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd switched to configuration voters=(12820827585665650109)"} {"level":"info","ts":"2026-07-24T04:46:56.311461Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"94b127ce9c24156a","local-member-id":"b1ecbac2f2214dbd","added-peer-id":"b1ecbac2f2214dbd","added-peer-peer-urls":["https://199.19.213.29:2380"]} {"level":"info","ts":"2026-07-24T04:46:56.314764Z","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-07-24T04:46:56.314864Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.29:2380"} {"level":"info","ts":"2026-07-24T04:46:56.3149Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.29:2380"} {"level":"info","ts":"2026-07-24T04:46:56.315096Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b1ecbac2f2214dbd","initial-advertise-peer-urls":["https://199.19.213.29:2380"],"listen-peer-urls":["https://199.19.213.29:2380"],"advertise-client-urls":["https://199.19.213.29:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.29:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-24T04:46:56.315153Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-24T04:46:56.99871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd is starting a new election at term 1"} {"level":"info","ts":"2026-07-24T04:46:56.998814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd became pre-candidate at term 1"} {"level":"info","ts":"2026-07-24T04:46:56.99887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd received MsgPreVoteResp from b1ecbac2f2214dbd at term 1"} {"level":"info","ts":"2026-07-24T04:46:56.998895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd became candidate at term 2"} {"level":"info","ts":"2026-07-24T04:46:56.998909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd received MsgVoteResp from b1ecbac2f2214dbd at term 2"} {"level":"info","ts":"2026-07-24T04:46:56.998931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd became leader at term 2"} {"level":"info","ts":"2026-07-24T04:46:56.998948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b1ecbac2f2214dbd elected leader b1ecbac2f2214dbd at term 2"} {"level":"info","ts":"2026-07-24T04:46:57.000158Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-24T04:46:57.001016Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-24T04:46:57.001007Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b1ecbac2f2214dbd","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.29:2379]}","request-path":"/0/members/b1ecbac2f2214dbd/attributes","cluster-id":"94b127ce9c24156a","publish-timeout":"7s"} {"level":"info","ts":"2026-07-24T04:46:57.001222Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-24T04:46:57.001564Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-24T04:46:57.001584Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-24T04:46:57.003347Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.29:2379"} {"level":"info","ts":"2026-07-24T04:46:57.003441Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-24T04:46:57.007568Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"94b127ce9c24156a","local-member-id":"b1ecbac2f2214dbd","cluster-version":"3.5"} {"level":"info","ts":"2026-07-24T04:46:57.00767Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-24T04:46:57.007697Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-07-24T04:47:01.148339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.145212211s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-24T04:47:01.148461Z","caller":"traceutil/trace.go:171","msg":"trace[85272757] linearizableReadLoop","detail":"{readStateIndex:181; appliedIndex:180; }","duration":"770.66108ms","start":"2026-07-24T04:47:00.377783Z","end":"2026-07-24T04:47:01.148444Z","steps":["trace[85272757] 'read index received' (duration: 49.162µs)","trace[85272757] 'applied index is now lower than readState.Index' (duration: 770.610698ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T04:47:01.148557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"770.775453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T04:47:01.148587Z","caller":"traceutil/trace.go:171","msg":"trace[1763023713] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:177; }","duration":"770.860684ms","start":"2026-07-24T04:47:00.377715Z","end":"2026-07-24T04:47:01.148575Z","steps":["trace[1763023713] 'agreement among raft nodes before linearized reading' (duration: 770.782902ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:47:01.14856Z","caller":"traceutil/trace.go:171","msg":"trace[1103687133] transaction","detail":"{read_only:false; response_revision:177; number_of_response:1; }","duration":"1.351293143s","start":"2026-07-24T04:46:59.797224Z","end":"2026-07-24T04:47:01.148517Z","steps":["trace[1103687133] 'process raft request' (duration: 205.356873ms)","trace[1103687133] 'compare' (duration: 1.145045627s)"],"step_count":2} {"level":"warn","ts":"2026-07-24T04:47:01.148623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:47:00.377685Z","time spent":"770.930477ms","remote":"127.0.0.1:57688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-24T04:47:01.148723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:46:59.797215Z","time spent":"1.351433776s","remote":"127.0.0.1:44186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":756,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-24T04:47:02.005624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.617907ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-24T04:47:02.005715Z","caller":"traceutil/trace.go:171","msg":"trace[440275721] linearizableReadLoop","detail":"{readStateIndex:182; appliedIndex:181; }","duration":"532.00063ms","start":"2026-07-24T04:47:01.473699Z","end":"2026-07-24T04:47:02.0057Z","steps":["trace[440275721] 'read index received' (duration: 39.351µs)","trace[440275721] 'applied index is now lower than readState.Index' (duration: 531.958929ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T04:47:02.005922Z","caller":"traceutil/trace.go:171","msg":"trace[842802864] transaction","detail":"{read_only:false; response_revision:178; number_of_response:1; }","duration":"851.212743ms","start":"2026-07-24T04:47:01.15468Z","end":"2026-07-24T04:47:02.005893Z","steps":["trace[842802864] 'process raft request' (duration: 110.271708ms)","trace[842802864] 'compare' (duration: 740.515315ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T04:47:02.00602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.278927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T04:47:02.006074Z","caller":"traceutil/trace.go:171","msg":"trace[625073576] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:178; }","duration":"532.40355ms","start":"2026-07-24T04:47:01.47366Z","end":"2026-07-24T04:47:02.006063Z","steps":["trace[625073576] 'agreement among raft nodes before linearized reading' (duration: 532.207286ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:47:02.006122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:47:01.473636Z","time spent":"532.459752ms","remote":"127.0.0.1:57688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-24T04:47:02.006117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:47:01.154652Z","time spent":"851.374537ms","remote":"127.0.0.1:44186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":776,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-24T04:47:02.008006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.799168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T04:47:02.008048Z","caller":"traceutil/trace.go:171","msg":"trace[863488831] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:179; }","duration":"396.87268ms","start":"2026-07-24T04:47:01.611165Z","end":"2026-07-24T04:47:02.008038Z","steps":["trace[863488831] 'agreement among raft nodes before linearized reading' (duration: 396.768827ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:47:02.008018Z","caller":"traceutil/trace.go:171","msg":"trace[1536470402] transaction","detail":"{read_only:false; response_revision:179; number_of_response:1; }","duration":"363.929269ms","start":"2026-07-24T04:47:01.644081Z","end":"2026-07-24T04:47:02.00801Z","steps":["trace[1536470402] 'process raft request' (duration: 363.800546ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:47:02.008074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:47:01.611145Z","time spent":"396.922371ms","remote":"127.0.0.1:44084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-24T04:47:02.008136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:47:01.644063Z","time spent":"364.047652ms","remote":"127.0.0.1:44012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-24T04:48:48.949905Z","caller":"traceutil/trace.go:171","msg":"trace[688223265] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"121.650664ms","start":"2026-07-24T04:48:48.828206Z","end":"2026-07-24T04:48:48.949857Z","steps":["trace[688223265] 'process raft request' (duration: 120.139436ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:48:49.529745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.193921ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-24T04:48:49.529857Z","caller":"traceutil/trace.go:171","msg":"trace[1341312364] linearizableReadLoop","detail":"{readStateIndex:790; appliedIndex:789; }","duration":"462.4662ms","start":"2026-07-24T04:48:49.067373Z","end":"2026-07-24T04:48:49.52984Z","steps":["trace[1341312364] 'read index received' (duration: 297.992743ms)","trace[1341312364] 'applied index is now lower than readState.Index' (duration: 164.472387ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T04:48:49.529944Z","caller":"traceutil/trace.go:171","msg":"trace[2001722928] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"512.168844ms","start":"2026-07-24T04:48:49.017764Z","end":"2026-07-24T04:48:49.529933Z","steps":["trace[2001722928] 'process raft request' (duration: 347.715206ms)","trace[2001722928] 'compare' (duration: 163.870563ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T04:48:49.529999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:48:49.017728Z","time spent":"512.247676ms","remote":"127.0.0.1:44348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-24T04:48:49.530311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.913161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-24T04:48:49.530468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.023669ms","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-07-24T04:48:49.530495Z","caller":"traceutil/trace.go:171","msg":"trace[1769417112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:747; }","duration":"463.168688ms","start":"2026-07-24T04:48:49.067303Z","end":"2026-07-24T04:48:49.530472Z","steps":["trace[1769417112] 'agreement among raft nodes before linearized reading' (duration: 462.816459ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:48:49.530669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:48:49.06728Z","time spent":"463.376272ms","remote":"127.0.0.1:44084","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-07-24T04:48:49.530543Z","caller":"traceutil/trace.go:171","msg":"trace[630978162] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:747; }","duration":"260.124992ms","start":"2026-07-24T04:48:49.270394Z","end":"2026-07-24T04:48:49.530519Z","steps":["trace[630978162] 'agreement among raft nodes before linearized reading' (duration: 259.984278ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:48:49.530317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.15012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2tmh8\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-07-24T04:48:49.530959Z","caller":"traceutil/trace.go:171","msg":"trace[1329830021] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2tmh8; range_end:; response_count:1; response_revision:747; }","duration":"264.865607ms","start":"2026-07-24T04:48:49.266071Z","end":"2026-07-24T04:48:49.530937Z","steps":["trace[1329830021] 'agreement among raft nodes before linearized reading' (duration: 263.991456ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:50:03.051763Z","caller":"traceutil/trace.go:171","msg":"trace[872518097] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"126.697659ms","start":"2026-07-24T04:50:02.925033Z","end":"2026-07-24T04:50:03.051731Z","steps":["trace[872518097] 'process raft request' (duration: 126.509444ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:50:03.659387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.368725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T04:50:03.659477Z","caller":"traceutil/trace.go:171","msg":"trace[39802606] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1205; }","duration":"151.540769ms","start":"2026-07-24T04:50:03.507919Z","end":"2026-07-24T04:50:03.659459Z","steps":["trace[39802606] 'count revisions from in-memory index tree' (duration: 151.253042ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:50:24.010705Z","caller":"traceutil/trace.go:171","msg":"trace[1654790070] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"425.738862ms","start":"2026-07-24T04:50:23.584937Z","end":"2026-07-24T04:50:24.010676Z","steps":["trace[1654790070] 'process raft request' (duration: 425.558967ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:50:24.01104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:50:23.584906Z","time spent":"425.893456ms","remote":"127.0.0.1:44084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T04:50:24.188614Z","caller":"traceutil/trace.go:171","msg":"trace[1818207805] linearizableReadLoop","detail":"{readStateIndex:1398; appliedIndex:1396; }","duration":"348.979563ms","start":"2026-07-24T04:50:23.839613Z","end":"2026-07-24T04:50:24.188592Z","steps":["trace[1818207805] 'read index received' (duration: 170.925308ms)","trace[1818207805] 'applied index is now lower than readState.Index' (duration: 178.053495ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T04:50:24.18867Z","caller":"traceutil/trace.go:171","msg":"trace[1904922820] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"437.237506ms","start":"2026-07-24T04:50:23.751393Z","end":"2026-07-24T04:50:24.188631Z","steps":["trace[1904922820] 'process raft request' (duration: 340.948613ms)","trace[1904922820] 'compare' (duration: 96.147449ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T04:50:24.188745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.111106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T04:50:24.188795Z","caller":"traceutil/trace.go:171","msg":"trace[398167625] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1332; }","duration":"349.197738ms","start":"2026-07-24T04:50:23.839572Z","end":"2026-07-24T04:50:24.188769Z","steps":["trace[398167625] 'agreement among raft nodes before linearized reading' (duration: 349.119056ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:50:24.188812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:50:23.839552Z","time spent":"349.25556ms","remote":"127.0.0.1:57688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-24T04:50:24.188856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:50:23.751369Z","time spent":"437.392399ms","remote":"127.0.0.1:44084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T04:50:38.42537Z","caller":"traceutil/trace.go:171","msg":"trace[280588495] linearizableReadLoop","detail":"{readStateIndex:1459; appliedIndex:1458; }","duration":"180.801623ms","start":"2026-07-24T04:50:38.244546Z","end":"2026-07-24T04:50:38.425347Z","steps":["trace[280588495] 'read index received' (duration: 180.66777ms)","trace[280588495] 'applied index is now lower than readState.Index' (duration: 132.873µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T04:50:38.425694Z","caller":"traceutil/trace.go:171","msg":"trace[1883332534] transaction","detail":"{read_only:false; response_revision:1390; number_of_response:1; }","duration":"186.981826ms","start":"2026-07-24T04:50:38.238701Z","end":"2026-07-24T04:50:38.425683Z","steps":["trace[1883332534] 'process raft request' (duration: 186.511615ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:50:38.425957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.405227ms","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-07-24T04:50:38.425994Z","caller":"traceutil/trace.go:171","msg":"trace[703826332] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1390; }","duration":"181.49231ms","start":"2026-07-24T04:50:38.244493Z","end":"2026-07-24T04:50:38.425985Z","steps":["trace[703826332] 'agreement among raft nodes before linearized reading' (duration: 181.371017ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:50:38.426174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.100967ms","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-07-24T04:50:38.426206Z","caller":"traceutil/trace.go:171","msg":"trace[1039533575] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1390; }","duration":"172.153028ms","start":"2026-07-24T04:50:38.254045Z","end":"2026-07-24T04:50:38.426198Z","steps":["trace[1039533575] 'agreement among raft nodes before linearized reading' (duration: 172.074266ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:50:39.839424Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5601808962856628870,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-24T04:50:39.9038Z","caller":"traceutil/trace.go:171","msg":"trace[471722537] linearizableReadLoop","detail":"{readStateIndex:1467; appliedIndex:1466; }","duration":"564.610087ms","start":"2026-07-24T04:50:39.339169Z","end":"2026-07-24T04:50:39.90378Z","steps":["trace[471722537] 'read index received' (duration: 564.468184ms)","trace[471722537] 'applied index is now lower than readState.Index' (duration: 141.343µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T04:50:39.903884Z","caller":"traceutil/trace.go:171","msg":"trace[1603445226] transaction","detail":"{read_only:false; response_revision:1398; number_of_response:1; }","duration":"594.127496ms","start":"2026-07-24T04:50:39.309749Z","end":"2026-07-24T04:50:39.903877Z","steps":["trace[1603445226] 'process raft request' (duration: 593.928312ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:50:39.903963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:50:39.309738Z","time spent":"594.164738ms","remote":"127.0.0.1:44084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T04:50:39.904141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.979906ms","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-07-24T04:50:39.904177Z","caller":"traceutil/trace.go:171","msg":"trace[1510964924] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1398; }","duration":"565.056128ms","start":"2026-07-24T04:50:39.339112Z","end":"2026-07-24T04:50:39.904169Z","steps":["trace[1510964924] 'agreement among raft nodes before linearized reading' (duration: 564.960755ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:50:39.904199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:50:39.339089Z","time spent":"565.102629ms","remote":"127.0.0.1:44084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-24T04:50:39.904292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.175163ms","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-07-24T04:50:39.904313Z","caller":"traceutil/trace.go:171","msg":"trace[1897628796] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1398; }","duration":"479.228925ms","start":"2026-07-24T04:50:39.425079Z","end":"2026-07-24T04:50:39.904308Z","steps":["trace[1897628796] 'agreement among raft nodes before linearized reading' (duration: 479.173024ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:50:39.904331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:50:39.42506Z","time spent":"479.265785ms","remote":"127.0.0.1:44084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-24T04:50:40.14407Z","caller":"traceutil/trace.go:171","msg":"trace[281462417] transaction","detail":"{read_only:false; response_revision:1399; number_of_response:1; }","duration":"235.867994ms","start":"2026-07-24T04:50:39.908187Z","end":"2026-07-24T04:50:40.144055Z","steps":["trace[281462417] 'process raft request' (duration: 205.875933ms)","trace[281462417] 'compare' (duration: 29.687003ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T04:50:40.14407Z","caller":"traceutil/trace.go:171","msg":"trace[62169060] transaction","detail":"{read_only:false; response_revision:1400; number_of_response:1; }","duration":"235.649089ms","start":"2026-07-24T04:50:39.908403Z","end":"2026-07-24T04:50:40.144052Z","steps":["trace[62169060] 'process raft request' (duration: 235.586957ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:50:52.142098Z","caller":"traceutil/trace.go:171","msg":"trace[1841719673] transaction","detail":"{read_only:false; response_revision:1485; number_of_response:1; }","duration":"189.027386ms","start":"2026-07-24T04:50:51.953044Z","end":"2026-07-24T04:50:52.142072Z","steps":["trace[1841719673] 'process raft request' (duration: 188.879222ms)"],"step_count":1}