{"level":"warn","ts":"2026-08-04T15:20:44.468045Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-04T15:20:44.468203Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.130: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.130:2380","--initial-cluster=instance=https://199.19.213.130:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.130:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.130: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-08-04T15:20:44.468308Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-04T15:20:44.468336Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.130:2380"]} {"level":"info","ts":"2026-08-04T15:20:44.468359Z","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-08-04T15:20:44.469214Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.130:2379"]} {"level":"info","ts":"2026-08-04T15:20:44.46932Z","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.130:2380"],"listen-peer-urls":["https://199.19.213.130:2380"],"advertise-client-urls":["https://199.19.213.130:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.130:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.130: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-08-04T15:20:44.471665Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.04473ms"} {"level":"info","ts":"2026-08-04T15:20:44.477671Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a727d7e7ce5fe36a","cluster-id":"db8a5e7d54164af4"} {"level":"info","ts":"2026-08-04T15:20:44.477752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a switched to configuration voters=()"} {"level":"info","ts":"2026-08-04T15:20:44.477781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a became follower at term 0"} {"level":"info","ts":"2026-08-04T15:20:44.477794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a727d7e7ce5fe36a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-04T15:20:44.477809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a became follower at term 1"} {"level":"info","ts":"2026-08-04T15:20:44.477862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a switched to configuration voters=(12044833119025488746)"} {"level":"warn","ts":"2026-08-04T15:20:44.490337Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-04T15:20:44.495801Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-04T15:20:44.497026Z","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-08-04T15:20:44.499318Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a727d7e7ce5fe36a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-04T15:20:44.499442Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a727d7e7ce5fe36a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-04T15:20:44.499784Z","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-08-04T15:20:44.499988Z","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-08-04T15:20:44.50002Z","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-08-04T15:20:44.50256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a switched to configuration voters=(12044833119025488746)"} {"level":"info","ts":"2026-08-04T15:20:44.503895Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"db8a5e7d54164af4","local-member-id":"a727d7e7ce5fe36a","added-peer-id":"a727d7e7ce5fe36a","added-peer-peer-urls":["https://199.19.213.130:2380"]} {"level":"info","ts":"2026-08-04T15:20:44.505591Z","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-08-04T15:20:44.50596Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.130:2380"} {"level":"info","ts":"2026-08-04T15:20:44.505996Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.130:2380"} {"level":"info","ts":"2026-08-04T15:20:44.506028Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a727d7e7ce5fe36a","initial-advertise-peer-urls":["https://199.19.213.130:2380"],"listen-peer-urls":["https://199.19.213.130:2380"],"advertise-client-urls":["https://199.19.213.130:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.130:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-04T15:20:44.506073Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-04T15:20:45.282573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a is starting a new election at term 1"} {"level":"info","ts":"2026-08-04T15:20:45.282659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a became pre-candidate at term 1"} {"level":"info","ts":"2026-08-04T15:20:45.282681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a received MsgPreVoteResp from a727d7e7ce5fe36a at term 1"} {"level":"info","ts":"2026-08-04T15:20:45.282708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a became candidate at term 2"} {"level":"info","ts":"2026-08-04T15:20:45.282715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a received MsgVoteResp from a727d7e7ce5fe36a at term 2"} {"level":"info","ts":"2026-08-04T15:20:45.282745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a became leader at term 2"} {"level":"info","ts":"2026-08-04T15:20:45.282754Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a727d7e7ce5fe36a elected leader a727d7e7ce5fe36a at term 2"} {"level":"info","ts":"2026-08-04T15:20:45.288583Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a727d7e7ce5fe36a","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.130:2379]}","request-path":"/0/members/a727d7e7ce5fe36a/attributes","cluster-id":"db8a5e7d54164af4","publish-timeout":"7s"} {"level":"info","ts":"2026-08-04T15:20:45.288662Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-04T15:20:45.288752Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:20:45.288636Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-04T15:20:45.289092Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-04T15:20:45.289211Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-04T15:20:45.291956Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-04T15:20:45.296091Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"db8a5e7d54164af4","local-member-id":"a727d7e7ce5fe36a","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:20:45.296239Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:20:45.296311Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:20:45.296526Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.130:2379"} {"level":"info","ts":"2026-08-04T15:21:11.154267Z","caller":"traceutil/trace.go:171","msg":"trace[983953459] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"242.723478ms","start":"2026-08-04T15:21:10.911503Z","end":"2026-08-04T15:21:11.154226Z","steps":["trace[983953459] 'process raft request' (duration: 242.560644ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:11.207988Z","caller":"traceutil/trace.go:171","msg":"trace[618538737] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"296.330412ms","start":"2026-08-04T15:21:10.911634Z","end":"2026-08-04T15:21:11.207964Z","steps":["trace[618538737] 'process raft request' (duration: 295.952443ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:27.77445Z","caller":"traceutil/trace.go:171","msg":"trace[69005909] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"104.976193ms","start":"2026-08-04T15:21:27.669438Z","end":"2026-08-04T15:21:27.774414Z","steps":["trace[69005909] 'process raft request' (duration: 74.182518ms)","trace[69005909] 'compare' (duration: 30.648962ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:21:27.948128Z","caller":"traceutil/trace.go:171","msg":"trace[6850513] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"157.329416ms","start":"2026-08-04T15:21:27.790754Z","end":"2026-08-04T15:21:27.948083Z","steps":["trace[6850513] 'process raft request' (duration: 89.844452ms)","trace[6850513] 'compare' (duration: 67.276599ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:21:33.179517Z","caller":"traceutil/trace.go:171","msg":"trace[351830584] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"130.651064ms","start":"2026-08-04T15:21:33.048819Z","end":"2026-08-04T15:21:33.17947Z","steps":["trace[351830584] 'process raft request' (duration: 124.430194ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:33.840859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.787866ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:21:33.841126Z","caller":"traceutil/trace.go:171","msg":"trace[2101958169] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"598.288343ms","start":"2026-08-04T15:21:33.242796Z","end":"2026-08-04T15:21:33.841085Z","steps":["trace[2101958169] 'process raft request' (duration: 270.726018ms)","trace[2101958169] 'compare' (duration: 326.348196ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:21:33.841172Z","caller":"traceutil/trace.go:171","msg":"trace[1933387761] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"530.557463ms","start":"2026-08-04T15:21:33.310585Z","end":"2026-08-04T15:21:33.841142Z","steps":["trace[1933387761] 'read index received' (duration: 202.803553ms)","trace[1933387761] 'applied index is now lower than readState.Index' (duration: 327.75033ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:21:33.841265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:21:33.242771Z","time spent":"598.434357ms","remote":"127.0.0.1:37164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-04T15:21:33.922458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.827702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-04T15:21:33.922643Z","caller":"traceutil/trace.go:171","msg":"trace[657273133] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:604; }","duration":"612.062858ms","start":"2026-08-04T15:21:33.310533Z","end":"2026-08-04T15:21:33.922596Z","steps":["trace[657273133] 'agreement among raft nodes before linearized reading' (duration: 530.767789ms)","trace[657273133] 'range keys from in-memory index tree' (duration: 80.940521ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:21:33.922705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:21:33.310508Z","time spent":"612.18271ms","remote":"127.0.0.1:37084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-04T15:21:33.922832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.217485ms","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-08-04T15:21:33.922926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.845894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-04T15:21:33.922967Z","caller":"traceutil/trace.go:171","msg":"trace[386168495] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:604; }","duration":"280.887625ms","start":"2026-08-04T15:21:33.642069Z","end":"2026-08-04T15:21:33.922957Z","steps":["trace[386168495] 'agreement among raft nodes before linearized reading' (duration: 280.779432ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:33.922955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.360785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kcg6w\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-04T15:21:33.923006Z","caller":"traceutil/trace.go:171","msg":"trace[770515117] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:604; }","duration":"594.39816ms","start":"2026-08-04T15:21:33.328514Z","end":"2026-08-04T15:21:33.922912Z","steps":["trace[770515117] 'agreement among raft nodes before linearized reading' (duration: 594.093682ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:33.923079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:21:33.328483Z","time spent":"594.582484ms","remote":"127.0.0.1:37084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-04T15:21:33.923084Z","caller":"traceutil/trace.go:171","msg":"trace[342012686] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kcg6w; range_end:; response_count:1; response_revision:604; }","duration":"591.53587ms","start":"2026-08-04T15:21:33.331518Z","end":"2026-08-04T15:21:33.923054Z","steps":["trace[342012686] 'agreement among raft nodes before linearized reading' (duration: 591.1131ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:33.9231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.36124ms","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-08-04T15:21:33.923132Z","caller":"traceutil/trace.go:171","msg":"trace[1904641974] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:604; }","duration":"528.418611ms","start":"2026-08-04T15:21:33.394706Z","end":"2026-08-04T15:21:33.923124Z","steps":["trace[1904641974] 'agreement among raft nodes before linearized reading' (duration: 528.327649ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:33.923142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:21:33.331505Z","time spent":"591.626652ms","remote":"127.0.0.1:36994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-kcg6w\" "} {"level":"warn","ts":"2026-08-04T15:21:33.923158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:21:33.394693Z","time spent":"528.458812ms","remote":"127.0.0.1:37084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-04T15:21:34.497676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.376047ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:21:34.498148Z","caller":"traceutil/trace.go:171","msg":"trace[1167956412] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:626; }","duration":"380.641401ms","start":"2026-08-04T15:21:34.117485Z","end":"2026-08-04T15:21:34.498127Z","steps":["trace[1167956412] 'read index received' (duration: 334.785821ms)","trace[1167956412] 'applied index is now lower than readState.Index' (duration: 45.8543ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:21:34.498294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.805605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:21:34.498318Z","caller":"traceutil/trace.go:171","msg":"trace[818556758] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"569.557787ms","start":"2026-08-04T15:21:33.928636Z","end":"2026-08-04T15:21:34.498194Z","steps":["trace[818556758] 'process raft request' (duration: 569.163657ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:34.498499Z","caller":"traceutil/trace.go:171","msg":"trace[797727374] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"569.947936ms","start":"2026-08-04T15:21:33.928516Z","end":"2026-08-04T15:21:34.498464Z","steps":["trace[797727374] 'process raft request' (duration: 24.494993ms)","trace[797727374] 'compare' (duration: 544.06887ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:21:34.498576Z","caller":"traceutil/trace.go:171","msg":"trace[1763252041] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"568.384729ms","start":"2026-08-04T15:21:33.930178Z","end":"2026-08-04T15:21:34.498562Z","steps":["trace[1763252041] 'process raft request' (duration: 567.767734ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:34.498691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:21:33.928476Z","time spent":"570.08013ms","remote":"127.0.0.1:37084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:21:34.498705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:21:33.930147Z","time spent":"568.492702ms","remote":"127.0.0.1:37084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:21:34.498678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:21:33.928624Z","time spent":"569.847555ms","remote":"127.0.0.1:37084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:21:34.498359Z","caller":"traceutil/trace.go:171","msg":"trace[363056361] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"380.900407ms","start":"2026-08-04T15:21:34.11742Z","end":"2026-08-04T15:21:34.498321Z","steps":["trace[363056361] 'agreement among raft nodes before linearized reading' (duration: 380.772914ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:34.498884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:21:34.117391Z","time spent":"381.483451ms","remote":"127.0.0.1:36796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-04T15:21:34.498364Z","caller":"traceutil/trace.go:171","msg":"trace[1332079973] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"556.356798ms","start":"2026-08-04T15:21:33.941947Z","end":"2026-08-04T15:21:34.498304Z","steps":["trace[1332079973] 'process raft request' (duration: 556.116262ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:34.499185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:21:33.941917Z","time spent":"557.100116ms","remote":"127.0.0.1:36994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:21:34.893338Z","caller":"traceutil/trace.go:171","msg":"trace[886558133] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:630; }","duration":"392.52802ms","start":"2026-08-04T15:21:34.500776Z","end":"2026-08-04T15:21:34.893304Z","steps":["trace[886558133] 'read index received' (duration: 391.660879ms)","trace[886558133] 'applied index is now lower than readState.Index' (duration: 865.701µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:21:34.893416Z","caller":"traceutil/trace.go:171","msg":"trace[1415044083] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"552.69395ms","start":"2026-08-04T15:21:34.340646Z","end":"2026-08-04T15:21:34.89334Z","steps":["trace[1415044083] 'process raft request' (duration: 552.122426ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:34.893511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.714354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:21:34.893567Z","caller":"traceutil/trace.go:171","msg":"trace[1417608012] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:610; }","duration":"392.832297ms","start":"2026-08-04T15:21:34.500718Z","end":"2026-08-04T15:21:34.89355Z","steps":["trace[1417608012] 'agreement among raft nodes before linearized reading' (duration: 392.720494ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:34.893622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:21:34.500695Z","time spent":"392.914039ms","remote":"127.0.0.1:36806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-04T15:21:34.893776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:21:34.340619Z","time spent":"552.932225ms","remote":"127.0.0.1:36896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:21:36.634433Z","caller":"traceutil/trace.go:171","msg":"trace[666210662] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"127.102609ms","start":"2026-08-04T15:21:36.507289Z","end":"2026-08-04T15:21:36.634392Z","steps":["trace[666210662] 'process raft request' (duration: 126.667598ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:36.640226Z","caller":"traceutil/trace.go:171","msg":"trace[406415738] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"132.393058ms","start":"2026-08-04T15:21:36.507796Z","end":"2026-08-04T15:21:36.640189Z","steps":["trace[406415738] 'process raft request' (duration: 131.400644ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:36.640505Z","caller":"traceutil/trace.go:171","msg":"trace[1453227427] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"132.412988ms","start":"2026-08-04T15:21:36.508075Z","end":"2026-08-04T15:21:36.640488Z","steps":["trace[1453227427] 'process raft request' (duration: 131.329922ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:39.258351Z","caller":"traceutil/trace.go:171","msg":"trace[790833233] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"109.530933ms","start":"2026-08-04T15:21:39.148779Z","end":"2026-08-04T15:21:39.25831Z","steps":["trace[790833233] 'process raft request' (duration: 109.324348ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:39.756163Z","caller":"traceutil/trace.go:171","msg":"trace[1742823124] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"174.6368ms","start":"2026-08-04T15:21:39.58145Z","end":"2026-08-04T15:21:39.756087Z","steps":["trace[1742823124] 'process raft request' (duration: 174.21832ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:44.878871Z","caller":"traceutil/trace.go:171","msg":"trace[1783727950] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"153.350565ms","start":"2026-08-04T15:21:44.725486Z","end":"2026-08-04T15:21:44.878837Z","steps":["trace[1783727950] 'process raft request' (duration: 98.690381ms)","trace[1783727950] 'compare' (duration: 54.430189ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:21:45.115195Z","caller":"traceutil/trace.go:171","msg":"trace[155358806] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"221.090396ms","start":"2026-08-04T15:21:44.894062Z","end":"2026-08-04T15:21:45.115152Z","steps":["trace[155358806] 'process raft request' (duration: 210.076729ms)","trace[155358806] 'compare' (duration: 10.873574ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:21:45.350605Z","caller":"traceutil/trace.go:171","msg":"trace[1199388862] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"208.43708ms","start":"2026-08-04T15:21:45.142129Z","end":"2026-08-04T15:21:45.350566Z","steps":["trace[1199388862] 'process raft request' (duration: 204.463314ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:45.466008Z","caller":"traceutil/trace.go:171","msg":"trace[819064478] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"100.967666ms","start":"2026-08-04T15:21:45.365004Z","end":"2026-08-04T15:21:45.465971Z","steps":["trace[819064478] 'process raft request' (duration: 97.228745ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:45.55459Z","caller":"traceutil/trace.go:171","msg":"trace[1101831714] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"143.688801ms","start":"2026-08-04T15:21:45.410872Z","end":"2026-08-04T15:21:45.55456Z","steps":["trace[1101831714] 'process raft request' (duration: 143.631699ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:45.555265Z","caller":"traceutil/trace.go:171","msg":"trace[579030694] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"145.610047ms","start":"2026-08-04T15:21:45.409641Z","end":"2026-08-04T15:21:45.555252Z","steps":["trace[579030694] 'process raft request' (duration: 144.548852ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:45.555579Z","caller":"traceutil/trace.go:171","msg":"trace[329306383] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"144.88003ms","start":"2026-08-04T15:21:45.410687Z","end":"2026-08-04T15:21:45.555567Z","steps":["trace[329306383] 'process raft request' (duration: 143.743873ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:48.296374Z","caller":"traceutil/trace.go:171","msg":"trace[1574854183] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"172.230242ms","start":"2026-08-04T15:21:48.124111Z","end":"2026-08-04T15:21:48.296341Z","steps":["trace[1574854183] 'process raft request' (duration: 172.023127ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:50.655718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.270273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9tgr7\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-08-04T15:21:50.655788Z","caller":"traceutil/trace.go:171","msg":"trace[599871040] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9tgr7; range_end:; response_count:1; response_revision:769; }","duration":"210.411336ms","start":"2026-08-04T15:21:50.44536Z","end":"2026-08-04T15:21:50.655771Z","steps":["trace[599871040] 'range keys from in-memory index tree' (duration: 210.087878ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:50.655718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.980212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-04T15:21:50.65593Z","caller":"traceutil/trace.go:171","msg":"trace[204239662] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:769; }","duration":"325.246978ms","start":"2026-08-04T15:21:50.330651Z","end":"2026-08-04T15:21:50.655898Z","steps":["trace[204239662] 'range keys from in-memory index tree' (duration: 324.686845ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:50.655978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:21:50.330622Z","time spent":"325.344231ms","remote":"127.0.0.1:37084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-04T15:21:50.656405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.585403ms","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-08-04T15:21:50.656446Z","caller":"traceutil/trace.go:171","msg":"trace[476088837] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:769; }","duration":"355.667695ms","start":"2026-08-04T15:21:50.300768Z","end":"2026-08-04T15:21:50.656436Z","steps":["trace[476088837] 'range keys from in-memory index tree' (duration: 354.909367ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:50.656487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:21:50.300741Z","time spent":"355.739156ms","remote":"127.0.0.1:37084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-04T15:21:50.837844Z","caller":"traceutil/trace.go:171","msg":"trace[363380057] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"177.161342ms","start":"2026-08-04T15:21:50.660645Z","end":"2026-08-04T15:21:50.837806Z","steps":["trace[363380057] 'process raft request' (duration: 176.925736ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:50.849343Z","caller":"traceutil/trace.go:171","msg":"trace[719654802] linearizableReadLoop","detail":"{readStateIndex:798; appliedIndex:796; }","duration":"105.142227ms","start":"2026-08-04T15:21:50.744179Z","end":"2026-08-04T15:21:50.849322Z","steps":["trace[719654802] 'read index received' (duration: 93.606998ms)","trace[719654802] 'applied index is now lower than readState.Index' (duration: 11.532489ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:21:50.849506Z","caller":"traceutil/trace.go:171","msg":"trace[1213579317] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"184.783136ms","start":"2026-08-04T15:21:50.664688Z","end":"2026-08-04T15:21:50.849471Z","steps":["trace[1213579317] 'process raft request' (duration: 184.321935ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:50.849199Z","caller":"traceutil/trace.go:171","msg":"trace[1503171172] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"187.929483ms","start":"2026-08-04T15:21:50.661186Z","end":"2026-08-04T15:21:50.849116Z","steps":["trace[1503171172] 'process raft request' (duration: 187.705867ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:21:50.850037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.834764ms","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-08-04T15:21:50.85058Z","caller":"traceutil/trace.go:171","msg":"trace[1528330399] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:772; }","duration":"106.446019ms","start":"2026-08-04T15:21:50.744105Z","end":"2026-08-04T15:21:50.850551Z","steps":["trace[1528330399] 'agreement among raft nodes before linearized reading' (duration: 105.399543ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:22:25.90015Z","caller":"traceutil/trace.go:171","msg":"trace[411819358] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"188.811694ms","start":"2026-08-04T15:22:25.711303Z","end":"2026-08-04T15:22:25.900114Z","steps":["trace[411819358] 'process raft request' (duration: 188.574058ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:22:26.474048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.062305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:22:26.474172Z","caller":"traceutil/trace.go:171","msg":"trace[338061767] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:985; }","duration":"356.25815ms","start":"2026-08-04T15:22:26.11789Z","end":"2026-08-04T15:22:26.474149Z","steps":["trace[338061767] 'range keys from in-memory index tree' (duration: 355.952063ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:22:26.474214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:22:26.117842Z","time spent":"356.363012ms","remote":"127.0.0.1:36796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-04T15:22:51.393189Z","caller":"traceutil/trace.go:171","msg":"trace[259349975] linearizableReadLoop","detail":"{readStateIndex:1106; appliedIndex:1105; }","duration":"194.254093ms","start":"2026-08-04T15:22:51.198903Z","end":"2026-08-04T15:22:51.393157Z","steps":["trace[259349975] 'read index received' (duration: 193.946716ms)","trace[259349975] 'applied index is now lower than readState.Index' (duration: 306.267µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:22:51.393533Z","caller":"traceutil/trace.go:171","msg":"trace[978450600] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"215.974416ms","start":"2026-08-04T15:22:51.17751Z","end":"2026-08-04T15:22:51.393485Z","steps":["trace[978450600] 'process raft request' (duration: 215.456053ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:22:51.393714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.781666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-08-04T15:22:51.393784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.591536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-04T15:22:51.393831Z","caller":"traceutil/trace.go:171","msg":"trace[1521934408] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1066; }","duration":"194.96462ms","start":"2026-08-04T15:22:51.198837Z","end":"2026-08-04T15:22:51.393801Z","steps":["trace[1521934408] 'agreement among raft nodes before linearized reading' (duration: 194.650163ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:22:51.393988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.974356ms","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-08-04T15:22:51.394047Z","caller":"traceutil/trace.go:171","msg":"trace[1874245071] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1066; }","duration":"191.051618ms","start":"2026-08-04T15:22:51.202985Z","end":"2026-08-04T15:22:51.394037Z","steps":["trace[1874245071] 'agreement among raft nodes before linearized reading' (duration: 190.899554ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:22:51.393842Z","caller":"traceutil/trace.go:171","msg":"trace[1860024974] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1066; }","duration":"123.696248ms","start":"2026-08-04T15:22:51.27013Z","end":"2026-08-04T15:22:51.393826Z","steps":["trace[1860024974] 'agreement among raft nodes before linearized reading' (duration: 123.475843ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:22:51.394282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.810403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-08-04T15:22:51.394398Z","caller":"traceutil/trace.go:171","msg":"trace[1208283586] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1066; }","duration":"194.003518ms","start":"2026-08-04T15:22:51.200376Z","end":"2026-08-04T15:22:51.39438Z","steps":["trace[1208283586] 'agreement among raft nodes before linearized reading' (duration: 193.216959ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:22:52.322961Z","caller":"traceutil/trace.go:171","msg":"trace[2130438247] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"315.651439ms","start":"2026-08-04T15:22:52.007274Z","end":"2026-08-04T15:22:52.322925Z","steps":["trace[2130438247] 'process raft request' (duration: 315.460255ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:22:52.323192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:22:52.007239Z","time spent":"315.823524ms","remote":"127.0.0.1:37084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:22:53.02573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.482169ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:22:53.02611Z","caller":"traceutil/trace.go:171","msg":"trace[123467112] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"372.965962ms","start":"2026-08-04T15:22:52.653022Z","end":"2026-08-04T15:22:53.025988Z","steps":["trace[123467112] 'process raft request' (duration: 256.092404ms)","trace[123467112] 'compare' (duration: 116.092289ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:22:53.026272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:22:52.652986Z","time spent":"373.230838ms","remote":"127.0.0.1:37084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:22:54.452171Z","caller":"traceutil/trace.go:171","msg":"trace[1785822372] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"123.618837ms","start":"2026-08-04T15:22:54.328502Z","end":"2026-08-04T15:22:54.452121Z","steps":["trace[1785822372] 'process raft request' (duration: 123.041264ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:23:11.949731Z","caller":"traceutil/trace.go:171","msg":"trace[1339160335] linearizableReadLoop","detail":"{readStateIndex:1229; appliedIndex:1228; }","duration":"415.430185ms","start":"2026-08-04T15:23:11.534281Z","end":"2026-08-04T15:23:11.949711Z","steps":["trace[1339160335] 'read index received' (duration: 415.251411ms)","trace[1339160335] 'applied index is now lower than readState.Index' (duration: 178.084µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:23:11.949842Z","caller":"traceutil/trace.go:171","msg":"trace[615524869] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"449.858447ms","start":"2026-08-04T15:23:11.499972Z","end":"2026-08-04T15:23:11.949831Z","steps":["trace[615524869] 'process raft request' (duration: 449.620611ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:23:11.949937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:23:11.499951Z","time spent":"449.909907ms","remote":"127.0.0.1:37084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:23:11.950074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.84803ms","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-08-04T15:23:11.950126Z","caller":"traceutil/trace.go:171","msg":"trace[676720895] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1183; }","duration":"411.928351ms","start":"2026-08-04T15:23:11.538185Z","end":"2026-08-04T15:23:11.950114Z","steps":["trace[676720895] 'agreement among raft nodes before linearized reading' (duration: 411.792238ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:23:11.950153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:23:11.538174Z","time spent":"411.973733ms","remote":"127.0.0.1:37084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-04T15:23:11.950277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.635806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-04T15:23:11.950295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.697311ms","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-08-04T15:23:11.950306Z","caller":"traceutil/trace.go:171","msg":"trace[1816785891] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1183; }","duration":"389.696257ms","start":"2026-08-04T15:23:11.560603Z","end":"2026-08-04T15:23:11.950299Z","steps":["trace[1816785891] 'agreement among raft nodes before linearized reading' (duration: 389.599504ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:23:11.950316Z","caller":"traceutil/trace.go:171","msg":"trace[1092908778] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1183; }","duration":"390.751852ms","start":"2026-08-04T15:23:11.559558Z","end":"2026-08-04T15:23:11.950309Z","steps":["trace[1092908778] 'agreement among raft nodes before linearized reading' (duration: 390.696241ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:23:11.950328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:23:11.560589Z","time spent":"389.734608ms","remote":"127.0.0.1:37084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-04T15:23:11.950339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:23:11.559541Z","time spent":"390.792603ms","remote":"127.0.0.1:37084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-04T15:23:11.950422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.146532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-04T15:23:11.950439Z","caller":"traceutil/trace.go:171","msg":"trace[402827950] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1183; }","duration":"416.199463ms","start":"2026-08-04T15:23:11.534235Z","end":"2026-08-04T15:23:11.950434Z","steps":["trace[402827950] 'agreement among raft nodes before linearized reading' (duration: 416.150182ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:23:11.950455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:23:11.534218Z","time spent":"416.234113ms","remote":"127.0.0.1:37084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-04T15:23:12.15619Z","caller":"traceutil/trace.go:171","msg":"trace[495714825] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"201.091066ms","start":"2026-08-04T15:23:11.955074Z","end":"2026-08-04T15:23:12.156165Z","steps":["trace[495714825] 'process raft request' (duration: 201.051785ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:23:12.156238Z","caller":"traceutil/trace.go:171","msg":"trace[230425840] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"201.135377ms","start":"2026-08-04T15:23:11.955076Z","end":"2026-08-04T15:23:12.156212Z","steps":["trace[230425840] 'process raft request' (duration: 200.993974ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:23:12.156203Z","caller":"traceutil/trace.go:171","msg":"trace[740479510] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"201.926626ms","start":"2026-08-04T15:23:11.954253Z","end":"2026-08-04T15:23:12.15618Z","steps":["trace[740479510] 'process raft request' (duration: 201.655879ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:23:28.213063Z","caller":"traceutil/trace.go:171","msg":"trace[1507710700] linearizableReadLoop","detail":"{readStateIndex:1304; appliedIndex:1303; }","duration":"142.740189ms","start":"2026-08-04T15:23:28.070304Z","end":"2026-08-04T15:23:28.213044Z","steps":["trace[1507710700] 'read index received' (duration: 142.646556ms)","trace[1507710700] 'applied index is now lower than readState.Index' (duration: 92.893µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:23:28.213175Z","caller":"traceutil/trace.go:171","msg":"trace[744034253] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"160.624341ms","start":"2026-08-04T15:23:28.052501Z","end":"2026-08-04T15:23:28.213125Z","steps":["trace[744034253] 'process raft request' (duration: 160.417356ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:23:28.213459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.145188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-04T15:23:28.213605Z","caller":"traceutil/trace.go:171","msg":"trace[1522798152] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1255; }","duration":"143.341973ms","start":"2026-08-04T15:23:28.070227Z","end":"2026-08-04T15:23:28.213569Z","steps":["trace[1522798152] 'agreement among raft nodes before linearized reading' (duration: 142.932803ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:23:29.357632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.154922ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:23:29.357807Z","caller":"traceutil/trace.go:171","msg":"trace[2023180477] linearizableReadLoop","detail":"{readStateIndex:1316; appliedIndex:1314; }","duration":"240.864325ms","start":"2026-08-04T15:23:29.116925Z","end":"2026-08-04T15:23:29.357789Z","steps":["trace[2023180477] 'read index received' (duration: 60.457987ms)","trace[2023180477] 'applied index is now lower than readState.Index' (duration: 180.405328ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:23:29.357904Z","caller":"traceutil/trace.go:171","msg":"trace[260476670] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"552.139081ms","start":"2026-08-04T15:23:28.805753Z","end":"2026-08-04T15:23:29.357892Z","steps":["trace[260476670] 'process raft request' (duration: 371.656292ms)","trace[260476670] 'compare' (duration: 180.017648ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:23:29.357959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:23:28.805739Z","time spent":"552.191402ms","remote":"127.0.0.1:36878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-04T15:23:29.358255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.624383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-04T15:23:29.358313Z","caller":"traceutil/trace.go:171","msg":"trace[2013931665] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1266; }","duration":"144.91486ms","start":"2026-08-04T15:23:29.213385Z","end":"2026-08-04T15:23:29.3583Z","steps":["trace[2013931665] 'agreement among raft nodes before linearized reading' (duration: 144.778846ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:23:29.358364Z","caller":"traceutil/trace.go:171","msg":"trace[1954895413] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"550.899921ms","start":"2026-08-04T15:23:28.807426Z","end":"2026-08-04T15:23:29.358326Z","steps":["trace[1954895413] 'process raft request' (duration: 550.307537ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:23:29.358341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.390727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:23:29.358512Z","caller":"traceutil/trace.go:171","msg":"trace[2007083705] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1266; }","duration":"241.577372ms","start":"2026-08-04T15:23:29.116891Z","end":"2026-08-04T15:23:29.358469Z","steps":["trace[2007083705] 'agreement among raft nodes before linearized reading' (duration: 241.343396ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:23:29.358535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:23:28.807401Z","time spent":"551.043205ms","remote":"127.0.0.1:37084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-04T15:23:29.737635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.60431ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:23:29.737859Z","caller":"traceutil/trace.go:171","msg":"trace[107396145] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"371.479897ms","start":"2026-08-04T15:23:29.366357Z","end":"2026-08-04T15:23:29.737837Z","steps":["trace[107396145] 'process raft request' (duration: 371.393885ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:23:29.737968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:23:29.366343Z","time spent":"371.566399ms","remote":"127.0.0.1:37084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:23:29.738205Z","caller":"traceutil/trace.go:171","msg":"trace[2037948006] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"375.290627ms","start":"2026-08-04T15:23:29.362896Z","end":"2026-08-04T15:23:29.738187Z","steps":["trace[2037948006] 'process raft request' (duration: 114.063482ms)","trace[2037948006] 'compare' (duration: 260.497518ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:23:29.738287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:23:29.362866Z","time spent":"375.38802ms","remote":"127.0.0.1:36878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-04T15:23:30.381304Z","caller":"traceutil/trace.go:171","msg":"trace[1866461423] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"102.280114ms","start":"2026-08-04T15:23:30.279Z","end":"2026-08-04T15:23:30.38128Z","steps":["trace[1866461423] 'process raft request' (duration: 62.26995ms)","trace[1866461423] 'compare' (duration: 39.866521ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:23:30.381477Z","caller":"traceutil/trace.go:171","msg":"trace[290998130] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"102.356996ms","start":"2026-08-04T15:23:30.279098Z","end":"2026-08-04T15:23:30.381455Z","steps":["trace[290998130] 'process raft request' (duration: 102.143961ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:23:30.88235Z","caller":"traceutil/trace.go:171","msg":"trace[1904049115] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"225.534272ms","start":"2026-08-04T15:23:30.65679Z","end":"2026-08-04T15:23:30.882325Z","steps":["trace[1904049115] 'process raft request' (duration: 225.383858ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:23:31.207382Z","caller":"traceutil/trace.go:171","msg":"trace[714701162] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"240.015844ms","start":"2026-08-04T15:23:30.96734Z","end":"2026-08-04T15:23:31.207356Z","steps":["trace[714701162] 'process raft request' (duration: 239.84078ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:23:34.996712Z","caller":"traceutil/trace.go:171","msg":"trace[1177631220] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"103.703587ms","start":"2026-08-04T15:23:34.892968Z","end":"2026-08-04T15:23:34.996672Z","steps":["trace[1177631220] 'process raft request' (duration: 71.334113ms)","trace[1177631220] 'compare' (duration: 32.078607ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:23:40.315673Z","caller":"traceutil/trace.go:171","msg":"trace[2047194636] linearizableReadLoop","detail":"{readStateIndex:1391; appliedIndex:1390; }","duration":"198.590588ms","start":"2026-08-04T15:23:40.117051Z","end":"2026-08-04T15:23:40.315642Z","steps":["trace[2047194636] 'read index received' (duration: 198.437324ms)","trace[2047194636] 'applied index is now lower than readState.Index' (duration: 152.344µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:23:40.315718Z","caller":"traceutil/trace.go:171","msg":"trace[1339459740] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"524.5754ms","start":"2026-08-04T15:23:39.791109Z","end":"2026-08-04T15:23:40.315684Z","steps":["trace[1339459740] 'process raft request' (duration: 524.366565ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:23:40.31588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.807433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:23:40.31596Z","caller":"traceutil/trace.go:171","msg":"trace[2128126379] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1339; }","duration":"198.944186ms","start":"2026-08-04T15:23:40.116998Z","end":"2026-08-04T15:23:40.315942Z","steps":["trace[2128126379] 'agreement among raft nodes before linearized reading' (duration: 198.801223ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:23:40.316141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:23:39.791076Z","time spent":"524.805216ms","remote":"127.0.0.1:37084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:24:58.987783Z","caller":"traceutil/trace.go:171","msg":"trace[238929885] transaction","detail":"{read_only:false; response_revision:1703; number_of_response:1; }","duration":"135.249254ms","start":"2026-08-04T15:24:58.852491Z","end":"2026-08-04T15:24:58.98774Z","steps":["trace[238929885] 'process raft request' (duration: 63.128255ms)","trace[238929885] 'compare' (duration: 71.650638ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:27:19.828608Z","caller":"traceutil/trace.go:171","msg":"trace[1608330038] transaction","detail":"{read_only:false; response_revision:2348; number_of_response:1; }","duration":"100.736104ms","start":"2026-08-04T15:27:19.72783Z","end":"2026-08-04T15:27:19.828566Z","steps":["trace[1608330038] 'process raft request' (duration: 100.420566ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:28:13.200588Z","caller":"traceutil/trace.go:171","msg":"trace[1816951020] transaction","detail":"{read_only:false; response_revision:2626; number_of_response:1; }","duration":"114.119776ms","start":"2026-08-04T15:28:13.086439Z","end":"2026-08-04T15:28:13.200558Z","steps":["trace[1816951020] 'process raft request' (duration: 113.481481ms)"],"step_count":1}