{"level":"warn","ts":"2026-04-14T04:20:17.580848Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-14T04:20:17.580922Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.227:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.227:2380","--initial-cluster=instance=https://199.204.45.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.227: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-04-14T04:20:17.58098Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-14T04:20:17.580994Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-04-14T04:20:17.581012Z","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-04-14T04:20:17.581613Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"]} {"level":"info","ts":"2026-04-14T04:20:17.581757Z","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.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.227: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-04-14T04:20:17.588087Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.136917ms"} {"level":"info","ts":"2026-04-14T04:20:17.597989Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"572db18442eba1c2","cluster-id":"fb1028a037bf3cd6"} {"level":"info","ts":"2026-04-14T04:20:17.598053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-14T04:20:17.598075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 0"} {"level":"info","ts":"2026-04-14T04:20:17.598083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 572db18442eba1c2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-14T04:20:17.59809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 1"} {"level":"info","ts":"2026-04-14T04:20:17.598116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"warn","ts":"2026-04-14T04:20:17.604417Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-14T04:20:17.605782Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-14T04:20:17.607758Z","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-04-14T04:20:17.609606Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"572db18442eba1c2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-14T04:20:17.609975Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"572db18442eba1c2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-14T04:20:17.609956Z","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-04-14T04:20:17.610086Z","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-04-14T04:20:17.610102Z","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-04-14T04:20:17.611013Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"info","ts":"2026-04-14T04:20:17.618051Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","added-peer-id":"572db18442eba1c2","added-peer-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-04-14T04:20:17.620148Z","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-04-14T04:20:17.620299Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-04-14T04:20:17.620346Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-04-14T04:20:17.620396Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"572db18442eba1c2","initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-14T04:20:17.620428Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-14T04:20:17.998456Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-14T04:20:17.998525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-14T04:20:17.99856Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgPreVoteResp from 572db18442eba1c2 at term 1"} {"level":"info","ts":"2026-04-14T04:20:17.998578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became candidate at term 2"} {"level":"info","ts":"2026-04-14T04:20:17.998589Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgVoteResp from 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-04-14T04:20:17.9986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became leader at term 2"} {"level":"info","ts":"2026-04-14T04:20:17.998612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 572db18442eba1c2 elected leader 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-04-14T04:20:18.047031Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"572db18442eba1c2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.227:2379]}","request-path":"/0/members/572db18442eba1c2/attributes","cluster-id":"fb1028a037bf3cd6","publish-timeout":"7s"} {"level":"info","ts":"2026-04-14T04:20:18.047346Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T04:20:18.047455Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T04:20:18.047856Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-14T04:20:18.047881Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-14T04:20:18.047078Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T04:20:18.051074Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T04:20:18.051247Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T04:20:18.051315Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T04:20:18.05187Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.227:2379"} {"level":"info","ts":"2026-04-14T04:20:18.052093Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-14T04:20:19.383096Z","caller":"traceutil/trace.go:171","msg":"trace[929837361] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"156.330919ms","start":"2026-04-14T04:20:19.226743Z","end":"2026-04-14T04:20:19.383074Z","steps":["trace[929837361] 'process raft request' (duration: 156.143916ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:19.389743Z","caller":"traceutil/trace.go:171","msg":"trace[903165934] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"161.213266ms","start":"2026-04-14T04:20:19.228505Z","end":"2026-04-14T04:20:19.389718Z","steps":["trace[903165934] 'process raft request' (duration: 161.019112ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:19.390009Z","caller":"traceutil/trace.go:171","msg":"trace[1011105814] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"162.937177ms","start":"2026-04-14T04:20:19.226844Z","end":"2026-04-14T04:20:19.389781Z","steps":["trace[1011105814] 'process raft request' (duration: 162.590468ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:19.392057Z","caller":"traceutil/trace.go:171","msg":"trace[1256284638] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"163.635365ms","start":"2026-04-14T04:20:19.228396Z","end":"2026-04-14T04:20:19.392031Z","steps":["trace[1256284638] 'read index received' (duration: 154.527118ms)","trace[1256284638] 'applied index is now lower than readState.Index' (duration: 9.106766ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T04:20:19.392229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.807138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-14T04:20:19.392278Z","caller":"traceutil/trace.go:171","msg":"trace[738907038] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:11; }","duration":"163.88803ms","start":"2026-04-14T04:20:19.228378Z","end":"2026-04-14T04:20:19.392266Z","steps":["trace[738907038] 'agreement among raft nodes before linearized reading' (duration: 163.766867ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:19.393017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.582158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-14T04:20:19.393065Z","caller":"traceutil/trace.go:171","msg":"trace[1304306692] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"116.685449ms","start":"2026-04-14T04:20:19.276367Z","end":"2026-04-14T04:20:19.393052Z","steps":["trace[1304306692] 'agreement among raft nodes before linearized reading' (duration: 116.616517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:19.393102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.378931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-04-14T04:20:19.393196Z","caller":"traceutil/trace.go:171","msg":"trace[266335232] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"164.492063ms","start":"2026-04-14T04:20:19.228682Z","end":"2026-04-14T04:20:19.393174Z","steps":["trace[266335232] 'agreement among raft nodes before linearized reading' (duration: 164.33084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:19.39316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.508355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-14T04:20:19.393239Z","caller":"traceutil/trace.go:171","msg":"trace[1407274647] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"164.590297ms","start":"2026-04-14T04:20:19.228637Z","end":"2026-04-14T04:20:19.393228Z","steps":["trace[1407274647] 'agreement among raft nodes before linearized reading' (duration: 164.502655ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:19.39353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.085878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-14T04:20:19.393581Z","caller":"traceutil/trace.go:171","msg":"trace[1812239790] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:11; }","duration":"165.15246ms","start":"2026-04-14T04:20:19.228414Z","end":"2026-04-14T04:20:19.393567Z","steps":["trace[1812239790] 'agreement among raft nodes before linearized reading' (duration: 164.32785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:23.535347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.086947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-14T04:20:23.535447Z","caller":"traceutil/trace.go:171","msg":"trace[493677976] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:270; }","duration":"161.225501ms","start":"2026-04-14T04:20:23.374189Z","end":"2026-04-14T04:20:23.535415Z","steps":["trace[493677976] 'range keys from in-memory index tree' (duration: 160.980205ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:23.742767Z","caller":"traceutil/trace.go:171","msg":"trace[974345363] transaction","detail":"{read_only:false; response_revision:271; number_of_response:1; }","duration":"203.144199ms","start":"2026-04-14T04:20:23.539599Z","end":"2026-04-14T04:20:23.742743Z","steps":["trace[974345363] 'process raft request' (duration: 202.997106ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:24.057375Z","caller":"traceutil/trace.go:171","msg":"trace[1461430691] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"517.713852ms","start":"2026-04-14T04:20:23.539637Z","end":"2026-04-14T04:20:24.057351Z","steps":["trace[1461430691] 'process raft request' (duration: 517.543358ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:24.057545Z","caller":"traceutil/trace.go:171","msg":"trace[1567668001] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"517.789424ms","start":"2026-04-14T04:20:23.539739Z","end":"2026-04-14T04:20:24.057529Z","steps":["trace[1567668001] 'process raft request' (duration: 517.566749ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:24.058018Z","caller":"traceutil/trace.go:171","msg":"trace[1996291907] linearizableReadLoop","detail":"{readStateIndex:283; appliedIndex:280; }","duration":"512.05902ms","start":"2026-04-14T04:20:23.545947Z","end":"2026-04-14T04:20:24.058006Z","steps":["trace[1996291907] 'read index received' (duration: 197.040966ms)","trace[1996291907] 'applied index is now lower than readState.Index' (duration: 315.016774ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T04:20:24.058141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.140927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cronjob-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T04:20:24.058137Z","caller":"traceutil/trace.go:171","msg":"trace[2053377974] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"517.889986ms","start":"2026-04-14T04:20:23.540225Z","end":"2026-04-14T04:20:24.058115Z","steps":["trace[2053377974] 'process raft request' (duration: 517.260542ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:24.058149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.186623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T04:20:24.05818Z","caller":"traceutil/trace.go:171","msg":"trace[1256985128] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cronjob-controller; range_end:; response_count:0; response_revision:274; }","duration":"312.212998ms","start":"2026-04-14T04:20:23.745958Z","end":"2026-04-14T04:20:24.058171Z","steps":["trace[1256985128] 'agreement among raft nodes before linearized reading' (duration: 312.150447ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:24.058136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:23.53962Z","time spent":"517.831674ms","remote":"127.0.0.1:41396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T04:20:24.058211Z","caller":"traceutil/trace.go:171","msg":"trace[1296079711] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:274; }","duration":"512.283585ms","start":"2026-04-14T04:20:23.545912Z","end":"2026-04-14T04:20:24.058196Z","steps":["trace[1296079711] 'agreement among raft nodes before linearized reading' (duration: 512.181902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:24.058211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:23.745942Z","time spent":"312.262219ms","remote":"127.0.0.1:41336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/cronjob-controller\" "} {"level":"warn","ts":"2026-04-14T04:20:24.058237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:23.545899Z","time spent":"512.333387ms","remote":"127.0.0.1:41396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-14T04:20:24.058265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:23.540201Z","time spent":"517.994419ms","remote":"127.0.0.1:41396","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-04-14T04:20:24.058258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.330125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T04:20:24.058331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.182278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"} {"level":"info","ts":"2026-04-14T04:20:24.058349Z","caller":"traceutil/trace.go:171","msg":"trace[712370857] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:274; }","duration":"240.224559ms","start":"2026-04-14T04:20:23.818117Z","end":"2026-04-14T04:20:24.058342Z","steps":["trace[712370857] 'agreement among raft nodes before linearized reading' (duration: 240.181677ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:24.058354Z","caller":"traceutil/trace.go:171","msg":"trace[588718805] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:274; }","duration":"235.462429ms","start":"2026-04-14T04:20:23.822869Z","end":"2026-04-14T04:20:24.058331Z","steps":["trace[588718805] 'agreement among raft nodes before linearized reading' (duration: 235.264804ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:24.058449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:23.539734Z","time spent":"517.881227ms","remote":"127.0.0.1:41396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T04:20:24.399148Z","caller":"traceutil/trace.go:171","msg":"trace[1850355955] transaction","detail":"{read_only:false; response_revision:275; number_of_response:1; }","duration":"334.679495ms","start":"2026-04-14T04:20:24.06444Z","end":"2026-04-14T04:20:24.39912Z","steps":["trace[1850355955] 'process raft request' (duration: 330.360624ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:24.399451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:24.06443Z","time spent":"334.967312ms","remote":"127.0.0.1:41336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":186,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T04:20:24.403498Z","caller":"traceutil/trace.go:171","msg":"trace[923781849] transaction","detail":"{read_only:false; response_revision:276; number_of_response:1; }","duration":"338.889273ms","start":"2026-04-14T04:20:24.064594Z","end":"2026-04-14T04:20:24.403483Z","steps":["trace[923781849] 'process raft request' (duration: 338.506273ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:24.403571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:24.064589Z","time spent":"338.950723ms","remote":"127.0.0.1:41396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T04:20:24.403838Z","caller":"traceutil/trace.go:171","msg":"trace[1746000658] transaction","detail":"{read_only:false; response_revision:277; number_of_response:1; }","duration":"318.029767ms","start":"2026-04-14T04:20:24.085797Z","end":"2026-04-14T04:20:24.403827Z","steps":["trace[1746000658] 'process raft request' (duration: 317.366682ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:24.4039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:24.085786Z","time spent":"318.077659ms","remote":"127.0.0.1:41330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4649,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T04:20:27.139375Z","caller":"traceutil/trace.go:171","msg":"trace[1882612372] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"292.034384ms","start":"2026-04-14T04:20:26.847313Z","end":"2026-04-14T04:20:27.139347Z","steps":["trace[1882612372] 'process raft request' (duration: 291.503463ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:27.141385Z","caller":"traceutil/trace.go:171","msg":"trace[1515914239] linearizableReadLoop","detail":"{readStateIndex:354; appliedIndex:351; }","duration":"207.481876ms","start":"2026-04-14T04:20:26.933878Z","end":"2026-04-14T04:20:27.14136Z","steps":["trace[1515914239] 'read index received' (duration: 204.914307ms)","trace[1515914239] 'applied index is now lower than readState.Index' (duration: 2.566109ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T04:20:27.141597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.692831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-04-14T04:20:27.141707Z","caller":"traceutil/trace.go:171","msg":"trace[818724924] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:345; }","duration":"207.850296ms","start":"2026-04-14T04:20:26.933828Z","end":"2026-04-14T04:20:27.141678Z","steps":["trace[818724924] 'agreement among raft nodes before linearized reading' (duration: 207.642691ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:27.142042Z","caller":"traceutil/trace.go:171","msg":"trace[1594392227] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"287.912709ms","start":"2026-04-14T04:20:26.854106Z","end":"2026-04-14T04:20:27.142018Z","steps":["trace[1594392227] 'process raft request' (duration: 287.07292ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:27.142099Z","caller":"traceutil/trace.go:171","msg":"trace[1009344010] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"287.769308ms","start":"2026-04-14T04:20:26.854273Z","end":"2026-04-14T04:20:27.142042Z","steps":["trace[1009344010] 'process raft request' (duration: 287.02515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:46.504325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.512158ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-14T04:20:46.975128Z","caller":"traceutil/trace.go:171","msg":"trace[235792892] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"837.077479ms","start":"2026-04-14T04:20:46.138Z","end":"2026-04-14T04:20:46.975078Z","steps":["trace[235792892] 'process raft request' (duration: 836.810363ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:46.975219Z","caller":"traceutil/trace.go:171","msg":"trace[318023537] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"834.203836ms","start":"2026-04-14T04:20:46.140952Z","end":"2026-04-14T04:20:46.975156Z","steps":["trace[318023537] 'process raft request' (duration: 834.053443ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:46.975297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:46.137981Z","time spent":"837.240051ms","remote":"127.0.0.1:41208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T04:20:46.975191Z","caller":"traceutil/trace.go:171","msg":"trace[726680022] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"837.003136ms","start":"2026-04-14T04:20:46.138108Z","end":"2026-04-14T04:20:46.975112Z","steps":["trace[726680022] 'process raft request' (duration: 836.852123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:46.975466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:46.140929Z","time spent":"834.40168ms","remote":"127.0.0.1:41208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T04:20:46.975508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:46.138104Z","time spent":"837.261672ms","remote":"127.0.0.1:41208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T04:20:46.975518Z","caller":"traceutil/trace.go:171","msg":"trace[2062949280] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"825.484299ms","start":"2026-04-14T04:20:46.15Z","end":"2026-04-14T04:20:46.975485Z","steps":["trace[2062949280] 'process raft request' (duration: 825.076531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:46.975651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:46.149994Z","time spent":"825.591522ms","remote":"127.0.0.1:41208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T04:20:46.97571Z","caller":"traceutil/trace.go:171","msg":"trace[861691413] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"822.651019ms","start":"2026-04-14T04:20:46.153045Z","end":"2026-04-14T04:20:46.975696Z","steps":["trace[861691413] 'process raft request' (duration: 822.068056ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:46.975788Z","caller":"traceutil/trace.go:171","msg":"trace[92392678] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"828.886683ms","start":"2026-04-14T04:20:46.146888Z","end":"2026-04-14T04:20:46.975774Z","steps":["trace[92392678] 'process raft request' (duration: 828.151557ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:46.97582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:46.153039Z","time spent":"822.752861ms","remote":"127.0.0.1:41208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T04:20:46.975849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:46.146876Z","time spent":"828.942853ms","remote":"127.0.0.1:41208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T04:20:46.975663Z","caller":"traceutil/trace.go:171","msg":"trace[1115110091] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"822.545286ms","start":"2026-04-14T04:20:46.153102Z","end":"2026-04-14T04:20:46.975647Z","steps":["trace[1115110091] 'process raft request' (duration: 822.051426ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:46.975898Z","caller":"traceutil/trace.go:171","msg":"trace[680745516] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"822.367064ms","start":"2026-04-14T04:20:46.153516Z","end":"2026-04-14T04:20:46.975883Z","steps":["trace[680745516] 'process raft request' (duration: 821.679699ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:46.975943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:46.153099Z","time spent":"822.825243ms","remote":"127.0.0.1:41208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T04:20:46.975958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:46.153511Z","time spent":"822.417425ms","remote":"127.0.0.1:41208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T04:20:46.975979Z","caller":"traceutil/trace.go:171","msg":"trace[872365293] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"817.956188ms","start":"2026-04-14T04:20:46.158013Z","end":"2026-04-14T04:20:46.975969Z","steps":["trace[872365293] 'process raft request' (duration: 817.390796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:46.976033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:46.158008Z","time spent":"818.00316ms","remote":"127.0.0.1:41208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T04:20:46.976118Z","caller":"traceutil/trace.go:171","msg":"trace[920659951] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"816.355425ms","start":"2026-04-14T04:20:46.159754Z","end":"2026-04-14T04:20:46.97611Z","steps":["trace[920659951] 'process raft request' (duration: 815.863034ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:46.976161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:46.159749Z","time spent":"816.393945ms","remote":"127.0.0.1:41208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T04:20:46.976239Z","caller":"traceutil/trace.go:171","msg":"trace[9786027] linearizableReadLoop","detail":"{readStateIndex:493; appliedIndex:481; }","duration":"790.236585ms","start":"2026-04-14T04:20:46.18581Z","end":"2026-04-14T04:20:46.976047Z","steps":["trace[9786027] 'read index received' (duration: 51.847031ms)","trace[9786027] 'applied index is now lower than readState.Index' (duration: 738.388034ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T04:20:46.976214Z","caller":"traceutil/trace.go:171","msg":"trace[98159931] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"800.918344ms","start":"2026-04-14T04:20:46.175278Z","end":"2026-04-14T04:20:46.976196Z","steps":["trace[98159931] 'process raft request' (duration: 800.504226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:46.976472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"790.646534ms","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-04-14T04:20:46.976522Z","caller":"traceutil/trace.go:171","msg":"trace[1712257430] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:479; }","duration":"790.730705ms","start":"2026-04-14T04:20:46.18578Z","end":"2026-04-14T04:20:46.976511Z","steps":["trace[1712257430] 'agreement among raft nodes before linearized reading' (duration: 790.589432ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:46.97656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:46.185768Z","time spent":"790.784876ms","remote":"127.0.0.1:41396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-14T04:20:46.977026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:46.175226Z","time spent":"801.23362ms","remote":"127.0.0.1:41208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T04:20:46.990466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"802.64603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-14T04:20:46.990501Z","caller":"traceutil/trace.go:171","msg":"trace[158393055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:480; }","duration":"802.692032ms","start":"2026-04-14T04:20:46.1878Z","end":"2026-04-14T04:20:46.990492Z","steps":["trace[158393055] 'agreement among raft nodes before linearized reading' (duration: 802.618151ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:46.990518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:46.187795Z","time spent":"802.719152ms","remote":"127.0.0.1:41396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-14T04:20:46.990662Z","caller":"traceutil/trace.go:171","msg":"trace[1663890367] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"675.684562ms","start":"2026-04-14T04:20:46.314972Z","end":"2026-04-14T04:20:46.990656Z","steps":["trace[1663890367] 'process raft request' (duration: 675.365985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:46.990728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:46.314944Z","time spent":"675.730313ms","remote":"127.0.0.1:41208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T04:20:46.990835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.842547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-14T04:20:46.991078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.246811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-14T04:20:46.990903Z","caller":"traceutil/trace.go:171","msg":"trace[1542054188] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:480; }","duration":"762.962741ms","start":"2026-04-14T04:20:46.22793Z","end":"2026-04-14T04:20:46.990893Z","steps":["trace[1542054188] 'agreement among raft nodes before linearized reading' (duration: 762.836289ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:46.991188Z","caller":"traceutil/trace.go:171","msg":"trace[1097940195] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:480; }","duration":"470.457296ms","start":"2026-04-14T04:20:46.5207Z","end":"2026-04-14T04:20:46.991158Z","steps":["trace[1097940195] 'agreement among raft nodes before linearized reading' (duration: 470.212001ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:46.991239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:46.520679Z","time spent":"470.550527ms","remote":"127.0.0.1:41396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-14T04:20:46.990858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.69729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T04:20:46.99121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:46.2279Z","time spent":"763.302118ms","remote":"127.0.0.1:41396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-14T04:20:46.993004Z","caller":"traceutil/trace.go:171","msg":"trace[662212344] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:480; }","duration":"168.886387ms","start":"2026-04-14T04:20:46.824102Z","end":"2026-04-14T04:20:46.992989Z","steps":["trace[662212344] 'agreement among raft nodes before linearized reading' (duration: 166.6973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:47.570625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.175402ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T04:20:47.570756Z","caller":"traceutil/trace.go:171","msg":"trace[213394771] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"244.253995ms","start":"2026-04-14T04:20:47.326483Z","end":"2026-04-14T04:20:47.570737Z","steps":["trace[213394771] 'process raft request' (duration: 36.894228ms)","trace[213394771] 'compare' (duration: 207.007179ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T04:20:47.622607Z","caller":"traceutil/trace.go:171","msg":"trace[1745706816] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"291.448943ms","start":"2026-04-14T04:20:47.331138Z","end":"2026-04-14T04:20:47.622586Z","steps":["trace[1745706816] 'process raft request' (duration: 291.3145ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:47.641352Z","caller":"traceutil/trace.go:171","msg":"trace[1203269319] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"270.778672ms","start":"2026-04-14T04:20:47.370551Z","end":"2026-04-14T04:20:47.641329Z","steps":["trace[1203269319] 'process raft request' (duration: 270.593828ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:50.131726Z","caller":"traceutil/trace.go:171","msg":"trace[454215945] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"106.522262ms","start":"2026-04-14T04:20:50.025182Z","end":"2026-04-14T04:20:50.131704Z","steps":["trace[454215945] 'process raft request' (duration: 106.37701ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:53.490015Z","caller":"traceutil/trace.go:171","msg":"trace[330533685] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"113.672173ms","start":"2026-04-14T04:20:53.376317Z","end":"2026-04-14T04:20:53.489989Z","steps":["trace[330533685] 'process raft request' (duration: 113.615662ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:53.490054Z","caller":"traceutil/trace.go:171","msg":"trace[1931475192] linearizableReadLoop","detail":"{readStateIndex:590; appliedIndex:589; }","duration":"459.357118ms","start":"2026-04-14T04:20:53.030668Z","end":"2026-04-14T04:20:53.490025Z","steps":["trace[1931475192] 'read index received' (duration: 458.569282ms)","trace[1931475192] 'applied index is now lower than readState.Index' (duration: 785.456µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T04:20:53.490415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.728126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-14T04:20:53.490421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.393394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-14T04:20:53.490526Z","caller":"traceutil/trace.go:171","msg":"trace[1000107837] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:573; }","duration":"454.547166ms","start":"2026-04-14T04:20:53.035959Z","end":"2026-04-14T04:20:53.490506Z","steps":["trace[1000107837] 'agreement among raft nodes before linearized reading' (duration: 454.313912ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:53.490529Z","caller":"traceutil/trace.go:171","msg":"trace[1380452265] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:573; }","duration":"459.821638ms","start":"2026-04-14T04:20:53.030654Z","end":"2026-04-14T04:20:53.490475Z","steps":["trace[1380452265] 'agreement among raft nodes before linearized reading' (duration: 459.561623ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:53.490558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:53.035938Z","time spent":"454.613728ms","remote":"127.0.0.1:41396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-14T04:20:53.490463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.513601ms","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-04-14T04:20:53.490576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:53.030597Z","time spent":"459.969671ms","remote":"127.0.0.1:41396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-14T04:20:53.490568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.936503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-14T04:20:53.490621Z","caller":"traceutil/trace.go:171","msg":"trace[209522626] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:573; }","duration":"452.000523ms","start":"2026-04-14T04:20:53.038608Z","end":"2026-04-14T04:20:53.490608Z","steps":["trace[209522626] 'agreement among raft nodes before linearized reading' (duration: 451.80761ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:53.490614Z","caller":"traceutil/trace.go:171","msg":"trace[1218350970] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:573; }","duration":"447.692783ms","start":"2026-04-14T04:20:53.042906Z","end":"2026-04-14T04:20:53.490599Z","steps":["trace[1218350970] 'agreement among raft nodes before linearized reading' (duration: 447.371167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:53.490654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:53.038513Z","time spent":"452.132817ms","remote":"127.0.0.1:41396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T04:20:53.49069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:53.042896Z","time spent":"447.780126ms","remote":"127.0.0.1:41396","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-04-14T04:20:53.490106Z","caller":"traceutil/trace.go:171","msg":"trace[1038120013] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"551.046043ms","start":"2026-04-14T04:20:52.939019Z","end":"2026-04-14T04:20:53.490065Z","steps":["trace[1038120013] 'process raft request' (duration: 550.357539ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:53.491117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:52.93899Z","time spent":"551.783459ms","remote":"127.0.0.1:41254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T04:20:54.455879Z","caller":"traceutil/trace.go:171","msg":"trace[2056940118] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"527.383316ms","start":"2026-04-14T04:20:53.928468Z","end":"2026-04-14T04:20:54.455851Z","steps":["trace[2056940118] 'process raft request' (duration: 527.219193ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:54.456055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:53.928453Z","time spent":"527.507169ms","remote":"127.0.0.1:41330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T04:20:54.598215Z","caller":"traceutil/trace.go:171","msg":"trace[494514125] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"641.722325ms","start":"2026-04-14T04:20:53.956444Z","end":"2026-04-14T04:20:54.598167Z","steps":["trace[494514125] 'process raft request' (duration: 640.928898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:54.598405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:53.956431Z","time spent":"641.866398ms","remote":"127.0.0.1:41254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T04:20:55.324579Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656052002558460623,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-14T04:20:55.462422Z","caller":"traceutil/trace.go:171","msg":"trace[2058955875] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:601; }","duration":"638.940915ms","start":"2026-04-14T04:20:54.823458Z","end":"2026-04-14T04:20:55.462399Z","steps":["trace[2058955875] 'read index received' (duration: 638.700659ms)","trace[2058955875] 'applied index is now lower than readState.Index' (duration: 239.236µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T04:20:55.462744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.270393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T04:20:55.46283Z","caller":"traceutil/trace.go:171","msg":"trace[646759190] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:584; }","duration":"639.403335ms","start":"2026-04-14T04:20:54.823406Z","end":"2026-04-14T04:20:55.46281Z","steps":["trace[646759190] 'agreement among raft nodes before linearized reading' (duration: 639.093949ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:55.462873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:54.823382Z","time spent":"639.482786ms","remote":"127.0.0.1:41128","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-04-14T04:20:55.463158Z","caller":"traceutil/trace.go:171","msg":"trace[1730293158] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"808.08275ms","start":"2026-04-14T04:20:54.655059Z","end":"2026-04-14T04:20:55.463142Z","steps":["trace[1730293158] 'process raft request' (duration: 807.166881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:20:55.463346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:20:54.65503Z","time spent":"808.220072ms","remote":"127.0.0.1:41370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T04:20:57.338647Z","caller":"traceutil/trace.go:171","msg":"trace[1005321417] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"226.881622ms","start":"2026-04-14T04:20:57.111721Z","end":"2026-04-14T04:20:57.338603Z","steps":["trace[1005321417] 'process raft request' (duration: 226.646017ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:20:57.340846Z","caller":"traceutil/trace.go:171","msg":"trace[140179488] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"175.963646ms","start":"2026-04-14T04:20:57.164848Z","end":"2026-04-14T04:20:57.340812Z","steps":["trace[140179488] 'process raft request' (duration: 175.842584ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:21:07.686062Z","caller":"traceutil/trace.go:171","msg":"trace[1177852633] linearizableReadLoop","detail":"{readStateIndex:748; appliedIndex:747; }","duration":"123.032964ms","start":"2026-04-14T04:21:07.563004Z","end":"2026-04-14T04:21:07.686036Z","steps":["trace[1177852633] 'read index received' (duration: 122.81048ms)","trace[1177852633] 'applied index is now lower than readState.Index' (duration: 221.364µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T04:21:07.686264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.242328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-14T04:21:07.686357Z","caller":"traceutil/trace.go:171","msg":"trace[648192770] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:726; }","duration":"123.37309ms","start":"2026-04-14T04:21:07.562972Z","end":"2026-04-14T04:21:07.686345Z","steps":["trace[648192770] 'agreement among raft nodes before linearized reading' (duration: 123.175046ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:21:07.686384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.446212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-14T04:21:07.686456Z","caller":"traceutil/trace.go:171","msg":"trace[1296998972] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:726; }","duration":"122.539974ms","start":"2026-04-14T04:21:07.5639Z","end":"2026-04-14T04:21:07.68644Z","steps":["trace[1296998972] 'agreement among raft nodes before linearized reading' (duration: 122.37983ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:21:07.686518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.380789ms","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-04-14T04:21:07.686594Z","caller":"traceutil/trace.go:171","msg":"trace[1155834811] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:726; }","duration":"119.501032ms","start":"2026-04-14T04:21:07.567078Z","end":"2026-04-14T04:21:07.686579Z","steps":["trace[1155834811] 'agreement among raft nodes before linearized reading' (duration: 119.288428ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:21:07.686113Z","caller":"traceutil/trace.go:171","msg":"trace[1518210103] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"125.697967ms","start":"2026-04-14T04:21:07.560394Z","end":"2026-04-14T04:21:07.686092Z","steps":["trace[1518210103] 'process raft request' (duration: 125.479162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:21:10.959343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"969.062481ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T04:21:10.959567Z","caller":"traceutil/trace.go:171","msg":"trace[787742334] linearizableReadLoop","detail":"{readStateIndex:764; appliedIndex:761; }","duration":"949.462636ms","start":"2026-04-14T04:21:10.010086Z","end":"2026-04-14T04:21:10.959549Z","steps":["trace[787742334] 'read index received' (duration: 307.094714ms)","trace[787742334] 'applied index is now lower than readState.Index' (duration: 642.366892ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T04:21:10.959549Z","caller":"traceutil/trace.go:171","msg":"trace[369673522] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"1.225995802s","start":"2026-04-14T04:21:09.733516Z","end":"2026-04-14T04:21:10.959512Z","steps":["trace[369673522] 'process raft request' (duration: 256.578364ms)","trace[369673522] 'compare' (duration: 968.663583ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T04:21:10.959775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:21:09.733489Z","time spent":"1.226164245s","remote":"127.0.0.1:41396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T04:21:10.95977Z","caller":"traceutil/trace.go:171","msg":"trace[1014680548] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"1.22489718s","start":"2026-04-14T04:21:09.734824Z","end":"2026-04-14T04:21:10.959721Z","steps":["trace[1014680548] 'process raft request' (duration: 1.224684576s)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:21:10.959884Z","caller":"traceutil/trace.go:171","msg":"trace[1470543234] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"1.225246557s","start":"2026-04-14T04:21:09.734626Z","end":"2026-04-14T04:21:10.959872Z","steps":["trace[1470543234] 'process raft request' (duration: 1.224820088s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:21:10.959951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:21:09.73461Z","time spent":"1.225308248s","remote":"127.0.0.1:41396","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-04-14T04:21:10.959953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:21:09.734775Z","time spent":"1.225078403s","remote":"127.0.0.1:41396","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-04-14T04:21:10.959977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"949.856445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-l4495\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-14T04:21:10.960067Z","caller":"traceutil/trace.go:171","msg":"trace[1093804219] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-l4495; range_end:; response_count:1; response_revision:742; }","duration":"949.987668ms","start":"2026-04-14T04:21:10.010057Z","end":"2026-04-14T04:21:10.960044Z","steps":["trace[1093804219] 'agreement among raft nodes before linearized reading' (duration: 949.698632ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:21:10.96015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:21:10.010032Z","time spent":"950.10793ms","remote":"127.0.0.1:41330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-l4495\" "} {"level":"info","ts":"2026-04-14T04:21:11.200421Z","caller":"traceutil/trace.go:171","msg":"trace[913393268] linearizableReadLoop","detail":"{readStateIndex:765; appliedIndex:764; }","duration":"240.783006ms","start":"2026-04-14T04:21:10.959602Z","end":"2026-04-14T04:21:11.200386Z","steps":["trace[913393268] 'read index received' (duration: 215.363578ms)","trace[913393268] 'applied index is now lower than readState.Index' (duration: 25.418428ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T04:21:11.200506Z","caller":"traceutil/trace.go:171","msg":"trace[2115156194] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"805.759398ms","start":"2026-04-14T04:21:10.394709Z","end":"2026-04-14T04:21:11.200468Z","steps":["trace[2115156194] 'process raft request' (duration: 780.259909ms)","trace[2115156194] 'compare' (duration: 25.289695ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T04:21:11.200619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.267121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T04:21:11.200665Z","caller":"traceutil/trace.go:171","msg":"trace[707980954] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:743; }","duration":"377.392713ms","start":"2026-04-14T04:21:10.82326Z","end":"2026-04-14T04:21:11.200653Z","steps":["trace[707980954] 'agreement among raft nodes before linearized reading' (duration: 377.251161ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:21:11.200673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:21:10.394678Z","time spent":"805.89814ms","remote":"127.0.0.1:41396","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-04-14T04:21:11.200707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:21:10.823236Z","time spent":"377.463225ms","remote":"127.0.0.1:41128","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-04-14T04:21:11.201162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.426344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-14T04:21:11.201216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.262458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-14T04:21:11.201275Z","caller":"traceutil/trace.go:171","msg":"trace[1046527099] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; response_count:1; response_revision:743; }","duration":"296.34102ms","start":"2026-04-14T04:21:10.904924Z","end":"2026-04-14T04:21:11.201265Z","steps":["trace[1046527099] 'agreement among raft nodes before linearized reading' (duration: 296.195426ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:21:11.201352Z","caller":"traceutil/trace.go:171","msg":"trace[32403673] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:743; }","duration":"368.606248ms","start":"2026-04-14T04:21:10.83265Z","end":"2026-04-14T04:21:11.201257Z","steps":["trace[32403673] 'agreement among raft nodes before linearized reading' (duration: 368.299031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:21:11.201468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T04:21:10.832617Z","time spent":"368.836843ms","remote":"127.0.0.1:41396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-14T04:21:11.204238Z","caller":"traceutil/trace.go:171","msg":"trace[1733660769] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"235.299166ms","start":"2026-04-14T04:21:10.968923Z","end":"2026-04-14T04:21:11.204222Z","steps":["trace[1733660769] 'process raft request' (duration: 234.98587ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:21:25.486052Z","caller":"traceutil/trace.go:171","msg":"trace[1052244613] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"170.254995ms","start":"2026-04-14T04:21:25.315766Z","end":"2026-04-14T04:21:25.486021Z","steps":["trace[1052244613] 'process raft request' (duration: 170.015661ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:23:30.211606Z","caller":"traceutil/trace.go:171","msg":"trace[1433692632] transaction","detail":"{read_only:false; response_revision:1375; number_of_response:1; }","duration":"101.982421ms","start":"2026-04-14T04:23:30.109557Z","end":"2026-04-14T04:23:30.21154Z","steps":["trace[1433692632] 'process raft request' (duration: 101.616467ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T04:23:31.829775Z","caller":"traceutil/trace.go:171","msg":"trace[1212247245] linearizableReadLoop","detail":"{readStateIndex:1436; appliedIndex:1434; }","duration":"103.720852ms","start":"2026-04-14T04:23:31.72603Z","end":"2026-04-14T04:23:31.829751Z","steps":["trace[1212247245] 'read index received' (duration: 44.714752ms)","trace[1212247245] 'applied index is now lower than readState.Index' (duration: 59.00497ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T04:23:31.829813Z","caller":"traceutil/trace.go:171","msg":"trace[289456205] transaction","detail":"{read_only:false; response_revision:1381; number_of_response:1; }","duration":"107.470106ms","start":"2026-04-14T04:23:31.722317Z","end":"2026-04-14T04:23:31.829788Z","steps":["trace[289456205] 'process raft request' (duration: 106.744608ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T04:23:31.830353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.267854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-xqd9h\" ","response":"range_response_count:1 size:18525"} {"level":"info","ts":"2026-04-14T04:23:31.830483Z","caller":"traceutil/trace.go:171","msg":"trace[1435276105] range","detail":"{range_begin:/registry/pods/kube-system/cilium-xqd9h; range_end:; response_count:1; response_revision:1381; }","duration":"104.460561ms","start":"2026-04-14T04:23:31.726Z","end":"2026-04-14T04:23:31.83046Z","steps":["trace[1435276105] 'agreement among raft nodes before linearized reading' (duration: 103.871429ms)"],"step_count":1}