{"level":"warn","ts":"2026-09-09T01:00:02.540642Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-09T01:00:02.540733Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.223: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://162.253.55.223:2380","--initial-cluster=instance=https://162.253.55.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.223: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-09-09T01:00:02.540815Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-09T01:00:02.54083Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.223:2380"]} {"level":"info","ts":"2026-09-09T01:00:02.540846Z","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-09-09T01:00:02.541439Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.223:2379"]} {"level":"info","ts":"2026-09-09T01:00:02.541517Z","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://162.253.55.223:2380"],"listen-peer-urls":["https://162.253.55.223:2380"],"advertise-client-urls":["https://162.253.55.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.223: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-09-09T01:00:02.54638Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.664566ms"} {"level":"info","ts":"2026-09-09T01:00:02.568819Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a0f50f8a6c5f7d06","cluster-id":"62f129f77cf8e487"} {"level":"info","ts":"2026-09-09T01:00:02.56897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 switched to configuration voters=()"} {"level":"info","ts":"2026-09-09T01:00:02.568993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became follower at term 0"} {"level":"info","ts":"2026-09-09T01:00:02.569012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a0f50f8a6c5f7d06 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-09T01:00:02.569047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became follower at term 1"} {"level":"info","ts":"2026-09-09T01:00:02.56909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 switched to configuration voters=(11598193502560681222)"} {"level":"warn","ts":"2026-09-09T01:00:02.578685Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-09T01:00:02.581301Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-09T01:00:02.583649Z","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-09-09T01:00:02.586923Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a0f50f8a6c5f7d06","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-09T01:00:02.587705Z","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-09-09T01:00:02.587799Z","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-09-09T01:00:02.587809Z","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-09-09T01:00:02.587821Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a0f50f8a6c5f7d06","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-09T01:00:02.590515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 switched to configuration voters=(11598193502560681222)"} {"level":"info","ts":"2026-09-09T01:00:02.591106Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62f129f77cf8e487","local-member-id":"a0f50f8a6c5f7d06","added-peer-id":"a0f50f8a6c5f7d06","added-peer-peer-urls":["https://162.253.55.223:2380"]} {"level":"info","ts":"2026-09-09T01:00:02.592654Z","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-09-09T01:00:02.592732Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.223:2380"} {"level":"info","ts":"2026-09-09T01:00:02.592757Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.223:2380"} {"level":"info","ts":"2026-09-09T01:00:02.593007Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a0f50f8a6c5f7d06","initial-advertise-peer-urls":["https://162.253.55.223:2380"],"listen-peer-urls":["https://162.253.55.223:2380"],"advertise-client-urls":["https://162.253.55.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-09T01:00:02.593029Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-09T01:00:03.169483Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 is starting a new election at term 1"} {"level":"info","ts":"2026-09-09T01:00:03.169577Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-09T01:00:03.169607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 received MsgPreVoteResp from a0f50f8a6c5f7d06 at term 1"} {"level":"info","ts":"2026-09-09T01:00:03.169633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became candidate at term 2"} {"level":"info","ts":"2026-09-09T01:00:03.16965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 received MsgVoteResp from a0f50f8a6c5f7d06 at term 2"} {"level":"info","ts":"2026-09-09T01:00:03.169672Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became leader at term 2"} {"level":"info","ts":"2026-09-09T01:00:03.169692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a0f50f8a6c5f7d06 elected leader a0f50f8a6c5f7d06 at term 2"} {"level":"info","ts":"2026-09-09T01:00:03.171729Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T01:00:03.173857Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a0f50f8a6c5f7d06","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.223:2379]}","request-path":"/0/members/a0f50f8a6c5f7d06/attributes","cluster-id":"62f129f77cf8e487","publish-timeout":"7s"} {"level":"info","ts":"2026-09-09T01:00:03.17403Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-09T01:00:03.17412Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-09T01:00:03.174839Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62f129f77cf8e487","local-member-id":"a0f50f8a6c5f7d06","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T01:00:03.174962Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T01:00:03.175007Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T01:00:03.175741Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.223:2379"} {"level":"info","ts":"2026-09-09T01:00:03.175986Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-09T01:00:03.176009Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-09T01:00:03.177562Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-09-09T01:00:12.020403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.991973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-09-09T01:00:12.020563Z","caller":"traceutil/trace.go:171","msg":"trace[443428185] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:310; }","duration":"138.2199ms","start":"2026-09-09T01:00:11.882313Z","end":"2026-09-09T01:00:12.020533Z","steps":["trace[443428185] 'range keys from in-memory index tree' (duration: 137.849589ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:00:12.176443Z","caller":"traceutil/trace.go:171","msg":"trace[1282958453] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"148.73495ms","start":"2026-09-09T01:00:12.027679Z","end":"2026-09-09T01:00:12.176414Z","steps":["trace[1282958453] 'process raft request' (duration: 148.559625ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:00:12.304282Z","caller":"traceutil/trace.go:171","msg":"trace[1607909234] linearizableReadLoop","detail":"{readStateIndex:325; appliedIndex:322; }","duration":"273.203817ms","start":"2026-09-09T01:00:12.031062Z","end":"2026-09-09T01:00:12.304266Z","steps":["trace[1607909234] 'read index received' (duration: 145.197523ms)","trace[1607909234] 'applied index is now lower than readState.Index' (duration: 128.005604ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:00:12.304385Z","caller":"traceutil/trace.go:171","msg":"trace[975313496] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"275.050403ms","start":"2026-09-09T01:00:12.029299Z","end":"2026-09-09T01:00:12.30435Z","steps":["trace[975313496] 'process raft request' (duration: 274.925009ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:00:12.304449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.367152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-09-09T01:00:12.30449Z","caller":"traceutil/trace.go:171","msg":"trace[1229188003] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:313; }","duration":"273.451885ms","start":"2026-09-09T01:00:12.031029Z","end":"2026-09-09T01:00:12.30448Z","steps":["trace[1229188003] 'agreement among raft nodes before linearized reading' (duration: 273.336971ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:00:12.304556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.499696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-09-09T01:00:12.304579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.180438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-09-09T01:00:12.30463Z","caller":"traceutil/trace.go:171","msg":"trace[789107533] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:313; }","duration":"171.60597ms","start":"2026-09-09T01:00:12.133005Z","end":"2026-09-09T01:00:12.304611Z","steps":["trace[789107533] 'agreement among raft nodes before linearized reading' (duration: 171.489346ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:00:12.304668Z","caller":"traceutil/trace.go:171","msg":"trace[2036319057] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:313; }","duration":"121.314912ms","start":"2026-09-09T01:00:12.183331Z","end":"2026-09-09T01:00:12.304646Z","steps":["trace[2036319057] 'agreement among raft nodes before linearized reading' (duration: 121.154457ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:00:12.304548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.120185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-09-09T01:00:12.304736Z","caller":"traceutil/trace.go:171","msg":"trace[86470761] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:313; }","duration":"222.358322ms","start":"2026-09-09T01:00:12.082368Z","end":"2026-09-09T01:00:12.304726Z","steps":["trace[86470761] 'agreement among raft nodes before linearized reading' (duration: 222.075274ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:00:12.304871Z","caller":"traceutil/trace.go:171","msg":"trace[1945716209] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"276.805226ms","start":"2026-09-09T01:00:12.028051Z","end":"2026-09-09T01:00:12.304856Z","steps":["trace[1945716209] 'process raft request' (duration: 247.725189ms)","trace[1945716209] 'compare' (duration: 28.339745ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:00:23.201419Z","caller":"traceutil/trace.go:171","msg":"trace[546006536] linearizableReadLoop","detail":"{readStateIndex:396; appliedIndex:395; }","duration":"141.132217ms","start":"2026-09-09T01:00:23.060263Z","end":"2026-09-09T01:00:23.201395Z","steps":["trace[546006536] 'read index received' (duration: 140.90102ms)","trace[546006536] 'applied index is now lower than readState.Index' (duration: 230.367µs)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:00:23.201569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.281421ms","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-09-09T01:00:23.201603Z","caller":"traceutil/trace.go:171","msg":"trace[2125368147] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:381; }","duration":"141.374305ms","start":"2026-09-09T01:00:23.060218Z","end":"2026-09-09T01:00:23.201593Z","steps":["trace[2125368147] 'agreement among raft nodes before linearized reading' (duration: 141.276242ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:00:23.201866Z","caller":"traceutil/trace.go:171","msg":"trace[996395075] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"179.790423ms","start":"2026-09-09T01:00:23.022043Z","end":"2026-09-09T01:00:23.201834Z","steps":["trace[996395075] 'process raft request' (duration: 179.216986ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:00:23.882122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.060707ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T01:00:23.882242Z","caller":"traceutil/trace.go:171","msg":"trace[324721045] linearizableReadLoop","detail":"{readStateIndex:397; appliedIndex:396; }","duration":"469.87228ms","start":"2026-09-09T01:00:23.412338Z","end":"2026-09-09T01:00:23.88221Z","steps":["trace[324721045] 'read index received' (duration: 357.76272ms)","trace[324721045] 'applied index is now lower than readState.Index' (duration: 112.10846ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:00:23.882248Z","caller":"traceutil/trace.go:171","msg":"trace[1373488705] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"674.904292ms","start":"2026-09-09T01:00:23.207327Z","end":"2026-09-09T01:00:23.882231Z","steps":["trace[1373488705] 'process raft request' (duration: 562.878464ms)","trace[1373488705] 'compare' (duration: 110.675975ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:00:23.882319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:00:23.207307Z","time spent":"674.978525ms","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:00:23.882377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.032396ms","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-09-09T01:00:23.882424Z","caller":"traceutil/trace.go:171","msg":"trace[1935911056] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:382; }","duration":"470.109678ms","start":"2026-09-09T01:00:23.412301Z","end":"2026-09-09T01:00:23.882411Z","steps":["trace[1935911056] 'agreement among raft nodes before linearized reading' (duration: 470.012595ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:00:23.882486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:00:23.412279Z","time spent":"470.18811ms","remote":"127.0.0.1:45640","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-09-09T01:00:23.88298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.212996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:00:23.883057Z","caller":"traceutil/trace.go:171","msg":"trace[1479708354] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:382; }","duration":"409.3171ms","start":"2026-09-09T01:00:23.473717Z","end":"2026-09-09T01:00:23.883034Z","steps":["trace[1479708354] 'agreement among raft nodes before linearized reading' (duration: 408.698251ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:00:23.883199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:00:23.473704Z","time spent":"409.385141ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-09T01:00:25.07814Z","caller":"traceutil/trace.go:171","msg":"trace[226516797] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"166.673165ms","start":"2026-09-09T01:00:24.911447Z","end":"2026-09-09T01:00:25.078121Z","steps":["trace[226516797] 'process raft request' (duration: 166.510599ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:00:26.040637Z","caller":"traceutil/trace.go:171","msg":"trace[819025819] linearizableReadLoop","detail":"{readStateIndex:402; appliedIndex:401; }","duration":"131.633126ms","start":"2026-09-09T01:00:25.90898Z","end":"2026-09-09T01:00:26.040613Z","steps":["trace[819025819] 'read index received' (duration: 131.516762ms)","trace[819025819] 'applied index is now lower than readState.Index' (duration: 115.504µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:00:26.040675Z","caller":"traceutil/trace.go:171","msg":"trace[1716585580] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"150.176527ms","start":"2026-09-09T01:00:25.890482Z","end":"2026-09-09T01:00:26.040658Z","steps":["trace[1716585580] 'process raft request' (duration: 149.983961ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:00:26.040785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.78464ms","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-09-09T01:00:26.040841Z","caller":"traceutil/trace.go:171","msg":"trace[1601823871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:387; }","duration":"131.875873ms","start":"2026-09-09T01:00:25.908953Z","end":"2026-09-09T01:00:26.040829Z","steps":["trace[1601823871] 'agreement among raft nodes before linearized reading' (duration: 131.76322ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:00:26.60679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.19031ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T01:00:26.606885Z","caller":"traceutil/trace.go:171","msg":"trace[296920426] linearizableReadLoop","detail":"{readStateIndex:403; appliedIndex:402; }","duration":"370.388688ms","start":"2026-09-09T01:00:26.236481Z","end":"2026-09-09T01:00:26.60687Z","steps":["trace[296920426] 'read index received' (duration: 102.974762ms)","trace[296920426] 'applied index is now lower than readState.Index' (duration: 267.412846ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:00:26.606979Z","caller":"traceutil/trace.go:171","msg":"trace[1875437697] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"562.250895ms","start":"2026-09-09T01:00:26.044661Z","end":"2026-09-09T01:00:26.606912Z","steps":["trace[1875437697] 'process raft request' (duration: 294.846969ms)","trace[1875437697] 'compare' (duration: 267.079266ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:00:26.607081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.579354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.223\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-09T01:00:26.607156Z","caller":"traceutil/trace.go:171","msg":"trace[1342918843] range","detail":"{range_begin:/registry/masterleases/162.253.55.223; range_end:; response_count:1; response_revision:388; }","duration":"370.719178ms","start":"2026-09-09T01:00:26.236419Z","end":"2026-09-09T01:00:26.607138Z","steps":["trace[1342918843] 'agreement among raft nodes before linearized reading' (duration: 370.550352ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:00:26.607153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:00:26.04464Z","time spent":"562.421061ms","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:00:26.607019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.81707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-09T01:00:26.607198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:00:26.236395Z","time spent":"370.79454ms","remote":"127.0.0.1:45422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.223\" "} {"level":"info","ts":"2026-09-09T01:00:26.607241Z","caller":"traceutil/trace.go:171","msg":"trace[1791377294] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:388; }","duration":"132.064247ms","start":"2026-09-09T01:00:26.475155Z","end":"2026-09-09T01:00:26.607219Z","steps":["trace[1791377294] 'agreement among raft nodes before linearized reading' (duration: 131.83378ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:00:26.823635Z","caller":"traceutil/trace.go:171","msg":"trace[1530354513] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"188.480243ms","start":"2026-09-09T01:00:26.635129Z","end":"2026-09-09T01:00:26.823609Z","steps":["trace[1530354513] 'process raft request' (duration: 125.948314ms)","trace[1530354513] 'compare' (duration: 62.417766ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:00:29.494187Z","caller":"traceutil/trace.go:171","msg":"trace[1035181601] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"169.859628ms","start":"2026-09-09T01:00:29.324312Z","end":"2026-09-09T01:00:29.494172Z","steps":["trace[1035181601] 'process raft request' (duration: 169.472485ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:00:49.209527Z","caller":"traceutil/trace.go:171","msg":"trace[1333070064] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"230.80454ms","start":"2026-09-09T01:00:48.978699Z","end":"2026-09-09T01:00:49.209503Z","steps":["trace[1333070064] 'process raft request' (duration: 228.493864ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:00:49.215699Z","caller":"traceutil/trace.go:171","msg":"trace[2070298694] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"155.066517ms","start":"2026-09-09T01:00:49.060548Z","end":"2026-09-09T01:00:49.215614Z","steps":["trace[2070298694] 'process raft request' (duration: 154.600472ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:00:55.546867Z","caller":"traceutil/trace.go:171","msg":"trace[1739006277] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"143.320146ms","start":"2026-09-09T01:00:55.403514Z","end":"2026-09-09T01:00:55.546834Z","steps":["trace[1739006277] 'process raft request' (duration: 143.001995ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:00:55.703699Z","caller":"traceutil/trace.go:171","msg":"trace[1012881378] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"152.024576ms","start":"2026-09-09T01:00:55.551646Z","end":"2026-09-09T01:00:55.70367Z","steps":["trace[1012881378] 'process raft request' (duration: 137.124578ms)","trace[1012881378] 'compare' (duration: 14.737143ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:00:56.567187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.725452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.223\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-09T01:00:56.567276Z","caller":"traceutil/trace.go:171","msg":"trace[1126345735] range","detail":"{range_begin:/registry/masterleases/162.253.55.223; range_end:; response_count:1; response_revision:622; }","duration":"328.867818ms","start":"2026-09-09T01:00:56.238388Z","end":"2026-09-09T01:00:56.567256Z","steps":["trace[1126345735] 'range keys from in-memory index tree' (duration: 328.576928ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:00:56.567302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.495839ms","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-09-09T01:00:56.567323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:00:56.238368Z","time spent":"328.94303ms","remote":"127.0.0.1:45422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.223\" "} {"level":"warn","ts":"2026-09-09T01:00:56.567256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.988548ms","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-09-09T01:00:56.567373Z","caller":"traceutil/trace.go:171","msg":"trace[1039378935] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:622; }","duration":"358.601022ms","start":"2026-09-09T01:00:56.208748Z","end":"2026-09-09T01:00:56.567349Z","steps":["trace[1039378935] 'range keys from in-memory index tree' (duration: 358.261961ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:00:56.567406Z","caller":"traceutil/trace.go:171","msg":"trace[1916056759] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:622; }","duration":"578.143593ms","start":"2026-09-09T01:00:55.989235Z","end":"2026-09-09T01:00:56.567379Z","steps":["trace[1916056759] 'range keys from in-memory index tree' (duration: 577.971387ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:00:56.567451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:00:56.208728Z","time spent":"358.709936ms","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-09T01:00:56.721135Z","caller":"traceutil/trace.go:171","msg":"trace[1562625108] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"149.497419ms","start":"2026-09-09T01:00:56.571614Z","end":"2026-09-09T01:00:56.721112Z","steps":["trace[1562625108] 'process raft request' (duration: 149.318953ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:01.997055Z","caller":"traceutil/trace.go:171","msg":"trace[159851424] linearizableReadLoop","detail":"{readStateIndex:726; appliedIndex:724; }","duration":"210.851523ms","start":"2026-09-09T01:01:01.78618Z","end":"2026-09-09T01:01:01.997031Z","steps":["trace[159851424] 'read index received' (duration: 148.246945ms)","trace[159851424] 'applied index is now lower than readState.Index' (duration: 62.603618ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:01:01.997357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.173684ms","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-09-09T01:01:01.997423Z","caller":"traceutil/trace.go:171","msg":"trace[1095256267] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:696; }","duration":"211.292398ms","start":"2026-09-09T01:01:01.786119Z","end":"2026-09-09T01:01:01.997412Z","steps":["trace[1095256267] 'agreement among raft nodes before linearized reading' (duration: 211.106132ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:01.997534Z","caller":"traceutil/trace.go:171","msg":"trace[623256766] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"101.280401ms","start":"2026-09-09T01:01:01.896229Z","end":"2026-09-09T01:01:01.997509Z","steps":["trace[623256766] 'process raft request' (duration: 100.683181ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:01.997494Z","caller":"traceutil/trace.go:171","msg":"trace[749164089] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"304.250479ms","start":"2026-09-09T01:01:01.693193Z","end":"2026-09-09T01:01:01.997443Z","steps":["trace[749164089] 'process raft request' (duration: 303.556936ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:01.997812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:01.693167Z","time spent":"304.54157ms","remote":"127.0.0.1:45436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-09T01:01:04.899788Z","caller":"traceutil/trace.go:171","msg":"trace[1485980035] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"125.37507ms","start":"2026-09-09T01:01:04.774379Z","end":"2026-09-09T01:01:04.899754Z","steps":["trace[1485980035] 'process raft request' (duration: 125.037659ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:07.210439Z","caller":"traceutil/trace.go:171","msg":"trace[371340855] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"173.357047ms","start":"2026-09-09T01:01:07.037047Z","end":"2026-09-09T01:01:07.210404Z","steps":["trace[371340855] 'process raft request' (duration: 162.499888ms)","trace[371340855] 'compare' (duration: 10.710724ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:01:07.721285Z","caller":"traceutil/trace.go:171","msg":"trace[957509323] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"116.32206ms","start":"2026-09-09T01:01:07.604934Z","end":"2026-09-09T01:01:07.721256Z","steps":["trace[957509323] 'process raft request' (duration: 102.973387ms)","trace[957509323] 'compare' (duration: 13.2336ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:01:07.721829Z","caller":"traceutil/trace.go:171","msg":"trace[1660492277] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"107.289183ms","start":"2026-09-09T01:01:07.614524Z","end":"2026-09-09T01:01:07.721813Z","steps":["trace[1660492277] 'process raft request' (duration: 107.088736ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:17.657584Z","caller":"traceutil/trace.go:171","msg":"trace[1830272111] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"139.060578ms","start":"2026-09-09T01:01:17.518079Z","end":"2026-09-09T01:01:17.65714Z","steps":["trace[1830272111] 'process raft request' (duration: 138.867281ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:21.004678Z","caller":"traceutil/trace.go:171","msg":"trace[776815472] linearizableReadLoop","detail":"{readStateIndex:885; appliedIndex:884; }","duration":"108.960015ms","start":"2026-09-09T01:01:20.895699Z","end":"2026-09-09T01:01:21.004659Z","steps":["trace[776815472] 'read index received' (duration: 107.92198ms)","trace[776815472] 'applied index is now lower than readState.Index' (duration: 1.035225ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:01:21.004787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.06864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/envoy-gateway-system/\" range_end:\"/registry/poddisruptionbudgets/envoy-gateway-system0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:01:21.004916Z","caller":"traceutil/trace.go:171","msg":"trace[2090523204] range","detail":"{range_begin:/registry/poddisruptionbudgets/envoy-gateway-system/; range_end:/registry/poddisruptionbudgets/envoy-gateway-system0; response_count:0; response_revision:849; }","duration":"109.214994ms","start":"2026-09-09T01:01:20.895661Z","end":"2026-09-09T01:01:21.004876Z","steps":["trace[2090523204] 'agreement among raft nodes before linearized reading' (duration: 109.077079ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:21.004954Z","caller":"traceutil/trace.go:171","msg":"trace[1588216200] transaction","detail":"{read_only:false; response_revision:849; number_of_response:1; }","duration":"109.565696ms","start":"2026-09-09T01:01:20.895297Z","end":"2026-09-09T01:01:21.004862Z","steps":["trace[1588216200] 'process raft request' (duration: 108.314884ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:26.45576Z","caller":"traceutil/trace.go:171","msg":"trace[1106310235] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"145.67096ms","start":"2026-09-09T01:01:26.310053Z","end":"2026-09-09T01:01:26.455724Z","steps":["trace[1106310235] 'process raft request' (duration: 68.948091ms)","trace[1106310235] 'compare' (duration: 76.43393ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:01:26.456116Z","caller":"traceutil/trace.go:171","msg":"trace[1730752206] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"145.701161ms","start":"2026-09-09T01:01:26.310359Z","end":"2026-09-09T01:01:26.45606Z","steps":["trace[1730752206] 'process raft request' (duration: 145.598297ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:27.416298Z","caller":"traceutil/trace.go:171","msg":"trace[1190825510] linearizableReadLoop","detail":"{readStateIndex:950; appliedIndex:949; }","duration":"170.986553ms","start":"2026-09-09T01:01:27.24529Z","end":"2026-09-09T01:01:27.416276Z","steps":["trace[1190825510] 'read index received' (duration: 170.645661ms)","trace[1190825510] 'applied index is now lower than readState.Index' (duration: 340.202µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:01:27.416659Z","caller":"traceutil/trace.go:171","msg":"trace[199552737] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"282.183312ms","start":"2026-09-09T01:01:27.134467Z","end":"2026-09-09T01:01:27.416651Z","steps":["trace[199552737] 'process raft request' (duration: 281.52712ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:27.416892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.589384ms","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-09-09T01:01:27.416921Z","caller":"traceutil/trace.go:171","msg":"trace[453266876] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:912; }","duration":"171.668576ms","start":"2026-09-09T01:01:27.245244Z","end":"2026-09-09T01:01:27.416913Z","steps":["trace[453266876] 'agreement among raft nodes before linearized reading' (duration: 171.551162ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:27.536684Z","caller":"traceutil/trace.go:171","msg":"trace[888394425] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"113.211188ms","start":"2026-09-09T01:01:27.423448Z","end":"2026-09-09T01:01:27.536659Z","steps":["trace[888394425] 'process raft request' (duration: 103.517912ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:27.536832Z","caller":"traceutil/trace.go:171","msg":"trace[627323446] linearizableReadLoop","detail":"{readStateIndex:952; appliedIndex:950; }","duration":"108.813576ms","start":"2026-09-09T01:01:27.427986Z","end":"2026-09-09T01:01:27.536799Z","steps":["trace[627323446] 'read index received' (duration: 98.995706ms)","trace[627323446] 'applied index is now lower than readState.Index' (duration: 9.81552ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:01:27.536954Z","caller":"traceutil/trace.go:171","msg":"trace[486060425] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"113.187077ms","start":"2026-09-09T01:01:27.423731Z","end":"2026-09-09T01:01:27.536918Z","steps":["trace[486060425] 'process raft request' (duration: 112.888607ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:27.537041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.038614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:01:27.537078Z","caller":"traceutil/trace.go:171","msg":"trace[1281865504] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:914; }","duration":"109.140307ms","start":"2026-09-09T01:01:27.427925Z","end":"2026-09-09T01:01:27.537066Z","steps":["trace[1281865504] 'agreement among raft nodes before linearized reading' (duration: 109.054854ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:27.774778Z","caller":"traceutil/trace.go:171","msg":"trace[850703635] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"162.702155ms","start":"2026-09-09T01:01:27.612038Z","end":"2026-09-09T01:01:27.774741Z","steps":["trace[850703635] 'process raft request' (duration: 162.568231ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:27.774819Z","caller":"traceutil/trace.go:171","msg":"trace[600630606] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"166.995895ms","start":"2026-09-09T01:01:27.607787Z","end":"2026-09-09T01:01:27.774783Z","steps":["trace[600630606] 'process raft request' (duration: 166.638333ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:27.882787Z","caller":"traceutil/trace.go:171","msg":"trace[1333071786] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"100.653083ms","start":"2026-09-09T01:01:27.782078Z","end":"2026-09-09T01:01:27.882731Z","steps":["trace[1333071786] 'process raft request' (duration: 30.911773ms)","trace[1333071786] 'compare' (duration: 69.543322ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:01:28.203698Z","caller":"traceutil/trace.go:171","msg":"trace[793815005] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"153.704788ms","start":"2026-09-09T01:01:28.04997Z","end":"2026-09-09T01:01:28.203674Z","steps":["trace[793815005] 'process raft request' (duration: 140.632474ms)","trace[793815005] 'compare' (duration: 12.804045ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:01:28.35351Z","caller":"traceutil/trace.go:171","msg":"trace[136146026] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"110.797169ms","start":"2026-09-09T01:01:28.242691Z","end":"2026-09-09T01:01:28.353488Z","steps":["trace[136146026] 'process raft request' (duration: 110.709916ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:28.353522Z","caller":"traceutil/trace.go:171","msg":"trace[245517155] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"111.771222ms","start":"2026-09-09T01:01:28.241723Z","end":"2026-09-09T01:01:28.353494Z","steps":["trace[245517155] 'process raft request' (duration: 69.053197ms)","trace[245517155] 'compare' (duration: 42.417133ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:01:28.55657Z","caller":"traceutil/trace.go:171","msg":"trace[451997676] linearizableReadLoop","detail":"{readStateIndex:972; appliedIndex:968; }","duration":"143.749483ms","start":"2026-09-09T01:01:28.412796Z","end":"2026-09-09T01:01:28.556545Z","steps":["trace[451997676] 'read index received' (duration: 23.334571ms)","trace[451997676] 'applied index is now lower than readState.Index' (duration: 120.413752ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:01:28.556587Z","caller":"traceutil/trace.go:171","msg":"trace[2098951827] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"196.485044ms","start":"2026-09-09T01:01:28.360077Z","end":"2026-09-09T01:01:28.556562Z","steps":["trace[2098951827] 'process raft request' (duration: 196.338499ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:28.55666Z","caller":"traceutil/trace.go:171","msg":"trace[1324467436] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"196.07808ms","start":"2026-09-09T01:01:28.360533Z","end":"2026-09-09T01:01:28.556611Z","steps":["trace[1324467436] 'process raft request' (duration: 195.692497ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:28.556733Z","caller":"traceutil/trace.go:171","msg":"trace[1437334560] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"193.329644ms","start":"2026-09-09T01:01:28.363386Z","end":"2026-09-09T01:01:28.556715Z","steps":["trace[1437334560] 'process raft request' (duration: 193.093416ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:28.557006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.190837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12755"} {"level":"info","ts":"2026-09-09T01:01:28.557114Z","caller":"traceutil/trace.go:171","msg":"trace[743237144] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:934; }","duration":"144.309111ms","start":"2026-09-09T01:01:28.412747Z","end":"2026-09-09T01:01:28.557056Z","steps":["trace[743237144] 'agreement among raft nodes before linearized reading' (duration: 143.939408ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:28.599092Z","caller":"traceutil/trace.go:171","msg":"trace[1338038138] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"158.732782ms","start":"2026-09-09T01:01:28.440333Z","end":"2026-09-09T01:01:28.599066Z","steps":["trace[1338038138] 'process raft request' (duration: 158.591577ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:28.599336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.074935ms","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-09-09T01:01:28.59943Z","caller":"traceutil/trace.go:171","msg":"trace[1618181488] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:935; }","duration":"138.20724ms","start":"2026-09-09T01:01:28.4612Z","end":"2026-09-09T01:01:28.599408Z","steps":["trace[1618181488] 'agreement among raft nodes before linearized reading' (duration: 137.91041ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:28.599525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.681461ms","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-09-09T01:01:28.599603Z","caller":"traceutil/trace.go:171","msg":"trace[1271383607] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:935; }","duration":"139.809845ms","start":"2026-09-09T01:01:28.459775Z","end":"2026-09-09T01:01:28.599585Z","steps":["trace[1271383607] 'agreement among raft nodes before linearized reading' (duration: 139.567317ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:28.599616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.020227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/local-path-provisioner-679c578f5-pqd7m\" ","response":"range_response_count:1 size:2650"} {"level":"info","ts":"2026-09-09T01:01:28.599682Z","caller":"traceutil/trace.go:171","msg":"trace[1564235609] range","detail":"{range_begin:/registry/pods/local-path-storage/local-path-provisioner-679c578f5-pqd7m; range_end:; response_count:1; response_revision:935; }","duration":"158.116511ms","start":"2026-09-09T01:01:28.441548Z","end":"2026-09-09T01:01:28.599665Z","steps":["trace[1564235609] 'agreement among raft nodes before linearized reading' (duration: 157.615283ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:29.107389Z","caller":"traceutil/trace.go:171","msg":"trace[975731079] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"125.585475ms","start":"2026-09-09T01:01:28.981766Z","end":"2026-09-09T01:01:29.107352Z","steps":["trace[975731079] 'process raft request' (duration: 125.43551ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:29.534075Z","caller":"traceutil/trace.go:171","msg":"trace[481101643] linearizableReadLoop","detail":"{readStateIndex:982; appliedIndex:981; }","duration":"112.678386ms","start":"2026-09-09T01:01:29.421368Z","end":"2026-09-09T01:01:29.534047Z","steps":["trace[481101643] 'read index received' (duration: 112.348365ms)","trace[481101643] 'applied index is now lower than readState.Index' (duration: 328.751µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:01:29.534414Z","caller":"traceutil/trace.go:171","msg":"trace[768367429] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"146.118379ms","start":"2026-09-09T01:01:29.388262Z","end":"2026-09-09T01:01:29.534381Z","steps":["trace[768367429] 'process raft request' (duration: 145.503388ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:29.535354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.95233ms","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-09-09T01:01:29.535446Z","caller":"traceutil/trace.go:171","msg":"trace[1621267676] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:944; }","duration":"114.088195ms","start":"2026-09-09T01:01:29.421339Z","end":"2026-09-09T01:01:29.535427Z","steps":["trace[1621267676] 'agreement among raft nodes before linearized reading' (duration: 113.011948ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:30.562827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"953.990739ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T01:01:30.562936Z","caller":"traceutil/trace.go:171","msg":"trace[1024999163] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"1.022952126s","start":"2026-09-09T01:01:29.539957Z","end":"2026-09-09T01:01:30.562909Z","steps":["trace[1024999163] 'process raft request' (duration: 68.798092ms)","trace[1024999163] 'compare' (duration: 953.823592ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:01:30.563022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:29.539936Z","time spent":"1.023037099s","remote":"127.0.0.1:45650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:01:31.048798Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.439964289s","expected-duration":"1s"} {"level":"warn","ts":"2026-09-09T01:01:31.319493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.002791ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T01:01:31.319909Z","caller":"traceutil/trace.go:171","msg":"trace[350640451] linearizableReadLoop","detail":"{readStateIndex:984; appliedIndex:982; }","duration":"1.777475317s","start":"2026-09-09T01:01:29.542417Z","end":"2026-09-09T01:01:31.319893Z","steps":["trace[350640451] 'read index received' (duration: 66.268274ms)","trace[350640451] 'applied index is now lower than readState.Index' (duration: 1.711206213s)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:01:31.320127Z","caller":"traceutil/trace.go:171","msg":"trace[1999088915] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"1.776262996s","start":"2026-09-09T01:01:29.543773Z","end":"2026-09-09T01:01:31.320036Z","steps":["trace[1999088915] 'process raft request' (duration: 1.775977345s)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:31.319984Z","caller":"traceutil/trace.go:171","msg":"trace[1418939842] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"1.779920473s","start":"2026-09-09T01:01:29.540052Z","end":"2026-09-09T01:01:31.319972Z","steps":["trace[1418939842] 'process raft request' (duration: 1.509172775s)","trace[1418939842] 'compare' (duration: 269.805854ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:01:31.320274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:29.540035Z","time spent":"1.780185303s","remote":"127.0.0.1:45554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1104,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T01:01:31.320028Z","caller":"traceutil/trace.go:171","msg":"trace[667068043] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"1.776233476s","start":"2026-09-09T01:01:29.543786Z","end":"2026-09-09T01:01:31.32002Z","steps":["trace[667068043] 'process raft request' (duration: 1.776058629s)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:31.320471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:29.543767Z","time spent":"1.77667406s","remote":"127.0.0.1:45826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5192,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:01:31.320439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:29.543756Z","time spent":"1.776457613s","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:01:31.320148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.777724667s","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-09-09T01:01:31.320636Z","caller":"traceutil/trace.go:171","msg":"trace[463445600] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:948; }","duration":"1.778213973s","start":"2026-09-09T01:01:29.542411Z","end":"2026-09-09T01:01:31.320625Z","steps":["trace[463445600] 'agreement among raft nodes before linearized reading' (duration: 1.777643784s)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:31.320668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:29.542358Z","time spent":"1.778301257s","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-09T01:01:31.714043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.279815ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T01:01:31.71425Z","caller":"traceutil/trace.go:171","msg":"trace[747657622] linearizableReadLoop","detail":"{readStateIndex:988; appliedIndex:986; }","duration":"394.02378ms","start":"2026-09-09T01:01:31.320185Z","end":"2026-09-09T01:01:31.714209Z","steps":["trace[747657622] 'read index received' (duration: 251.58674ms)","trace[747657622] 'applied index is now lower than readState.Index' (duration: 142.43575ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:01:31.714434Z","caller":"traceutil/trace.go:171","msg":"trace[884219646] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"889.356384ms","start":"2026-09-09T01:01:30.825064Z","end":"2026-09-09T01:01:31.714421Z","steps":["trace[884219646] 'process raft request' (duration: 889.077844ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:31.714525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:30.825038Z","time spent":"889.436986ms","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:01:31.714593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.171706255s","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-09-09T01:01:31.714501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.024920891s","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-09-09T01:01:31.714655Z","caller":"traceutil/trace.go:171","msg":"trace[686541386] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:950; }","duration":"2.171792168s","start":"2026-09-09T01:01:29.542846Z","end":"2026-09-09T01:01:31.714638Z","steps":["trace[686541386] 'agreement among raft nodes before linearized reading' (duration: 2.171640963s)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:31.714723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:29.542836Z","time spent":"2.171874921s","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-09T01:01:31.714811Z","caller":"traceutil/trace.go:171","msg":"trace[2090684140] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:950; }","duration":"1.025124637s","start":"2026-09-09T01:01:30.689523Z","end":"2026-09-09T01:01:31.714648Z","steps":["trace[2090684140] 'agreement among raft nodes before linearized reading' (duration: 1.024845638s)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:01:31.714838Z","caller":"traceutil/trace.go:171","msg":"trace[1716764754] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"1.978445077s","start":"2026-09-09T01:01:29.735925Z","end":"2026-09-09T01:01:31.71437Z","steps":["trace[1716764754] 'process raft request' (duration: 1.835756558s)","trace[1716764754] 'compare' (duration: 142.14457ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:01:31.714827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.099588418s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-09-09T01:01:31.714878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:30.689504Z","time spent":"1.025356336s","remote":"127.0.0.1:45640","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":"warn","ts":"2026-09-09T01:01:31.714914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:29.735897Z","time spent":"1.978975685s","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T01:01:31.715129Z","caller":"traceutil/trace.go:171","msg":"trace[2073202194] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:950; }","duration":"1.09989771s","start":"2026-09-09T01:01:30.615162Z","end":"2026-09-09T01:01:31.71506Z","steps":["trace[2073202194] 'agreement among raft nodes before linearized reading' (duration: 1.099275337s)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:31.715296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:30.61514Z","time spent":"1.100102537s","remote":"127.0.0.1:45640","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-09-09T01:01:32.021037Z","caller":"traceutil/trace.go:171","msg":"trace[105625137] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"691.244211ms","start":"2026-09-09T01:01:31.329768Z","end":"2026-09-09T01:01:32.021013Z","steps":["trace[105625137] 'process raft request' (duration: 691.138348ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:32.021199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:31.329756Z","time spent":"691.349245ms","remote":"127.0.0.1:45808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5626,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T01:01:32.021325Z","caller":"traceutil/trace.go:171","msg":"trace[1032752211] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"694.67609ms","start":"2026-09-09T01:01:31.326552Z","end":"2026-09-09T01:01:32.021228Z","steps":["trace[1032752211] 'process raft request' (duration: 644.270004ms)","trace[1032752211] 'compare' (duration: 49.630169ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:01:32.021481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:31.326523Z","time spent":"694.871857ms","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T01:01:32.028607Z","caller":"traceutil/trace.go:171","msg":"trace[2003384993] linearizableReadLoop","detail":"{readStateIndex:991; appliedIndex:988; }","duration":"314.270134ms","start":"2026-09-09T01:01:31.714319Z","end":"2026-09-09T01:01:32.028589Z","steps":["trace[2003384993] 'read index received' (duration: 256.624987ms)","trace[2003384993] 'applied index is now lower than readState.Index' (duration: 57.643947ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:01:32.028709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.97693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:01:32.028746Z","caller":"traceutil/trace.go:171","msg":"trace[71240218] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:955; }","duration":"554.050154ms","start":"2026-09-09T01:01:31.474684Z","end":"2026-09-09T01:01:32.028734Z","steps":["trace[71240218] 'agreement among raft nodes before linearized reading' (duration: 553.97217ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:32.028781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:31.474662Z","time spent":"554.110816ms","remote":"127.0.0.1:45398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-09T01:01:32.029085Z","caller":"traceutil/trace.go:171","msg":"trace[1125692402] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"309.952805ms","start":"2026-09-09T01:01:31.719121Z","end":"2026-09-09T01:01:32.029074Z","steps":["trace[1125692402] 'process raft request' (duration: 309.25649ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:32.029167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:31.719103Z","time spent":"310.015106ms","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T01:01:32.029324Z","caller":"traceutil/trace.go:171","msg":"trace[669155423] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"309.271971ms","start":"2026-09-09T01:01:31.720043Z","end":"2026-09-09T01:01:32.029315Z","steps":["trace[669155423] 'process raft request' (duration: 308.446071ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:32.029378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:31.720037Z","time spent":"309.314402ms","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T01:01:32.029514Z","caller":"traceutil/trace.go:171","msg":"trace[313926727] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"307.54353ms","start":"2026-09-09T01:01:31.72196Z","end":"2026-09-09T01:01:32.029503Z","steps":["trace[313926727] 'process raft request' (duration: 306.589766ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:32.029734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:31.721954Z","time spent":"307.580481ms","remote":"127.0.0.1:45640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:01:32.029874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.570027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-09T01:01:32.029925Z","caller":"traceutil/trace.go:171","msg":"trace[869132798] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:955; }","duration":"325.669591ms","start":"2026-09-09T01:01:31.704243Z","end":"2026-09-09T01:01:32.029912Z","steps":["trace[869132798] 'agreement among raft nodes before linearized reading' (duration: 325.583558ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:01:32.029952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:01:31.704225Z","time spent":"325.718143ms","remote":"127.0.0.1:45854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":29,"response size":30,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "}