{"level":"warn","ts":"2026-04-13T17:05:19.951424Z","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-13T17:05:19.951523Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.100: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.100:2380","--initial-cluster=instance=https://199.19.213.100:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.100:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.100: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-13T17:05:19.951597Z","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-13T17:05:19.951608Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.100:2380"]} {"level":"info","ts":"2026-04-13T17:05:19.951629Z","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-13T17:05:19.953232Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.100:2379"]} {"level":"info","ts":"2026-04-13T17:05:19.953309Z","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.100:2380"],"listen-peer-urls":["https://199.19.213.100:2380"],"advertise-client-urls":["https://199.19.213.100:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.100:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.100: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-13T17:05:19.957455Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.934763ms"} {"level":"info","ts":"2026-04-13T17:05:19.965757Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"79e65b4197a2a1a","cluster-id":"bba89cbb2a6fc22a"} {"level":"info","ts":"2026-04-13T17:05:19.96585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a switched to configuration voters=()"} {"level":"info","ts":"2026-04-13T17:05:19.966352Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a became follower at term 0"} {"level":"info","ts":"2026-04-13T17:05:19.966366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 79e65b4197a2a1a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-13T17:05:19.966376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a became follower at term 1"} {"level":"info","ts":"2026-04-13T17:05:19.966428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a switched to configuration voters=(548988028781734426)"} {"level":"warn","ts":"2026-04-13T17:05:19.979159Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-13T17:05:19.981329Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-13T17:05:19.982976Z","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-13T17:05:19.985568Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"79e65b4197a2a1a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-13T17:05:19.985698Z","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-13T17:05:19.985781Z","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-13T17:05:19.985716Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"79e65b4197a2a1a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-13T17:05:19.985794Z","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-13T17:05:19.993558Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a switched to configuration voters=(548988028781734426)"} {"level":"info","ts":"2026-04-13T17:05:19.993762Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bba89cbb2a6fc22a","local-member-id":"79e65b4197a2a1a","added-peer-id":"79e65b4197a2a1a","added-peer-peer-urls":["https://199.19.213.100:2380"]} {"level":"info","ts":"2026-04-13T17:05:19.994715Z","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-13T17:05:19.994865Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.100:2380"} {"level":"info","ts":"2026-04-13T17:05:19.994894Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.100:2380"} {"level":"info","ts":"2026-04-13T17:05:19.995161Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"79e65b4197a2a1a","initial-advertise-peer-urls":["https://199.19.213.100:2380"],"listen-peer-urls":["https://199.19.213.100:2380"],"advertise-client-urls":["https://199.19.213.100:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.100:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-13T17:05:19.995194Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-13T17:05:20.968532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a is starting a new election at term 1"} {"level":"info","ts":"2026-04-13T17:05:20.968628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a became pre-candidate at term 1"} {"level":"info","ts":"2026-04-13T17:05:20.968652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a received MsgPreVoteResp from 79e65b4197a2a1a at term 1"} {"level":"info","ts":"2026-04-13T17:05:20.968671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a became candidate at term 2"} {"level":"info","ts":"2026-04-13T17:05:20.968682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a received MsgVoteResp from 79e65b4197a2a1a at term 2"} {"level":"info","ts":"2026-04-13T17:05:20.968698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"79e65b4197a2a1a became leader at term 2"} {"level":"info","ts":"2026-04-13T17:05:20.968717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 79e65b4197a2a1a elected leader 79e65b4197a2a1a at term 2"} {"level":"info","ts":"2026-04-13T17:05:20.973836Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T17:05:20.975394Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T17:05:20.975401Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"79e65b4197a2a1a","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.100:2379]}","request-path":"/0/members/79e65b4197a2a1a/attributes","cluster-id":"bba89cbb2a6fc22a","publish-timeout":"7s"} {"level":"info","ts":"2026-04-13T17:05:20.97562Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T17:05:20.975798Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bba89cbb2a6fc22a","local-member-id":"79e65b4197a2a1a","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T17:05:20.975948Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T17:05:20.975968Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-13T17:05:20.975981Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T17:05:20.97599Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-13T17:05:20.977828Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-13T17:05:20.978202Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.100:2379"} {"level":"warn","ts":"2026-04-13T17:05:23.762107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.791724ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-13T17:05:23.762247Z","caller":"traceutil/trace.go:171","msg":"trace[1828592594] transaction","detail":"{read_only:false; response_revision:94; number_of_response:1; }","duration":"126.923265ms","start":"2026-04-13T17:05:23.635302Z","end":"2026-04-13T17:05:23.762225Z","steps":["trace[1828592594] 'process raft request' (duration: 15.272517ms)","trace[1828592594] 'compare' (duration: 110.623199ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:05:24.358088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.981932ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-13T17:05:24.358391Z","caller":"traceutil/trace.go:171","msg":"trace[1687601892] transaction","detail":"{read_only:false; response_revision:96; number_of_response:1; }","duration":"559.048169ms","start":"2026-04-13T17:05:23.79915Z","end":"2026-04-13T17:05:24.358198Z","steps":["trace[1687601892] 'process raft request' (duration: 76.898403ms)","trace[1687601892] 'compare' (duration: 481.854777ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:05:24.358653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:23.799123Z","time spent":"559.389108ms","remote":"127.0.0.1:44936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":710,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T17:05:25.160083Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3033910505590251286,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-13T17:05:25.280474Z","caller":"traceutil/trace.go:171","msg":"trace[1445861287] linearizableReadLoop","detail":"{readStateIndex:102; appliedIndex:101; }","duration":"620.686406ms","start":"2026-04-13T17:05:24.659764Z","end":"2026-04-13T17:05:25.28045Z","steps":["trace[1445861287] 'read index received' (duration: 620.594724ms)","trace[1445861287] 'applied index is now lower than readState.Index' (duration: 90.702µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:05:25.280849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.070104ms","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-13T17:05:25.280858Z","caller":"traceutil/trace.go:171","msg":"trace[1936487102] transaction","detail":"{read_only:false; response_revision:98; number_of_response:1; }","duration":"898.53573ms","start":"2026-04-13T17:05:24.381967Z","end":"2026-04-13T17:05:25.280503Z","steps":["trace[1936487102] 'process raft request' (duration: 898.344056ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:05:25.281114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:24.38194Z","time spent":"899.050131ms","remote":"127.0.0.1:44936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":669,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T17:05:25.280891Z","caller":"traceutil/trace.go:171","msg":"trace[1591593264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:98; }","duration":"621.168136ms","start":"2026-04-13T17:05:24.659712Z","end":"2026-04-13T17:05:25.28088Z","steps":["trace[1591593264] 'agreement among raft nodes before linearized reading' (duration: 620.831119ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:05:25.281249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:24.65969Z","time spent":"621.521984ms","remote":"127.0.0.1:44846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-13T17:05:25.886245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.957683ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-13T17:05:25.88637Z","caller":"traceutil/trace.go:171","msg":"trace[1780351244] linearizableReadLoop","detail":"{readStateIndex:104; appliedIndex:103; }","duration":"576.642722ms","start":"2026-04-13T17:05:25.309706Z","end":"2026-04-13T17:05:25.886349Z","steps":["trace[1780351244] 'read index received' (duration: 8.206153ms)","trace[1780351244] 'applied index is now lower than readState.Index' (duration: 568.435109ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:05:25.886439Z","caller":"traceutil/trace.go:171","msg":"trace[108373904] transaction","detail":"{read_only:false; response_revision:100; number_of_response:1; }","duration":"599.600535ms","start":"2026-04-13T17:05:25.286797Z","end":"2026-04-13T17:05:25.886398Z","steps":["trace[108373904] 'process raft request' (duration: 358.407247ms)","trace[108373904] 'compare' (duration: 240.79002ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:05:25.88657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.166039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"warn","ts":"2026-04-13T17:05:25.886609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.871816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-13T17:05:25.886699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:25.286781Z","time spent":"599.84012ms","remote":"127.0.0.1:44936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":687,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T17:05:25.886723Z","caller":"traceutil/trace.go:171","msg":"trace[337540359] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:100; }","duration":"577.069361ms","start":"2026-04-13T17:05:25.309635Z","end":"2026-04-13T17:05:25.886704Z","steps":["trace[337540359] 'agreement among raft nodes before linearized reading' (duration: 576.831966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:05:25.886914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:25.309611Z","time spent":"577.225644ms","remote":"127.0.0.1:44576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-13T17:05:25.886632Z","caller":"traceutil/trace.go:171","msg":"trace[927850294] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:100; }","duration":"565.263793ms","start":"2026-04-13T17:05:25.321347Z","end":"2026-04-13T17:05:25.886611Z","steps":["trace[927850294] 'agreement among raft nodes before linearized reading' (duration: 565.12177ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:05:25.887107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:25.321327Z","time spent":"565.767213ms","remote":"127.0.0.1:44846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T17:05:27.719306Z","caller":"traceutil/trace.go:171","msg":"trace[61798613] transaction","detail":"{read_only:false; response_revision:207; number_of_response:1; }","duration":"129.619935ms","start":"2026-04-13T17:05:27.589662Z","end":"2026-04-13T17:05:27.719282Z","steps":["trace[61798613] 'process raft request' (duration: 129.472232ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:05:29.277285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.309903ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-13T17:05:29.277417Z","caller":"traceutil/trace.go:171","msg":"trace[1327738767] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"295.360113ms","start":"2026-04-13T17:05:28.982036Z","end":"2026-04-13T17:05:29.277397Z","steps":["trace[1327738767] 'process raft request' (duration: 77.871157ms)","trace[1327738767] 'compare' (duration: 217.149259ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:05:34.216826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.038004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-13T17:05:34.216918Z","caller":"traceutil/trace.go:171","msg":"trace[863896629] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:328; }","duration":"266.198378ms","start":"2026-04-13T17:05:33.950695Z","end":"2026-04-13T17:05:34.216894Z","steps":["trace[863896629] 'range keys from in-memory index tree' (duration: 265.927962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:05:34.216895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.591671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-04-13T17:05:34.216983Z","caller":"traceutil/trace.go:171","msg":"trace[293299997] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:328; }","duration":"166.738764ms","start":"2026-04-13T17:05:34.050226Z","end":"2026-04-13T17:05:34.216965Z","steps":["trace[293299997] 'range keys from in-memory index tree' (duration: 166.461888ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:05:34.217104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.019172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-04-13T17:05:34.217202Z","caller":"traceutil/trace.go:171","msg":"trace[1839974108] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:328; }","duration":"116.150395ms","start":"2026-04-13T17:05:34.10103Z","end":"2026-04-13T17:05:34.217181Z","steps":["trace[1839974108] 'range keys from in-memory index tree' (duration: 115.880169ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:05:34.217074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.790274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-13T17:05:34.217255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.997774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-04-13T17:05:34.217329Z","caller":"traceutil/trace.go:171","msg":"trace[1246670783] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:328; }","duration":"217.100366ms","start":"2026-04-13T17:05:34.000209Z","end":"2026-04-13T17:05:34.217309Z","steps":["trace[1246670783] 'range keys from in-memory index tree' (duration: 216.84749ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:05:34.217554Z","caller":"traceutil/trace.go:171","msg":"trace[2117474706] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:328; }","duration":"258.114151ms","start":"2026-04-13T17:05:33.959186Z","end":"2026-04-13T17:05:34.2173Z","steps":["trace[2117474706] 'range keys from in-memory index tree' (duration: 257.690852ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:05:34.931074Z","caller":"traceutil/trace.go:171","msg":"trace[1935462225] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"112.210148ms","start":"2026-04-13T17:05:34.818836Z","end":"2026-04-13T17:05:34.931046Z","steps":["trace[1935462225] 'process raft request' (duration: 71.301122ms)","trace[1935462225] 'compare' (duration: 40.807564ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:05:34.93163Z","caller":"traceutil/trace.go:171","msg":"trace[1574203559] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"102.081127ms","start":"2026-04-13T17:05:34.829534Z","end":"2026-04-13T17:05:34.931615Z","steps":["trace[1574203559] 'process raft request' (duration: 101.939383ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:05:39.80198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.072294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:05:39.802096Z","caller":"traceutil/trace.go:171","msg":"trace[1616455737] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:401; }","duration":"146.229317ms","start":"2026-04-13T17:05:39.655842Z","end":"2026-04-13T17:05:39.802071Z","steps":["trace[1616455737] 'range keys from in-memory index tree' (duration: 145.995042ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:05:51.499943Z","caller":"traceutil/trace.go:171","msg":"trace[1189027464] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"110.24071ms","start":"2026-04-13T17:05:51.389671Z","end":"2026-04-13T17:05:51.499911Z","steps":["trace[1189027464] 'process raft request' (duration: 109.946603ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:05:53.634167Z","caller":"traceutil/trace.go:171","msg":"trace[1007391055] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"500.752278ms","start":"2026-04-13T17:05:53.133383Z","end":"2026-04-13T17:05:53.634135Z","steps":["trace[1007391055] 'process raft request' (duration: 500.496512ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:05:53.634649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:53.133327Z","time spent":"501.177498ms","remote":"127.0.0.1:44612","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-13T17:05:53.769017Z","caller":"traceutil/trace.go:171","msg":"trace[2009529582] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"627.777256ms","start":"2026-04-13T17:05:53.141222Z","end":"2026-04-13T17:05:53.768999Z","steps":["trace[2009529582] 'process raft request' (duration: 627.645003ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:05:53.769133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:53.141216Z","time spent":"627.863388ms","remote":"127.0.0.1:44612","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-13T17:05:53.769158Z","caller":"traceutil/trace.go:171","msg":"trace[254620807] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"627.970831ms","start":"2026-04-13T17:05:53.141094Z","end":"2026-04-13T17:05:53.769065Z","steps":["trace[254620807] 'process raft request' (duration: 627.661134ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:05:53.769216Z","caller":"traceutil/trace.go:171","msg":"trace[607209573] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"633.864247ms","start":"2026-04-13T17:05:53.13515Z","end":"2026-04-13T17:05:53.769014Z","steps":["trace[607209573] 'process raft request' (duration: 630.668423ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:05:53.769477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:53.135128Z","time spent":"634.257568ms","remote":"127.0.0.1:44612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T17:05:53.769466Z","caller":"traceutil/trace.go:171","msg":"trace[1943917664] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"624.437408ms","start":"2026-04-13T17:05:53.144956Z","end":"2026-04-13T17:05:53.769393Z","steps":["trace[1943917664] 'process raft request' (duration: 624.006647ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:05:53.769726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:53.144948Z","time spent":"624.706704ms","remote":"127.0.0.1:44612","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-13T17:05:53.769804Z","caller":"traceutil/trace.go:171","msg":"trace[918655855] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"624.784566ms","start":"2026-04-13T17:05:53.145004Z","end":"2026-04-13T17:05:53.769789Z","steps":["trace[918655855] 'process raft request' (duration: 624.341916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:05:53.769843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:53.141074Z","time spent":"628.205616ms","remote":"127.0.0.1:44846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T17:05:53.769875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:53.145Z","time spent":"624.841327ms","remote":"127.0.0.1:44612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T17:05:53.769883Z","caller":"traceutil/trace.go:171","msg":"trace[163093344] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"621.618762ms","start":"2026-04-13T17:05:53.148229Z","end":"2026-04-13T17:05:53.769847Z","steps":["trace[163093344] 'process raft request' (duration: 621.484109ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:05:53.769973Z","caller":"traceutil/trace.go:171","msg":"trace[1360038677] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"621.53181ms","start":"2026-04-13T17:05:53.148431Z","end":"2026-04-13T17:05:53.769963Z","steps":["trace[1360038677] 'process raft request' (duration: 621.371407ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:05:53.770016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:53.148425Z","time spent":"621.570451ms","remote":"127.0.0.1:44612","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-13T17:05:53.770092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:53.148219Z","time spent":"621.785056ms","remote":"127.0.0.1:44612","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-13T17:05:53.770127Z","caller":"traceutil/trace.go:171","msg":"trace[1578142750] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"618.719905ms","start":"2026-04-13T17:05:53.151388Z","end":"2026-04-13T17:05:53.770108Z","steps":["trace[1578142750] 'process raft request' (duration: 618.51538ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:05:53.770181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:53.151381Z","time spent":"618.774236ms","remote":"127.0.0.1:44612","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-13T17:05:53.770254Z","caller":"traceutil/trace.go:171","msg":"trace[1538156481] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"616.335869ms","start":"2026-04-13T17:05:53.1539Z","end":"2026-04-13T17:05:53.770236Z","steps":["trace[1538156481] 'process raft request' (duration: 616.092903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:05:53.770353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:53.153864Z","time spent":"616.445411ms","remote":"127.0.0.1:44612","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-13T17:05:53.770611Z","caller":"traceutil/trace.go:171","msg":"trace[1963961905] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"585.913918ms","start":"2026-04-13T17:05:53.18468Z","end":"2026-04-13T17:05:53.770594Z","steps":["trace[1963961905] 'process raft request' (duration: 585.622101ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:05:53.770367Z","caller":"traceutil/trace.go:171","msg":"trace[1943847167] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"608.965757ms","start":"2026-04-13T17:05:53.161383Z","end":"2026-04-13T17:05:53.770348Z","steps":["trace[1943847167] 'process raft request' (duration: 608.756132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:05:53.773008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:53.161368Z","time spent":"611.564558ms","remote":"127.0.0.1:44612","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-13T17:05:53.770696Z","caller":"traceutil/trace.go:171","msg":"trace[1583977257] linearizableReadLoop","detail":"{readStateIndex:524; appliedIndex:511; }","duration":"183.878556ms","start":"2026-04-13T17:05:53.58679Z","end":"2026-04-13T17:05:53.770668Z","steps":["trace[1583977257] 'read index received' (duration: 47.152281ms)","trace[1583977257] 'applied index is now lower than readState.Index' (duration: 136.725304ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:05:53.770709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:53.184656Z","time spent":"586.00911ms","remote":"127.0.0.1:44612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T17:05:53.770709Z","caller":"traceutil/trace.go:171","msg":"trace[1166843663] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"467.604794ms","start":"2026-04-13T17:05:53.303092Z","end":"2026-04-13T17:05:53.770696Z","steps":["trace[1166843663] 'process raft request' (duration: 467.489952ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:05:53.773847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:53.303065Z","time spent":"470.692237ms","remote":"127.0.0.1:44612","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-13T17:05:53.770927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.142422ms","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-13T17:05:53.774988Z","caller":"traceutil/trace.go:171","msg":"trace[1100909584] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:507; }","duration":"187.432348ms","start":"2026-04-13T17:05:53.586493Z","end":"2026-04-13T17:05:53.773925Z","steps":["trace[1100909584] 'agreement among raft nodes before linearized reading' (duration: 184.234164ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:05:53.791147Z","caller":"traceutil/trace.go:171","msg":"trace[1769339616] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"150.556356ms","start":"2026-04-13T17:05:53.64057Z","end":"2026-04-13T17:05:53.791126Z","steps":["trace[1769339616] 'process raft request' (duration: 150.134026ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:05:53.791212Z","caller":"traceutil/trace.go:171","msg":"trace[2008684841] transaction","detail":"{read_only:false; number_of_response:1; response_revision:509; }","duration":"148.98329ms","start":"2026-04-13T17:05:53.642194Z","end":"2026-04-13T17:05:53.791177Z","steps":["trace[2008684841] 'process raft request' (duration: 148.898748ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:05:53.791502Z","caller":"traceutil/trace.go:171","msg":"trace[875676902] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"149.336948ms","start":"2026-04-13T17:05:53.642145Z","end":"2026-04-13T17:05:53.791482Z","steps":["trace[875676902] 'process raft request' (duration: 148.839667ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:05:59.414686Z","caller":"traceutil/trace.go:171","msg":"trace[1677007599] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"595.933225ms","start":"2026-04-13T17:05:58.81872Z","end":"2026-04-13T17:05:59.414653Z","steps":["trace[1677007599] 'process raft request' (duration: 595.72129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:05:59.414859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:58.818706Z","time spent":"596.075358ms","remote":"127.0.0.1:44846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T17:05:59.425545Z","caller":"traceutil/trace.go:171","msg":"trace[149580038] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"523.810208ms","start":"2026-04-13T17:05:58.901705Z","end":"2026-04-13T17:05:59.425515Z","steps":["trace[149580038] 'process raft request' (duration: 523.345386ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:05:59.425735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:58.901675Z","time spent":"523.951851ms","remote":"127.0.0.1:44658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036233,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T17:06:00.036567Z","caller":"traceutil/trace.go:171","msg":"trace[63540788] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"175.268883ms","start":"2026-04-13T17:05:59.861257Z","end":"2026-04-13T17:06:00.036526Z","steps":["trace[63540788] 'process raft request' (duration: 111.009266ms)","trace[63540788] 'compare' (duration: 64.073122ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:06:00.446175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.837257ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T17:06:00.44654Z","caller":"traceutil/trace.go:171","msg":"trace[1948474046] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"491.905733ms","start":"2026-04-13T17:05:59.954598Z","end":"2026-04-13T17:06:00.446504Z","steps":["trace[1948474046] 'process raft request' (duration: 230.603675ms)","trace[1948474046] 'compare' (duration: 260.260824ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:06:00.446685Z","caller":"traceutil/trace.go:171","msg":"trace[1248271790] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"398.136724ms","start":"2026-04-13T17:06:00.048526Z","end":"2026-04-13T17:06:00.446663Z","steps":["trace[1248271790] 'read index received' (duration: 136.451107ms)","trace[1248271790] 'applied index is now lower than readState.Index' (duration: 261.683427ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:06:00.446722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:05:59.954578Z","time spent":"492.086747ms","remote":"127.0.0.1:44658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036269,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T17:06:00.446874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.341309ms","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-13T17:06:00.44694Z","caller":"traceutil/trace.go:171","msg":"trace[17343724] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:602; }","duration":"398.426261ms","start":"2026-04-13T17:06:00.048495Z","end":"2026-04-13T17:06:00.446922Z","steps":["trace[17343724] 'agreement among raft nodes before linearized reading' (duration: 398.310968ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:06:00.44699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:06:00.048482Z","time spent":"398.495002ms","remote":"127.0.0.1:44846","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-13T17:06:01.15898Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3033910505590252288,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T17:06:01.560449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.453995ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T17:06:01.560651Z","caller":"traceutil/trace.go:171","msg":"trace[71964380] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"1.107935308s","start":"2026-04-13T17:06:00.452702Z","end":"2026-04-13T17:06:01.560637Z","steps":["trace[71964380] 'process raft request' (duration: 203.230097ms)","trace[71964380] 'compare' (duration: 904.330872ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:06:01.560704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:06:00.452695Z","time spent":"1.107988979s","remote":"127.0.0.1:44846","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-13T17:06:01.560954Z","caller":"traceutil/trace.go:171","msg":"trace[1277863818] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:623; }","duration":"902.044308ms","start":"2026-04-13T17:06:00.658883Z","end":"2026-04-13T17:06:01.560928Z","steps":["trace[1277863818] 'read index received' (duration: 867.685668ms)","trace[1277863818] 'applied index is now lower than readState.Index' (duration: 34.357129ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:06:01.561151Z","caller":"traceutil/trace.go:171","msg":"trace[1365824132] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"1.051280169s","start":"2026-04-13T17:06:00.50983Z","end":"2026-04-13T17:06:01.56111Z","steps":["trace[1365824132] 'process raft request' (duration: 1.050695905s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:06:01.561328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:06:00.509786Z","time spent":"1.051403832s","remote":"127.0.0.1:44946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T17:06:01.561335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"902.446748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:06:01.56141Z","caller":"traceutil/trace.go:171","msg":"trace[1092636083] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:605; }","duration":"902.524049ms","start":"2026-04-13T17:06:00.658846Z","end":"2026-04-13T17:06:01.56137Z","steps":["trace[1092636083] 'agreement among raft nodes before linearized reading' (duration: 902.340835ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:06:01.561454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:06:00.658831Z","time spent":"902.613631ms","remote":"127.0.0.1:44576","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-13T17:06:01.597771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.439277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-13T17:06:01.59783Z","caller":"traceutil/trace.go:171","msg":"trace[406586142] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:605; }","duration":"178.541969ms","start":"2026-04-13T17:06:01.419274Z","end":"2026-04-13T17:06:01.597816Z","steps":["trace[406586142] 'agreement among raft nodes before linearized reading' (duration: 178.380675ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:06:02.100446Z","caller":"traceutil/trace.go:171","msg":"trace[1956805026] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"100.674116ms","start":"2026-04-13T17:06:01.99975Z","end":"2026-04-13T17:06:02.100424Z","steps":["trace[1956805026] 'process raft request' (duration: 100.01221ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:06:07.067084Z","caller":"traceutil/trace.go:171","msg":"trace[1057625868] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"115.336927ms","start":"2026-04-13T17:06:06.951718Z","end":"2026-04-13T17:06:07.067055Z","steps":["trace[1057625868] 'process raft request' (duration: 100.400326ms)","trace[1057625868] 'compare' (duration: 14.772277ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:06:13.103263Z","caller":"traceutil/trace.go:171","msg":"trace[1541663352] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"172.11236ms","start":"2026-04-13T17:06:12.931127Z","end":"2026-04-13T17:06:13.103239Z","steps":["trace[1541663352] 'process raft request' (duration: 171.978247ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:06:13.938035Z","caller":"traceutil/trace.go:171","msg":"trace[659828515] linearizableReadLoop","detail":"{readStateIndex:776; appliedIndex:775; }","duration":"275.451694ms","start":"2026-04-13T17:06:13.662526Z","end":"2026-04-13T17:06:13.937977Z","steps":["trace[659828515] 'read index received' (duration: 275.310801ms)","trace[659828515] 'applied index is now lower than readState.Index' (duration: 140.053µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:06:13.938087Z","caller":"traceutil/trace.go:171","msg":"trace[629956148] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"309.514228ms","start":"2026-04-13T17:06:13.628553Z","end":"2026-04-13T17:06:13.938067Z","steps":["trace[629956148] 'process raft request' (duration: 309.251782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:06:13.938257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.71629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-13T17:06:13.938299Z","caller":"traceutil/trace.go:171","msg":"trace[491089097] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:752; }","duration":"275.807333ms","start":"2026-04-13T17:06:13.662479Z","end":"2026-04-13T17:06:13.938287Z","steps":["trace[491089097] 'agreement among raft nodes before linearized reading' (duration: 275.643579ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:06:13.938682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:06:13.628522Z","time spent":"310.089441ms","remote":"127.0.0.1:44846","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-13T17:06:14.620302Z","caller":"traceutil/trace.go:171","msg":"trace[988089788] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"338.569084ms","start":"2026-04-13T17:06:14.28168Z","end":"2026-04-13T17:06:14.620249Z","steps":["trace[988089788] 'process raft request' (duration: 338.410771ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:06:14.620523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:06:14.281653Z","time spent":"338.782139ms","remote":"127.0.0.1:44846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T17:06:14.62708Z","caller":"traceutil/trace.go:171","msg":"trace[398406031] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"297.4329ms","start":"2026-04-13T17:06:14.329612Z","end":"2026-04-13T17:06:14.627045Z","steps":["trace[398406031] 'process raft request' (duration: 297.225565ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:06:14.913656Z","caller":"traceutil/trace.go:171","msg":"trace[111113086] linearizableReadLoop","detail":"{readStateIndex:780; appliedIndex:779; }","duration":"257.085007ms","start":"2026-04-13T17:06:14.656526Z","end":"2026-04-13T17:06:14.913611Z","steps":["trace[111113086] 'read index received' (duration: 255.636132ms)","trace[111113086] 'applied index is now lower than readState.Index' (duration: 1.446945ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:06:14.913789Z","caller":"traceutil/trace.go:171","msg":"trace[1819504451] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"282.550511ms","start":"2026-04-13T17:06:14.631203Z","end":"2026-04-13T17:06:14.913753Z","steps":["trace[1819504451] 'process raft request' (duration: 280.875321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:06:14.913866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.318972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:06:14.913927Z","caller":"traceutil/trace.go:171","msg":"trace[245367535] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:756; }","duration":"257.442085ms","start":"2026-04-13T17:06:14.656468Z","end":"2026-04-13T17:06:14.91391Z","steps":["trace[245367535] 'agreement among raft nodes before linearized reading' (duration: 257.315662ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:06:21.1595Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3033910505590252703,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-13T17:06:21.263848Z","caller":"traceutil/trace.go:171","msg":"trace[1592627887] linearizableReadLoop","detail":"{readStateIndex:805; appliedIndex:804; }","duration":"605.176622ms","start":"2026-04-13T17:06:20.65864Z","end":"2026-04-13T17:06:21.263817Z","steps":["trace[1592627887] 'read index received' (duration: 604.975637ms)","trace[1592627887] 'applied index is now lower than readState.Index' (duration: 199.895µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:06:21.263962Z","caller":"traceutil/trace.go:171","msg":"trace[1239368358] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"605.377526ms","start":"2026-04-13T17:06:20.658533Z","end":"2026-04-13T17:06:21.263911Z","steps":["trace[1239368358] 'process raft request' (duration: 605.111229ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:06:21.264042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.375586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:06:21.264083Z","caller":"traceutil/trace.go:171","msg":"trace[1964114278] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:780; }","duration":"605.437688ms","start":"2026-04-13T17:06:20.658633Z","end":"2026-04-13T17:06:21.264071Z","steps":["trace[1964114278] 'agreement among raft nodes before linearized reading' (duration: 605.344866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:06:21.264122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:06:20.65856Z","time spent":"605.552291ms","remote":"127.0.0.1:44576","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-13T17:06:21.264192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:06:20.658519Z","time spent":"605.569651ms","remote":"127.0.0.1:44846","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-13T17:06:21.264227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.94287ms","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-13T17:06:21.26432Z","caller":"traceutil/trace.go:171","msg":"trace[27553651] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:780; }","duration":"327.109393ms","start":"2026-04-13T17:06:20.937187Z","end":"2026-04-13T17:06:21.264296Z","steps":["trace[27553651] 'agreement among raft nodes before linearized reading' (duration: 326.816946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:06:21.264369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:06:20.937159Z","time spent":"327.201136ms","remote":"127.0.0.1:44846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-13T17:06:21.264418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.901527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-bdnvp\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-13T17:06:21.264513Z","caller":"traceutil/trace.go:171","msg":"trace[224608988] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-bdnvp; range_end:; response_count:1; response_revision:780; }","duration":"314.049231ms","start":"2026-04-13T17:06:20.950438Z","end":"2026-04-13T17:06:21.264487Z","steps":["trace[224608988] 'agreement among raft nodes before linearized reading' (duration: 313.800645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:06:21.264565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:06:20.950413Z","time spent":"314.141453ms","remote":"127.0.0.1:44758","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-bdnvp\" "} {"level":"info","ts":"2026-04-13T17:06:25.626572Z","caller":"traceutil/trace.go:171","msg":"trace[709819368] transaction","detail":"{read_only:false; response_revision:826; number_of_response:1; }","duration":"155.675012ms","start":"2026-04-13T17:06:25.470844Z","end":"2026-04-13T17:06:25.626519Z","steps":["trace[709819368] 'process raft request' (duration: 152.674867ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:06:33.458096Z","caller":"traceutil/trace.go:171","msg":"trace[728280054] linearizableReadLoop","detail":"{readStateIndex:957; appliedIndex:956; }","duration":"131.637372ms","start":"2026-04-13T17:06:33.326399Z","end":"2026-04-13T17:06:33.458037Z","steps":["trace[728280054] 'read index received' (duration: 82.622862ms)","trace[728280054] 'applied index is now lower than readState.Index' (duration: 49.01228ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:06:33.458204Z","caller":"traceutil/trace.go:171","msg":"trace[1389318098] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"138.413723ms","start":"2026-04-13T17:06:33.319705Z","end":"2026-04-13T17:06:33.458118Z","steps":["trace[1389318098] 'process raft request' (duration: 89.416483ms)","trace[1389318098] 'compare' (duration: 48.778324ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:06:33.458556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.109493ms","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-13T17:06:33.458719Z","caller":"traceutil/trace.go:171","msg":"trace[952017702] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:928; }","duration":"132.282527ms","start":"2026-04-13T17:06:33.326382Z","end":"2026-04-13T17:06:33.458664Z","steps":["trace[952017702] 'agreement among raft nodes before linearized reading' (duration: 131.862177ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:06:56.305035Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3033910505590253212,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-13T17:06:56.631249Z","caller":"traceutil/trace.go:171","msg":"trace[484589742] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"832.731339ms","start":"2026-04-13T17:06:55.798493Z","end":"2026-04-13T17:06:56.631224Z","steps":["trace[484589742] 'process raft request' (duration: 832.518083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:06:56.631416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:06:55.798484Z","time spent":"832.850252ms","remote":"127.0.0.1:44846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T17:06:56.633585Z","caller":"traceutil/trace.go:171","msg":"trace[1286887760] linearizableReadLoop","detail":"{readStateIndex:1056; appliedIndex:1053; }","duration":"829.246409ms","start":"2026-04-13T17:06:55.804304Z","end":"2026-04-13T17:06:56.63355Z","steps":["trace[1286887760] 'read index received' (duration: 826.652482ms)","trace[1286887760] 'applied index is now lower than readState.Index' (duration: 2.592237ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:06:56.633887Z","caller":"traceutil/trace.go:171","msg":"trace[532877208] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"829.467455ms","start":"2026-04-13T17:06:55.804407Z","end":"2026-04-13T17:06:56.633874Z","steps":["trace[532877208] 'process raft request' (duration: 829.012573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:06:56.633975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:06:55.804379Z","time spent":"829.535607ms","remote":"127.0.0.1:44846","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-13T17:06:56.634019Z","caller":"traceutil/trace.go:171","msg":"trace[578140379] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"829.534397ms","start":"2026-04-13T17:06:55.804448Z","end":"2026-04-13T17:06:56.633982Z","steps":["trace[578140379] 'process raft request' (duration: 829.056464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:06:56.634072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"828.626633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:06:56.634162Z","caller":"traceutil/trace.go:171","msg":"trace[1746829166] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1023; }","duration":"828.756937ms","start":"2026-04-13T17:06:55.805382Z","end":"2026-04-13T17:06:56.634139Z","steps":["trace[1746829166] 'agreement among raft nodes before linearized reading' (duration: 828.595822ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:06:56.634215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:06:55.80535Z","time spent":"828.853729ms","remote":"127.0.0.1:44584","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-13T17:06:56.634215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:06:55.804429Z","time spent":"829.68115ms","remote":"127.0.0.1:44846","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-13T17:06:56.634254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.94676ms","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-13T17:06:56.634301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.205139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-13T17:06:56.634315Z","caller":"traceutil/trace.go:171","msg":"trace[560992626] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1023; }","duration":"400.043913ms","start":"2026-04-13T17:06:56.234251Z","end":"2026-04-13T17:06:56.634295Z","steps":["trace[560992626] 'agreement among raft nodes before linearized reading' (duration: 399.841557ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:06:56.634331Z","caller":"traceutil/trace.go:171","msg":"trace[1048747639] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1023; }","duration":"509.300752ms","start":"2026-04-13T17:06:56.125021Z","end":"2026-04-13T17:06:56.634322Z","steps":["trace[1048747639] 'agreement among raft nodes before linearized reading' (duration: 509.189219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:06:56.634362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:06:56.125001Z","time spent":"509.353363ms","remote":"127.0.0.1:44846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-13T17:06:56.634369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:06:56.23423Z","time spent":"400.128335ms","remote":"127.0.0.1:44846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-13T17:06:56.634433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.361616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T17:06:56.63445Z","caller":"traceutil/trace.go:171","msg":"trace[1744131315] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1023; }","duration":"734.379136ms","start":"2026-04-13T17:06:55.900065Z","end":"2026-04-13T17:06:56.634444Z","steps":["trace[1744131315] 'agreement among raft nodes before linearized reading' (duration: 734.342825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:06:56.634466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:06:55.900001Z","time spent":"734.460149ms","remote":"127.0.0.1:44926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":16,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-04-13T17:06:56.634502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"830.190404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T17:06:56.63455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.87666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.100\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-13T17:06:56.634588Z","caller":"traceutil/trace.go:171","msg":"trace[1284721796] range","detail":"{range_begin:/registry/masterleases/199.19.213.100; range_end:; response_count:1; response_revision:1023; }","duration":"120.960782ms","start":"2026-04-13T17:06:56.513615Z","end":"2026-04-13T17:06:56.634576Z","steps":["trace[1284721796] 'agreement among raft nodes before linearized reading' (duration: 120.857739ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:06:56.63455Z","caller":"traceutil/trace.go:171","msg":"trace[2011017415] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1023; }","duration":"830.255715ms","start":"2026-04-13T17:06:55.804277Z","end":"2026-04-13T17:06:56.634533Z","steps":["trace[2011017415] 'agreement among raft nodes before linearized reading' (duration: 830.183753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:06:56.634888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:06:55.804264Z","time spent":"830.610934ms","remote":"127.0.0.1:44576","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-13T17:07:08.832502Z","caller":"traceutil/trace.go:171","msg":"trace[468024769] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"109.747351ms","start":"2026-04-13T17:07:08.722715Z","end":"2026-04-13T17:07:08.832463Z","steps":["trace[468024769] 'process raft request' (duration: 85.781932ms)","trace[468024769] 'compare' (duration: 23.62293ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:07:08.832555Z","caller":"traceutil/trace.go:171","msg":"trace[858354623] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"107.892682ms","start":"2026-04-13T17:07:08.724647Z","end":"2026-04-13T17:07:08.83254Z","steps":["trace[858354623] 'process raft request' (duration: 107.735558ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:08:47.717709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.207698ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T17:08:47.717908Z","caller":"traceutil/trace.go:171","msg":"trace[580480492] transaction","detail":"{read_only:false; response_revision:1435; number_of_response:1; }","duration":"251.995088ms","start":"2026-04-13T17:08:47.465877Z","end":"2026-04-13T17:08:47.717872Z","steps":["trace[580480492] 'process raft request' (duration: 117.522523ms)","trace[580480492] 'compare' (duration: 134.046453ms)"],"step_count":2}