{"level":"warn","ts":"2026-07-08T15:26:06.790198Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-08T15:26:06.790277Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.84: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.84:2380","--initial-cluster=instance=https://199.19.213.84:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.84:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.84:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-08T15:26:06.790333Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-08T15:26:06.79034Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.84:2380"]} {"level":"info","ts":"2026-07-08T15:26:06.790357Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-08T15:26:06.790936Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.84:2379"]} {"level":"info","ts":"2026-07-08T15:26:06.791003Z","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.84:2380"],"listen-peer-urls":["https://199.19.213.84:2380"],"advertise-client-urls":["https://199.19.213.84:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.84:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.84:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-08T15:26:06.797581Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.07525ms"} {"level":"info","ts":"2026-07-08T15:26:06.804889Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f823adf772f78a4c","cluster-id":"b5473e4c769d66"} {"level":"info","ts":"2026-07-08T15:26:06.804954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c switched to configuration voters=()"} {"level":"info","ts":"2026-07-08T15:26:06.804991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c became follower at term 0"} {"level":"info","ts":"2026-07-08T15:26:06.805Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f823adf772f78a4c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-08T15:26:06.80501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c became follower at term 1"} {"level":"info","ts":"2026-07-08T15:26:06.805049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c switched to configuration voters=(17880326223888353868)"} {"level":"warn","ts":"2026-07-08T15:26:06.813635Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-08T15:26:06.815111Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-08T15:26:06.81906Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-08T15:26:06.823791Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f823adf772f78a4c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-08T15:26:06.823907Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f823adf772f78a4c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-08T15:26:06.82422Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-08T15:26:06.824477Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-08T15:26:06.824492Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-08T15:26:06.826454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c switched to configuration voters=(17880326223888353868)"} {"level":"info","ts":"2026-07-08T15:26:06.826564Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b5473e4c769d66","local-member-id":"f823adf772f78a4c","added-peer-id":"f823adf772f78a4c","added-peer-peer-urls":["https://199.19.213.84:2380"]} {"level":"info","ts":"2026-07-08T15:26:06.828146Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-08T15:26:06.828339Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f823adf772f78a4c","initial-advertise-peer-urls":["https://199.19.213.84:2380"],"listen-peer-urls":["https://199.19.213.84:2380"],"advertise-client-urls":["https://199.19.213.84:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.84:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-08T15:26:06.828372Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-08T15:26:06.828479Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.84:2380"} {"level":"info","ts":"2026-07-08T15:26:06.828497Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.84:2380"} {"level":"info","ts":"2026-07-08T15:26:07.505176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c is starting a new election at term 1"} {"level":"info","ts":"2026-07-08T15:26:07.505248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c became pre-candidate at term 1"} {"level":"info","ts":"2026-07-08T15:26:07.505302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c received MsgPreVoteResp from f823adf772f78a4c at term 1"} {"level":"info","ts":"2026-07-08T15:26:07.505317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c became candidate at term 2"} {"level":"info","ts":"2026-07-08T15:26:07.505326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c received MsgVoteResp from f823adf772f78a4c at term 2"} {"level":"info","ts":"2026-07-08T15:26:07.50534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c became leader at term 2"} {"level":"info","ts":"2026-07-08T15:26:07.505355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f823adf772f78a4c elected leader f823adf772f78a4c at term 2"} {"level":"info","ts":"2026-07-08T15:26:07.506605Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f823adf772f78a4c","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.84:2379]}","request-path":"/0/members/f823adf772f78a4c/attributes","cluster-id":"b5473e4c769d66","publish-timeout":"7s"} {"level":"info","ts":"2026-07-08T15:26:07.506631Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T15:26:07.506664Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T15:26:07.506691Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T15:26:07.506862Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-08T15:26:07.506909Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-08T15:26:07.507833Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b5473e4c769d66","local-member-id":"f823adf772f78a4c","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T15:26:07.507959Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T15:26:07.507997Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T15:26:07.510679Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.84:2379"} {"level":"info","ts":"2026-07-08T15:26:07.510281Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-08T15:26:10.623864Z","caller":"traceutil/trace.go:171","msg":"trace[1309112582] transaction","detail":"{read_only:false; response_revision:234; number_of_response:1; }","duration":"142.555901ms","start":"2026-07-08T15:26:10.48128Z","end":"2026-07-08T15:26:10.623836Z","steps":["trace[1309112582] 'process raft request' (duration: 97.192551ms)","trace[1309112582] 'compare' (duration: 45.222748ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:26:13.43587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.94386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-07-08T15:26:13.43605Z","caller":"traceutil/trace.go:171","msg":"trace[1643731196] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:311; }","duration":"115.175633ms","start":"2026-07-08T15:26:13.320848Z","end":"2026-07-08T15:26:13.436024Z","steps":["trace[1643731196] 'range keys from in-memory index tree' (duration: 114.752747ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:13.656095Z","caller":"traceutil/trace.go:171","msg":"trace[17035883] transaction","detail":"{read_only:false; number_of_response:0; response_revision:311; }","duration":"328.702327ms","start":"2026-07-08T15:26:13.327366Z","end":"2026-07-08T15:26:13.656068Z","steps":["trace[17035883] 'process raft request' (duration: 328.609856ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:13.656691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:13.32735Z","time spent":"328.835048ms","remote":"127.0.0.1:32768","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:26:13.924265Z","caller":"traceutil/trace.go:171","msg":"trace[1194364317] linearizableReadLoop","detail":"{readStateIndex:321; appliedIndex:320; }","duration":"596.362653ms","start":"2026-07-08T15:26:13.327877Z","end":"2026-07-08T15:26:13.92424Z","steps":["trace[1194364317] 'read index received' (duration: 328.20076ms)","trace[1194364317] 'applied index is now lower than readState.Index' (duration: 268.160873ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:26:13.924379Z","caller":"traceutil/trace.go:171","msg":"trace[1505733368] transaction","detail":"{read_only:false; number_of_response:0; response_revision:311; }","duration":"596.524775ms","start":"2026-07-08T15:26:13.327846Z","end":"2026-07-08T15:26:13.92437Z","steps":["trace[1505733368] 'process raft request' (duration: 596.222711ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:13.924459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:13.327824Z","time spent":"596.580485ms","remote":"127.0.0.1:32768","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:26:13.924686Z","caller":"traceutil/trace.go:171","msg":"trace[1512960237] transaction","detail":"{read_only:false; number_of_response:0; response_revision:311; }","duration":"596.266652ms","start":"2026-07-08T15:26:13.32841Z","end":"2026-07-08T15:26:13.924677Z","steps":["trace[1512960237] 'process raft request' (duration: 595.739465ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:13.92473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:13.328402Z","time spent":"596.306103ms","remote":"127.0.0.1:32768","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:26:13.924905Z","caller":"traceutil/trace.go:171","msg":"trace[637173982] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"484.489512ms","start":"2026-07-08T15:26:13.440405Z","end":"2026-07-08T15:26:13.924895Z","steps":["trace[637173982] 'process raft request' (duration: 483.768094ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:13.924948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:13.440378Z","time spent":"484.549103ms","remote":"127.0.0.1:32792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:26:13.925129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.244594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3974"} {"level":"info","ts":"2026-07-08T15:26:13.92516Z","caller":"traceutil/trace.go:171","msg":"trace[1087951343] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:312; }","duration":"597.295444ms","start":"2026-07-08T15:26:13.327855Z","end":"2026-07-08T15:26:13.925151Z","steps":["trace[1087951343] 'agreement among raft nodes before linearized reading' (duration: 597.222183ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:13.925186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:13.327844Z","time spent":"597.336305ms","remote":"127.0.0.1:32768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":3996,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"warn","ts":"2026-07-08T15:26:13.925312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.689347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5892"} {"level":"info","ts":"2026-07-08T15:26:13.925338Z","caller":"traceutil/trace.go:171","msg":"trace[203826413] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:312; }","duration":"267.748357ms","start":"2026-07-08T15:26:13.657581Z","end":"2026-07-08T15:26:13.92533Z","steps":["trace[203826413] 'agreement among raft nodes before linearized reading' (duration: 267.704027ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:14.894436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.861768ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T15:26:14.894554Z","caller":"traceutil/trace.go:171","msg":"trace[1375689036] linearizableReadLoop","detail":"{readStateIndex:325; appliedIndex:324; }","duration":"929.50638ms","start":"2026-07-08T15:26:13.965028Z","end":"2026-07-08T15:26:14.894535Z","steps":["trace[1375689036] 'read index received' (duration: 335.838781ms)","trace[1375689036] 'applied index is now lower than readState.Index' (duration: 593.666139ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:26:14.894643Z","caller":"traceutil/trace.go:171","msg":"trace[1127214869] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"948.356378ms","start":"2026-07-08T15:26:13.94625Z","end":"2026-07-08T15:26:14.894607Z","steps":["trace[1127214869] 'process raft request' (duration: 354.754411ms)","trace[1127214869] 'compare' (duration: 592.721646ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:26:14.894747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"929.765783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T15:26:14.894775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.634274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-08T15:26:14.894813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:13.946232Z","time spent":"948.4933ms","remote":"127.0.0.1:32768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5311,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:26:14.89482Z","caller":"traceutil/trace.go:171","msg":"trace[1284308465] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:0; response_revision:314; }","duration":"929.884615ms","start":"2026-07-08T15:26:13.964911Z","end":"2026-07-08T15:26:14.894796Z","steps":["trace[1284308465] 'agreement among raft nodes before linearized reading' (duration: 929.781873ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:14.894891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:13.964891Z","time spent":"929.986906ms","remote":"127.0.0.1:32792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"info","ts":"2026-07-08T15:26:14.894819Z","caller":"traceutil/trace.go:171","msg":"trace[1479923911] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:314; }","duration":"123.713105ms","start":"2026-07-08T15:26:14.771094Z","end":"2026-07-08T15:26:14.894807Z","steps":["trace[1479923911] 'agreement among raft nodes before linearized reading' (duration: 123.633084ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:15.520842Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9965515182725257169,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T15:26:16.35117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"808.427727ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T15:26:16.351308Z","caller":"traceutil/trace.go:171","msg":"trace[1539203082] linearizableReadLoop","detail":"{readStateIndex:328; appliedIndex:325; }","duration":"1.331115119s","start":"2026-07-08T15:26:15.020184Z","end":"2026-07-08T15:26:16.351299Z","steps":["trace[1539203082] 'read index received' (duration: 522.545879ms)","trace[1539203082] 'applied index is now lower than readState.Index' (duration: 808.56873ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:26:16.351358Z","caller":"traceutil/trace.go:171","msg":"trace[1648273007] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"1.446609887s","start":"2026-07-08T15:26:14.904743Z","end":"2026-07-08T15:26:16.351353Z","steps":["trace[1648273007] 'process raft request' (duration: 1.446522446s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:16.351389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:14.904733Z","time spent":"1.446640878s","remote":"127.0.0.1:32768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7279,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T15:26:16.351477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.331306631s","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-07-08T15:26:16.351524Z","caller":"traceutil/trace.go:171","msg":"trace[852348231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:317; }","duration":"1.331391272s","start":"2026-07-08T15:26:15.020121Z","end":"2026-07-08T15:26:16.351513Z","steps":["trace[852348231] 'agreement among raft nodes before linearized reading' (duration: 1.331311581s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:16.351562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:15.020101Z","time spent":"1.331452573s","remote":"127.0.0.1:32882","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-07-08T15:26:16.351603Z","caller":"traceutil/trace.go:171","msg":"trace[1958993659] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"1.451671971s","start":"2026-07-08T15:26:14.899859Z","end":"2026-07-08T15:26:16.351531Z","steps":["trace[1958993659] 'process raft request' (duration: 642.832689ms)","trace[1958993659] 'compare' (duration: 808.353547ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:26:16.351751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.116065348s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-08T15:26:16.351775Z","caller":"traceutil/trace.go:171","msg":"trace[1972144949] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:317; }","duration":"1.116121668s","start":"2026-07-08T15:26:15.235648Z","end":"2026-07-08T15:26:16.351769Z","steps":["trace[1972144949] 'agreement among raft nodes before linearized reading' (duration: 1.116070828s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:16.351789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:15.235622Z","time spent":"1.116163838s","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T15:26:16.35179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:14.899833Z","time spent":"1.451861574s","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T15:26:16.351856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.214754562s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-08T15:26:16.351982Z","caller":"traceutil/trace.go:171","msg":"trace[793250269] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:317; }","duration":"1.214894934s","start":"2026-07-08T15:26:15.137041Z","end":"2026-07-08T15:26:16.351936Z","steps":["trace[793250269] 'agreement among raft nodes before linearized reading' (duration: 1.21467326s)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:16.351969Z","caller":"traceutil/trace.go:171","msg":"trace[2135088309] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"1.449668237s","start":"2026-07-08T15:26:14.902272Z","end":"2026-07-08T15:26:16.351941Z","steps":["trace[2135088309] 'process raft request' (duration: 1.448962138s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:16.352072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:15.137018Z","time spent":"1.215009325s","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-08T15:26:16.352228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:14.90222Z","time spent":"1.44995407s","remote":"127.0.0.1:32792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":182,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:26:17.202802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.972957ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T15:26:17.203025Z","caller":"traceutil/trace.go:171","msg":"trace[1371518980] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"847.460602ms","start":"2026-07-08T15:26:16.355524Z","end":"2026-07-08T15:26:17.202985Z","steps":["trace[1371518980] 'process raft request' (duration: 397.216861ms)","trace[1371518980] 'compare' (duration: 449.842096ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:26:17.203118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:16.355507Z","time spent":"847.565893ms","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:26:17.203302Z","caller":"traceutil/trace.go:171","msg":"trace[1927618159] linearizableReadLoop","detail":"{readStateIndex:331; appliedIndex:328; }","duration":"845.223334ms","start":"2026-07-08T15:26:16.358063Z","end":"2026-07-08T15:26:17.203287Z","steps":["trace[1927618159] 'read index received' (duration: 394.660459ms)","trace[1927618159] 'applied index is now lower than readState.Index' (duration: 450.561795ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:26:17.203425Z","caller":"traceutil/trace.go:171","msg":"trace[2112004377] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"843.702286ms","start":"2026-07-08T15:26:16.359712Z","end":"2026-07-08T15:26:17.203415Z","steps":["trace[2112004377] 'process raft request' (duration: 843.32905ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:17.203493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:16.359695Z","time spent":"843.765566ms","remote":"127.0.0.1:32768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6946,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T15:26:17.203675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"686.462975ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T15:26:17.203658Z","caller":"traceutil/trace.go:171","msg":"trace[375787088] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"847.226889ms","start":"2026-07-08T15:26:16.35639Z","end":"2026-07-08T15:26:17.203617Z","steps":["trace[375787088] 'process raft request' (duration: 846.56474ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:17.203754Z","caller":"traceutil/trace.go:171","msg":"trace[1718882264] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:321; }","duration":"686.542686ms","start":"2026-07-08T15:26:16.517199Z","end":"2026-07-08T15:26:17.203742Z","steps":["trace[1718882264] 'agreement among raft nodes before linearized reading' (duration: 686.448765ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:17.203754Z","caller":"traceutil/trace.go:171","msg":"trace[993951139] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"847.37113ms","start":"2026-07-08T15:26:16.356361Z","end":"2026-07-08T15:26:17.203732Z","steps":["trace[993951139] 'process raft request' (duration: 846.5435ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:17.203795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"845.692999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"warn","ts":"2026-07-08T15:26:17.203835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:16.356343Z","time spent":"847.442391ms","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:26:17.203867Z","caller":"traceutil/trace.go:171","msg":"trace[668063562] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:321; }","duration":"845.805591ms","start":"2026-07-08T15:26:16.358037Z","end":"2026-07-08T15:26:17.203843Z","steps":["trace[668063562] 'agreement among raft nodes before linearized reading' (duration: 845.670679ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:17.203871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:16.356376Z","time spent":"847.395721ms","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T15:26:17.203901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:16.358028Z","time spent":"845.864992ms","remote":"127.0.0.1:60944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-07-08T15:26:19.321048Z","caller":"traceutil/trace.go:171","msg":"trace[1316097972] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"110.630802ms","start":"2026-07-08T15:26:19.210379Z","end":"2026-07-08T15:26:19.32101Z","steps":["trace[1316097972] 'process raft request' (duration: 110.45579ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:19.564402Z","caller":"traceutil/trace.go:171","msg":"trace[1487678739] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"353.058338ms","start":"2026-07-08T15:26:19.211299Z","end":"2026-07-08T15:26:19.564357Z","steps":["trace[1487678739] 'process raft request' (duration: 296.240928ms)","trace[1487678739] 'compare' (duration: 56.583247ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:26:19.564689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:19.211284Z","time spent":"353.309692ms","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:26:19.564895Z","caller":"traceutil/trace.go:171","msg":"trace[536845349] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"353.549734ms","start":"2026-07-08T15:26:19.211325Z","end":"2026-07-08T15:26:19.564875Z","steps":["trace[536845349] 'process raft request' (duration: 352.965117ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:19.565012Z","caller":"traceutil/trace.go:171","msg":"trace[1901481577] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"159.744788ms","start":"2026-07-08T15:26:19.405133Z","end":"2026-07-08T15:26:19.564877Z","steps":["trace[1901481577] 'process raft request' (duration: 159.536375ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:19.565222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:19.211311Z","time spent":"353.730306ms","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T15:26:46.182871Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9965515182725257583,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-08T15:26:46.415114Z","caller":"traceutil/trace.go:171","msg":"trace[404688941] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"881.71642ms","start":"2026-07-08T15:26:45.533373Z","end":"2026-07-08T15:26:46.415089Z","steps":["trace[404688941] 'process raft request' (duration: 881.622309ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:46.415227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:45.533353Z","time spent":"881.821621ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:26:46.571962Z","caller":"traceutil/trace.go:171","msg":"trace[2129142749] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"1.034593555s","start":"2026-07-08T15:26:45.537334Z","end":"2026-07-08T15:26:46.571928Z","steps":["trace[2129142749] 'process raft request' (duration: 1.026378832s)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:46.57208Z","caller":"traceutil/trace.go:171","msg":"trace[169167200] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"1.026968518s","start":"2026-07-08T15:26:45.545099Z","end":"2026-07-08T15:26:46.572067Z","steps":["trace[169167200] 'process raft request' (duration: 1.026824416s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:46.572173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:45.537315Z","time spent":"1.034773717s","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:26:46.57222Z","caller":"traceutil/trace.go:171","msg":"trace[1746426358] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"1.024088846s","start":"2026-07-08T15:26:45.548098Z","end":"2026-07-08T15:26:46.572187Z","steps":["trace[1746426358] 'process raft request' (duration: 1.023852943s)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:46.572232Z","caller":"traceutil/trace.go:171","msg":"trace[92289083] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"1.028373265s","start":"2026-07-08T15:26:45.543822Z","end":"2026-07-08T15:26:46.572195Z","steps":["trace[92289083] 'process raft request' (duration: 1.028059841s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:46.572247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:45.545092Z","time spent":"1.027035799s","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:26:46.572329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:45.543782Z","time spent":"1.028503586s","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:26:46.572015Z","caller":"traceutil/trace.go:171","msg":"trace[290995654] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"1.03158816s","start":"2026-07-08T15:26:45.540403Z","end":"2026-07-08T15:26:46.571991Z","steps":["trace[290995654] 'process raft request' (duration: 1.031418518s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:46.572344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:45.548091Z","time spent":"1.024192687s","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:26:46.572417Z","caller":"traceutil/trace.go:171","msg":"trace[509993103] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"1.022358197s","start":"2026-07-08T15:26:45.550054Z","end":"2026-07-08T15:26:46.572412Z","steps":["trace[509993103] 'process raft request' (duration: 1.021954761s)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:46.572439Z","caller":"traceutil/trace.go:171","msg":"trace[87436048] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"1.010373742s","start":"2026-07-08T15:26:45.562059Z","end":"2026-07-08T15:26:46.572433Z","steps":["trace[87436048] 'process raft request' (duration: 1.009988377s)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:46.57258Z","caller":"traceutil/trace.go:171","msg":"trace[781363060] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"991.322736ms","start":"2026-07-08T15:26:45.581219Z","end":"2026-07-08T15:26:46.572542Z","steps":["trace[781363060] 'process raft request' (duration: 991.149754ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:46.573184Z","caller":"traceutil/trace.go:171","msg":"trace[1285188232] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"994.987817ms","start":"2026-07-08T15:26:45.577465Z","end":"2026-07-08T15:26:46.572453Z","steps":["trace[1285188232] 'process raft request' (duration: 994.630232ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:46.573482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:45.581193Z","time spent":"992.242925ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:26:46.573941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:45.540386Z","time spent":"1.032030816s","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:26:46.573384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:45.562051Z","time spent":"1.011234611s","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:26:46.574561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:45.550047Z","time spent":"1.022384608s","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:26:46.574714Z","caller":"traceutil/trace.go:171","msg":"trace[1909552793] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"970.659363ms","start":"2026-07-08T15:26:45.604016Z","end":"2026-07-08T15:26:46.574675Z","steps":["trace[1909552793] 'process raft request' (duration: 969.013124ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:46.574903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:45.603992Z","time spent":"970.853174ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:26:46.575068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:45.577446Z","time spent":"996.033389ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:26:46.575504Z","caller":"traceutil/trace.go:171","msg":"trace[1608745312] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"864.789836ms","start":"2026-07-08T15:26:45.710683Z","end":"2026-07-08T15:26:46.575473Z","steps":["trace[1608745312] 'process raft request' (duration: 863.191258ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:46.57562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:45.710665Z","time spent":"864.908897ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:26:46.71003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.347046ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-07-08T15:26:46.710379Z","caller":"traceutil/trace.go:171","msg":"trace[1749373470] linearizableReadLoop","detail":"{readStateIndex:551; appliedIndex:538; }","duration":"1.02847395s","start":"2026-07-08T15:26:45.681849Z","end":"2026-07-08T15:26:46.710323Z","steps":["trace[1749373470] 'read index received' (duration: 733.212602ms)","trace[1749373470] 'applied index is now lower than readState.Index' (duration: 295.256738ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:26:46.710575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.028714962s","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-07-08T15:26:46.710612Z","caller":"traceutil/trace.go:171","msg":"trace[1687491515] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:536; }","duration":"1.028802264s","start":"2026-07-08T15:26:45.681799Z","end":"2026-07-08T15:26:46.710602Z","steps":["trace[1687491515] 'agreement among raft nodes before linearized reading' (duration: 1.028682833s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:46.710639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:45.681777Z","time spent":"1.028856034s","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-08T15:26:46.710652Z","caller":"traceutil/trace.go:171","msg":"trace[1919961435] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"290.908458ms","start":"2026-07-08T15:26:46.419734Z","end":"2026-07-08T15:26:46.710643Z","steps":["trace[1919961435] 'process raft request' (duration: 290.476384ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:46.710586Z","caller":"traceutil/trace.go:171","msg":"trace[1421329243] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"289.418902ms","start":"2026-07-08T15:26:46.421148Z","end":"2026-07-08T15:26:46.710567Z","steps":["trace[1421329243] 'process raft request' (duration: 289.196789ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:46.710762Z","caller":"traceutil/trace.go:171","msg":"trace[805501321] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"117.088769ms","start":"2026-07-08T15:26:46.593655Z","end":"2026-07-08T15:26:46.710744Z","steps":["trace[805501321] 'process raft request' (duration: 117.019538ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:46.710856Z","caller":"traceutil/trace.go:171","msg":"trace[1841738641] transaction","detail":"{read_only:false; number_of_response:1; response_revision:535; }","duration":"289.171ms","start":"2026-07-08T15:26:46.421674Z","end":"2026-07-08T15:26:46.710845Z","steps":["trace[1841738641] 'process raft request' (duration: 288.726944ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:46.711488Z","caller":"traceutil/trace.go:171","msg":"trace[1820676561] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"114.974565ms","start":"2026-07-08T15:26:46.596493Z","end":"2026-07-08T15:26:46.711468Z","steps":["trace[1820676561] 'process raft request' (duration: 114.584511ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:46.71092Z","caller":"traceutil/trace.go:171","msg":"trace[1736547490] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"117.219321ms","start":"2026-07-08T15:26:46.59369Z","end":"2026-07-08T15:26:46.710909Z","steps":["trace[1736547490] 'process raft request' (duration: 117.022578ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:46.711003Z","caller":"traceutil/trace.go:171","msg":"trace[1064730167] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"120.745891ms","start":"2026-07-08T15:26:46.59025Z","end":"2026-07-08T15:26:46.710996Z","steps":["trace[1064730167] 'process raft request' (duration: 120.366006ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:46.710997Z","caller":"traceutil/trace.go:171","msg":"trace[1201929852] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"129.941834ms","start":"2026-07-08T15:26:46.581043Z","end":"2026-07-08T15:26:46.710985Z","steps":["trace[1201929852] 'process raft request' (duration: 129.394267ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:46.711022Z","caller":"traceutil/trace.go:171","msg":"trace[638214236] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"122.685242ms","start":"2026-07-08T15:26:46.588333Z","end":"2026-07-08T15:26:46.711018Z","steps":["trace[638214236] 'process raft request' (duration: 122.139976ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:46.711122Z","caller":"traceutil/trace.go:171","msg":"trace[1494941127] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"115.498863ms","start":"2026-07-08T15:26:46.595618Z","end":"2026-07-08T15:26:46.711117Z","steps":["trace[1494941127] 'process raft request' (duration: 115.23495ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:46.711983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.025590648s","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-07-08T15:26:46.712019Z","caller":"traceutil/trace.go:171","msg":"trace[952186242] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:544; }","duration":"1.025647148s","start":"2026-07-08T15:26:45.686364Z","end":"2026-07-08T15:26:46.712011Z","steps":["trace[952186242] 'agreement among raft nodes before linearized reading' (duration: 1.025560327s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:46.712039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:45.686354Z","time spent":"1.025680988s","remote":"127.0.0.1:32882","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-07-08T15:26:46.712141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"826.183584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T15:26:46.71212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.654438ms","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-07-08T15:26:46.712165Z","caller":"traceutil/trace.go:171","msg":"trace[1278625230] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:544; }","duration":"826.235056ms","start":"2026-07-08T15:26:45.885924Z","end":"2026-07-08T15:26:46.712159Z","steps":["trace[1278625230] 'agreement among raft nodes before linearized reading' (duration: 826.198354ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:46.712182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:45.885901Z","time spent":"826.277887ms","remote":"127.0.0.1:60828","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-07-08T15:26:46.712196Z","caller":"traceutil/trace.go:171","msg":"trace[2043982726] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:544; }","duration":"158.777381ms","start":"2026-07-08T15:26:46.553399Z","end":"2026-07-08T15:26:46.712176Z","steps":["trace[2043982726] 'agreement among raft nodes before linearized reading' (duration: 158.614358ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:46.712328Z","caller":"traceutil/trace.go:171","msg":"trace[1619403085] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"115.392011ms","start":"2026-07-08T15:26:46.596927Z","end":"2026-07-08T15:26:46.712319Z","steps":["trace[1619403085] 'process raft request' (duration: 114.41655ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:52.114122Z","caller":"traceutil/trace.go:171","msg":"trace[1889467064] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"160.524593ms","start":"2026-07-08T15:26:51.953568Z","end":"2026-07-08T15:26:52.114093Z","steps":["trace[1889467064] 'process raft request' (duration: 160.180348ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:53.236677Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9965515182725257813,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T15:26:53.736959Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9965515182725257813,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T15:26:54.122741Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.519855834s","expected-duration":"1s"} {"level":"info","ts":"2026-07-08T15:26:54.160544Z","caller":"traceutil/trace.go:171","msg":"trace[844504621] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:635; }","duration":"1.424700107s","start":"2026-07-08T15:26:52.735738Z","end":"2026-07-08T15:26:54.160438Z","steps":["trace[844504621] 'read index received' (duration: 1.387248214s)","trace[844504621] 'applied index is now lower than readState.Index' (duration: 37.450813ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:26:54.16075Z","caller":"traceutil/trace.go:171","msg":"trace[854393245] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"1.062840477s","start":"2026-07-08T15:26:53.097892Z","end":"2026-07-08T15:26:54.160732Z","steps":["trace[854393245] 'process raft request' (duration: 1.062461803s)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:54.160896Z","caller":"traceutil/trace.go:171","msg":"trace[1606599428] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"1.559148919s","start":"2026-07-08T15:26:52.601719Z","end":"2026-07-08T15:26:54.160868Z","steps":["trace[1606599428] 'process raft request' (duration: 1.521920468s)","trace[1606599428] 'compare' (duration: 35.789215ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:26:54.160924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:53.097862Z","time spent":"1.062972579s","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T15:26:54.161083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.27525383s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T15:26:54.161086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.686461ms","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-07-08T15:26:54.161138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.390218366s","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-07-08T15:26:54.161158Z","caller":"traceutil/trace.go:171","msg":"trace[751645545] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"1.275371212s","start":"2026-07-08T15:26:52.885761Z","end":"2026-07-08T15:26:54.161133Z","steps":["trace[751645545] 'agreement among raft nodes before linearized reading' (duration: 1.275263171s)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:54.161167Z","caller":"traceutil/trace.go:171","msg":"trace[1507688421] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:616; }","duration":"692.799573ms","start":"2026-07-08T15:26:53.468344Z","end":"2026-07-08T15:26:54.161144Z","steps":["trace[1507688421] 'agreement among raft nodes before linearized reading' (duration: 692.56788ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:54.161193Z","caller":"traceutil/trace.go:171","msg":"trace[2096039992] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:616; }","duration":"1.390294296s","start":"2026-07-08T15:26:52.770883Z","end":"2026-07-08T15:26:54.161177Z","steps":["trace[2096039992] 'agreement among raft nodes before linearized reading' (duration: 1.390163505s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:54.161036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.393706165s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-08T15:26:54.161207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:52.885741Z","time spent":"1.275453862s","remote":"127.0.0.1:60828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-08T15:26:54.161208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:53.468329Z","time spent":"692.869933ms","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-08T15:26:54.161233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:52.770868Z","time spent":"1.390356397s","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-08T15:26:54.161193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.425416526s","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-07-08T15:26:54.16126Z","caller":"traceutil/trace.go:171","msg":"trace[893990068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:616; }","duration":"1.394029048s","start":"2026-07-08T15:26:52.767209Z","end":"2026-07-08T15:26:54.161238Z","steps":["trace[893990068] 'agreement among raft nodes before linearized reading' (duration: 1.393571832s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:54.161311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:52.767189Z","time spent":"1.394108138s","remote":"127.0.0.1:32882","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-07-08T15:26:54.161309Z","caller":"traceutil/trace.go:171","msg":"trace[1883395868] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:616; }","duration":"1.425590807s","start":"2026-07-08T15:26:52.735694Z","end":"2026-07-08T15:26:54.161285Z","steps":["trace[1883395868] 'agreement among raft nodes before linearized reading' (duration: 1.425266304s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:54.161398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:52.735676Z","time spent":"1.425710348s","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T15:26:54.162681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:52.601694Z","time spent":"1.559268781s","remote":"127.0.0.1:60926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036109,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T15:26:54.890318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.216288ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T15:26:54.890538Z","caller":"traceutil/trace.go:171","msg":"trace[1736052973] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"720.27423ms","start":"2026-07-08T15:26:54.170247Z","end":"2026-07-08T15:26:54.890522Z","steps":["trace[1736052973] 'process raft request' (duration: 720.22993ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:54.8906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:54.170242Z","time spent":"720.327911ms","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:26:54.890711Z","caller":"traceutil/trace.go:171","msg":"trace[1432655546] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"720.506423ms","start":"2026-07-08T15:26:54.170176Z","end":"2026-07-08T15:26:54.890682Z","steps":["trace[1432655546] 'process raft request' (duration: 354.852669ms)","trace[1432655546] 'compare' (duration: 365.096397ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:26:54.889963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.119975ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T15:26:54.89078Z","caller":"traceutil/trace.go:171","msg":"trace[1128267089] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"720.557903ms","start":"2026-07-08T15:26:54.170211Z","end":"2026-07-08T15:26:54.890769Z","steps":["trace[1128267089] 'process raft request' (duration: 720.213999ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:54.890832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:54.170207Z","time spent":"720.599043ms","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T15:26:54.890848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:54.17017Z","time spent":"720.601684ms","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:26:54.892796Z","caller":"traceutil/trace.go:171","msg":"trace[1485381930] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:617; }","duration":"556.968187ms","start":"2026-07-08T15:26:54.335796Z","end":"2026-07-08T15:26:54.892764Z","steps":["trace[1485381930] 'range keys from in-memory index tree' (duration: 554.099545ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:54.899051Z","caller":"traceutil/trace.go:171","msg":"trace[1549588900] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"665.575856ms","start":"2026-07-08T15:26:54.233458Z","end":"2026-07-08T15:26:54.899034Z","steps":["trace[1549588900] 'process raft request' (duration: 665.482025ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:54.899148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:54.233439Z","time spent":"665.659447ms","remote":"127.0.0.1:32792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:26:55.927709Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9965515182725257831,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-08T15:26:56.266486Z","caller":"traceutil/trace.go:171","msg":"trace[504854834] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"932.008145ms","start":"2026-07-08T15:26:55.334454Z","end":"2026-07-08T15:26:56.266462Z","steps":["trace[504854834] 'process raft request' (duration: 931.350098ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:56.266632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:55.334426Z","time spent":"932.130107ms","remote":"127.0.0.1:60926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036161,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T15:26:57.811158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"996.163519ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-07-08T15:26:57.81137Z","caller":"traceutil/trace.go:171","msg":"trace[934963049] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"1.491038995s","start":"2026-07-08T15:26:56.320315Z","end":"2026-07-08T15:26:57.811354Z","steps":["trace[934963049] 'process raft request' (duration: 1.490940874s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:57.811464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:56.320288Z","time spent":"1.491117505s","remote":"127.0.0.1:32936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:26:57.811714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.384684526s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-p4st9\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-07-08T15:26:57.811786Z","caller":"traceutil/trace.go:171","msg":"trace[114055705] range","detail":"{range_begin:/registry/pods/kube-system/cilium-p4st9; range_end:; response_count:1; response_revision:626; }","duration":"2.384786537s","start":"2026-07-08T15:26:55.426979Z","end":"2026-07-08T15:26:57.811766Z","steps":["trace[114055705] 'agreement among raft nodes before linearized reading' (duration: 2.384574415s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:57.811838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:55.426961Z","time spent":"2.384866188s","remote":"127.0.0.1:32768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-p4st9\" "} {"level":"info","ts":"2026-07-08T15:26:57.811949Z","caller":"traceutil/trace.go:171","msg":"trace[962081097] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:645; }","duration":"2.384359653s","start":"2026-07-08T15:26:55.427011Z","end":"2026-07-08T15:26:57.811371Z","steps":["trace[962081097] 'read index received' (duration: 838.682788ms)","trace[962081097] 'applied index is now lower than readState.Index' (duration: 1.545673035s)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:26:57.812533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.927873236s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T15:26:57.812577Z","caller":"traceutil/trace.go:171","msg":"trace[317544827] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:626; }","duration":"1.927963887s","start":"2026-07-08T15:26:55.884599Z","end":"2026-07-08T15:26:57.812563Z","steps":["trace[317544827] 'agreement among raft nodes before linearized reading' (duration: 1.927865506s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:57.812641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"916.849338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-08T15:26:57.8127Z","caller":"traceutil/trace.go:171","msg":"trace[1804174062] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:626; }","duration":"916.964619ms","start":"2026-07-08T15:26:56.895722Z","end":"2026-07-08T15:26:57.812687Z","steps":["trace[1804174062] 'agreement among raft nodes before linearized reading' (duration: 916.774027ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:57.812733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:56.895699Z","time spent":"917.02602ms","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-08T15:26:57.812787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"917.112661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-08T15:26:57.812655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:55.884582Z","time spent":"1.928023187s","remote":"127.0.0.1:60842","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-07-08T15:26:57.812839Z","caller":"traceutil/trace.go:171","msg":"trace[1585540318] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:626; }","duration":"917.206722ms","start":"2026-07-08T15:26:56.895617Z","end":"2026-07-08T15:26:57.812824Z","steps":["trace[1585540318] 'agreement among raft nodes before linearized reading' (duration: 917.05709ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:57.812885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:56.895595Z","time spent":"917.278532ms","remote":"127.0.0.1:32882","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-07-08T15:26:57.813165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"917.02794ms","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-07-08T15:26:57.813222Z","caller":"traceutil/trace.go:171","msg":"trace[1948277697] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:626; }","duration":"917.128431ms","start":"2026-07-08T15:26:56.896078Z","end":"2026-07-08T15:26:57.813206Z","steps":["trace[1948277697] 'agreement among raft nodes before linearized reading' (duration: 916.624965ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:57.813272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:56.896065Z","time spent":"917.193001ms","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T15:26:57.813417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.604266727s","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-07-08T15:26:57.813472Z","caller":"traceutil/trace.go:171","msg":"trace[2068976009] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:626; }","duration":"1.604358209s","start":"2026-07-08T15:26:56.209101Z","end":"2026-07-08T15:26:57.813459Z","steps":["trace[2068976009] 'agreement among raft nodes before linearized reading' (duration: 1.603578911s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:26:57.813536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:26:56.209085Z","time spent":"1.60443871s","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-08T15:26:59.887408Z","caller":"traceutil/trace.go:171","msg":"trace[451182400] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"293.221778ms","start":"2026-07-08T15:26:59.594165Z","end":"2026-07-08T15:26:59.887387Z","steps":["trace[451182400] 'process raft request' (duration: 293.103786ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:26:59.902402Z","caller":"traceutil/trace.go:171","msg":"trace[175656268] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"109.429653ms","start":"2026-07-08T15:26:59.792498Z","end":"2026-07-08T15:26:59.901928Z","steps":["trace[175656268] 'process raft request' (duration: 109.229861ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:27:02.770618Z","caller":"traceutil/trace.go:171","msg":"trace[2122290591] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"173.329518ms","start":"2026-07-08T15:27:02.597268Z","end":"2026-07-08T15:27:02.770597Z","steps":["trace[2122290591] 'process raft request' (duration: 173.221297ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:27:14.386476Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9965515182725258166,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T15:27:14.423695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.050206659s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-08T15:27:14.423877Z","caller":"traceutil/trace.go:171","msg":"trace[788189781] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:798; }","duration":"1.050437831s","start":"2026-07-08T15:27:13.373418Z","end":"2026-07-08T15:27:14.423856Z","steps":["trace[788189781] 'count revisions from in-memory index tree' (duration: 1.050098007s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:27:14.423973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:27:13.3734Z","time spent":"1.050553143s","remote":"127.0.0.1:33024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-07-08T15:27:14.423766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.049856736s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T15:27:14.424397Z","caller":"traceutil/trace.go:171","msg":"trace[690975196] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:798; }","duration":"1.050523792s","start":"2026-07-08T15:27:13.373855Z","end":"2026-07-08T15:27:14.424378Z","steps":["trace[690975196] 'range keys from in-memory index tree' (duration: 1.049765375s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:27:14.424476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:27:13.373835Z","time spent":"1.050619073s","remote":"127.0.0.1:60828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-08T15:27:14.425587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"963.512021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-08T15:27:14.425685Z","caller":"traceutil/trace.go:171","msg":"trace[1575785942] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:798; }","duration":"963.644442ms","start":"2026-07-08T15:27:13.462026Z","end":"2026-07-08T15:27:14.425671Z","steps":["trace[1575785942] 'range keys from in-memory index tree' (duration: 961.649401ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:27:14.425996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:27:13.462008Z","time spent":"963.969445ms","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-08T15:27:14.428081Z","caller":"traceutil/trace.go:171","msg":"trace[797747384] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"887.798418ms","start":"2026-07-08T15:27:13.540267Z","end":"2026-07-08T15:27:14.428066Z","steps":["trace[797747384] 'process raft request' (duration: 887.680677ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:27:14.428308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:27:13.540246Z","time spent":"887.87586ms","remote":"127.0.0.1:32842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:27:14.437007Z","caller":"traceutil/trace.go:171","msg":"trace[1703402217] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"495.709069ms","start":"2026-07-08T15:27:13.941243Z","end":"2026-07-08T15:27:14.436952Z","steps":["trace[1703402217] 'process raft request' (duration: 495.469317ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:27:14.437153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.55147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T15:27:14.437227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:27:13.941224Z","time spent":"495.84434ms","remote":"127.0.0.1:60992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5051,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:27:14.437277Z","caller":"traceutil/trace.go:171","msg":"trace[745817261] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:800; }","duration":"551.718632ms","start":"2026-07-08T15:27:13.885544Z","end":"2026-07-08T15:27:14.437263Z","steps":["trace[745817261] 'agreement among raft nodes before linearized reading' (duration: 551.535641ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:27:14.437324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:27:13.885518Z","time spent":"551.795783ms","remote":"127.0.0.1:60842","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-07-08T15:27:14.436879Z","caller":"traceutil/trace.go:171","msg":"trace[577664487] linearizableReadLoop","detail":"{readStateIndex:827; appliedIndex:825; }","duration":"551.258537ms","start":"2026-07-08T15:27:13.885599Z","end":"2026-07-08T15:27:14.436858Z","steps":["trace[577664487] 'read index received' (duration: 542.386444ms)","trace[577664487] 'applied index is now lower than readState.Index' (duration: 8.871433ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:27:14.441493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.113784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-08T15:27:14.441547Z","caller":"traceutil/trace.go:171","msg":"trace[579054223] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:801; }","duration":"462.206064ms","start":"2026-07-08T15:27:13.979327Z","end":"2026-07-08T15:27:14.441533Z","steps":["trace[579054223] 'agreement among raft nodes before linearized reading' (duration: 462.068043ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:27:14.441573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:27:13.979308Z","time spent":"462.259886ms","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-08T15:27:14.44161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.671931ms","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-07-08T15:27:14.441664Z","caller":"traceutil/trace.go:171","msg":"trace[96153575] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:801; }","duration":"447.765611ms","start":"2026-07-08T15:27:13.993887Z","end":"2026-07-08T15:27:14.441653Z","steps":["trace[96153575] 'agreement among raft nodes before linearized reading' (duration: 447.599099ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:27:14.441704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:27:13.993869Z","time spent":"447.824242ms","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T15:27:14.4418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.6737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-08T15:27:14.441497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.903001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T15:27:14.442011Z","caller":"traceutil/trace.go:171","msg":"trace[790089037] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:801; }","duration":"411.451168ms","start":"2026-07-08T15:27:14.030549Z","end":"2026-07-08T15:27:14.442Z","steps":["trace[790089037] 'agreement among raft nodes before linearized reading' (duration: 410.901831ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:27:14.442072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:27:14.030537Z","time spent":"411.523968ms","remote":"127.0.0.1:32996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"warn","ts":"2026-07-08T15:27:14.442067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.613772ms","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-07-08T15:27:14.442167Z","caller":"traceutil/trace.go:171","msg":"trace[1090410746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:801; }","duration":"452.731623ms","start":"2026-07-08T15:27:13.989425Z","end":"2026-07-08T15:27:14.442157Z","steps":["trace[1090410746] 'agreement among raft nodes before linearized reading' (duration: 452.3988ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:27:14.442202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:27:13.989414Z","time spent":"452.778874ms","remote":"127.0.0.1:32882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-08T15:27:14.44194Z","caller":"traceutil/trace.go:171","msg":"trace[898681118] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:801; }","duration":"304.75843ms","start":"2026-07-08T15:27:14.137068Z","end":"2026-07-08T15:27:14.441838Z","steps":["trace[898681118] 'agreement among raft nodes before linearized reading' (duration: 304.453246ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:27:14.442736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:27:14.137052Z","time spent":"305.579498ms","remote":"127.0.0.1:60884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":31,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-07-08T15:27:14.442772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.025687ms","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-07-08T15:27:14.442946Z","caller":"traceutil/trace.go:171","msg":"trace[109788724] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:801; }","duration":"454.26629ms","start":"2026-07-08T15:27:13.988667Z","end":"2026-07-08T15:27:14.442933Z","steps":["trace[109788724] 'agreement among raft nodes before linearized reading' (duration: 452.838135ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:27:14.443036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:27:13.988647Z","time spent":"454.332201ms","remote":"127.0.0.1:32882","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-07-08T15:28:29.066418Z","caller":"traceutil/trace.go:171","msg":"trace[834633942] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"234.042809ms","start":"2026-07-08T15:28:28.832354Z","end":"2026-07-08T15:28:29.066397Z","steps":["trace[834633942] 'process raft request' (duration: 233.913717ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:28:29.070508Z","caller":"traceutil/trace.go:171","msg":"trace[1877858716] linearizableReadLoop","detail":"{readStateIndex:1222; appliedIndex:1220; }","duration":"233.009848ms","start":"2026-07-08T15:28:28.837476Z","end":"2026-07-08T15:28:29.070486Z","steps":["trace[1877858716] 'read index received' (duration: 228.800007ms)","trace[1877858716] 'applied index is now lower than readState.Index' (duration: 4.208701ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:28:29.070823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.961452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T15:28:29.070896Z","caller":"traceutil/trace.go:171","msg":"trace[1800785120] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1178; }","duration":"186.082364ms","start":"2026-07-08T15:28:28.884803Z","end":"2026-07-08T15:28:29.070886Z","steps":["trace[1800785120] 'agreement among raft nodes before linearized reading' (duration: 185.969652ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:28:29.070955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.06237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-08T15:28:29.070834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.313402ms","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-07-08T15:28:29.071005Z","caller":"traceutil/trace.go:171","msg":"trace[1812559347] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1178; }","duration":"232.172311ms","start":"2026-07-08T15:28:28.838821Z","end":"2026-07-08T15:28:29.070994Z","steps":["trace[1812559347] 'agreement among raft nodes before linearized reading' (duration: 231.969228ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:28:29.071075Z","caller":"traceutil/trace.go:171","msg":"trace[892421561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1178; }","duration":"232.533674ms","start":"2026-07-08T15:28:28.83848Z","end":"2026-07-08T15:28:29.071013Z","steps":["trace[892421561] 'agreement among raft nodes before linearized reading' (duration: 232.259761ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:28:29.071002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.502504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-08T15:28:29.070659Z","caller":"traceutil/trace.go:171","msg":"trace[1557061903] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"237.496632ms","start":"2026-07-08T15:28:28.833108Z","end":"2026-07-08T15:28:29.070605Z","steps":["trace[1557061903] 'process raft request' (duration: 236.107668ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:28:29.071354Z","caller":"traceutil/trace.go:171","msg":"trace[1089753046] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1178; }","duration":"233.888147ms","start":"2026-07-08T15:28:28.837439Z","end":"2026-07-08T15:28:29.071327Z","steps":["trace[1089753046] 'agreement among raft nodes before linearized reading' (duration: 233.17717ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:28:29.071388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.419889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5547"} {"level":"info","ts":"2026-07-08T15:28:29.071614Z","caller":"traceutil/trace.go:171","msg":"trace[1307010275] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1178; }","duration":"180.748272ms","start":"2026-07-08T15:28:28.890857Z","end":"2026-07-08T15:28:29.071606Z","steps":["trace[1307010275] 'agreement among raft nodes before linearized reading' (duration: 179.883834ms)"],"step_count":1}