{"level":"warn","ts":"2026-07-02T09:57:34.451282Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T09:57:34.451399Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.117: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.117:2380","--initial-cluster=instance=https://199.19.213.117:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.117:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.117:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-02T09:57:34.451495Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T09:57:34.451513Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.117:2380"]} {"level":"info","ts":"2026-07-02T09:57:34.451538Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-02T09:57:34.452243Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.117:2379"]} {"level":"info","ts":"2026-07-02T09:57:34.45232Z","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.117:2380"],"listen-peer-urls":["https://199.19.213.117:2380"],"advertise-client-urls":["https://199.19.213.117:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.117:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.117:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-02T09:57:34.504561Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"39.569635ms"} {"level":"info","ts":"2026-07-02T09:57:34.587857Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f9f905057b5b268","cluster-id":"293172f52aeb3f03"} {"level":"info","ts":"2026-07-02T09:57:34.587982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 switched to configuration voters=()"} {"level":"info","ts":"2026-07-02T09:57:34.588008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 became follower at term 0"} {"level":"info","ts":"2026-07-02T09:57:34.588028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5f9f905057b5b268 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-02T09:57:34.588043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 became follower at term 1"} {"level":"info","ts":"2026-07-02T09:57:34.588099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 switched to configuration voters=(6890384629643457128)"} {"level":"warn","ts":"2026-07-02T09:57:34.710825Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-02T09:57:34.718215Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-02T09:57:34.740841Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-02T09:57:34.761736Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5f9f905057b5b268","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-02T09:57:34.76212Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5f9f905057b5b268","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-02T09:57:34.76384Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-02T09:57:34.764041Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-02T09:57:34.764127Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-02T09:57:34.768035Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-02T09:57:34.768353Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5f9f905057b5b268","initial-advertise-peer-urls":["https://199.19.213.117:2380"],"listen-peer-urls":["https://199.19.213.117:2380"],"advertise-client-urls":["https://199.19.213.117:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.117:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-02T09:57:34.76841Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-02T09:57:34.768469Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.117:2380"} {"level":"info","ts":"2026-07-02T09:57:34.768487Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.117:2380"} {"level":"info","ts":"2026-07-02T09:57:34.769676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 switched to configuration voters=(6890384629643457128)"} {"level":"info","ts":"2026-07-02T09:57:34.769857Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"293172f52aeb3f03","local-member-id":"5f9f905057b5b268","added-peer-id":"5f9f905057b5b268","added-peer-peer-urls":["https://199.19.213.117:2380"]} {"level":"info","ts":"2026-07-02T09:57:35.488621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 is starting a new election at term 1"} {"level":"info","ts":"2026-07-02T09:57:35.488752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-02T09:57:35.488801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 received MsgPreVoteResp from 5f9f905057b5b268 at term 1"} {"level":"info","ts":"2026-07-02T09:57:35.488826Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 became candidate at term 2"} {"level":"info","ts":"2026-07-02T09:57:35.488841Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 received MsgVoteResp from 5f9f905057b5b268 at term 2"} {"level":"info","ts":"2026-07-02T09:57:35.488877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 became leader at term 2"} {"level":"info","ts":"2026-07-02T09:57:35.488896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f9f905057b5b268 elected leader 5f9f905057b5b268 at term 2"} {"level":"info","ts":"2026-07-02T09:57:35.491089Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T09:57:35.491991Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T09:57:35.492006Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5f9f905057b5b268","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.117:2379]}","request-path":"/0/members/5f9f905057b5b268/attributes","cluster-id":"293172f52aeb3f03","publish-timeout":"7s"} {"level":"info","ts":"2026-07-02T09:57:35.49218Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T09:57:35.492673Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"293172f52aeb3f03","local-member-id":"5f9f905057b5b268","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T09:57:35.49279Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T09:57:35.492826Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T09:57:35.494254Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.117:2379"} {"level":"info","ts":"2026-07-02T09:57:35.495089Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-02T09:57:35.496657Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-02T09:57:35.496948Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-07-02T09:57:38.207102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.546599ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-02T09:57:38.20738Z","caller":"traceutil/trace.go:171","msg":"trace[99718367] transaction","detail":"{read_only:false; response_revision:84; number_of_response:1; }","duration":"318.389588ms","start":"2026-07-02T09:57:37.888937Z","end":"2026-07-02T09:57:38.207326Z","steps":["trace[99718367] 'process raft request' (duration: 34.991063ms)","trace[99718367] 'compare' (duration: 282.366357ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T09:57:38.207574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T09:57:37.888914Z","time spent":"318.564139ms","remote":"127.0.0.1:55362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":827,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T09:57:38.295541Z","caller":"traceutil/trace.go:171","msg":"trace[1175535485] transaction","detail":"{read_only:false; response_revision:85; number_of_response:1; }","duration":"390.472649ms","start":"2026-07-02T09:57:37.905005Z","end":"2026-07-02T09:57:38.295478Z","steps":["trace[1175535485] 'process raft request' (duration: 390.280268ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T09:57:38.295461Z","caller":"traceutil/trace.go:171","msg":"trace[1582420725] linearizableReadLoop","detail":"{readStateIndex:89; appliedIndex:88; }","duration":"352.491426ms","start":"2026-07-02T09:57:37.942938Z","end":"2026-07-02T09:57:38.29543Z","steps":["trace[1582420725] 'read index received' (duration: 352.299835ms)","trace[1582420725] 'applied index is now lower than readState.Index' (duration: 190.351µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T09:57:38.295729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.767298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-02T09:57:38.296694Z","caller":"traceutil/trace.go:171","msg":"trace[393730399] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:85; }","duration":"353.761606ms","start":"2026-07-02T09:57:37.942882Z","end":"2026-07-02T09:57:38.296643Z","steps":["trace[393730399] 'agreement among raft nodes before linearized reading' (duration: 352.738528ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T09:57:38.29614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T09:57:37.904974Z","time spent":"390.671021ms","remote":"127.0.0.1:55194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T09:57:38.296827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T09:57:37.942863Z","time spent":"353.923307ms","remote":"127.0.0.1:54996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-02T09:57:38.535228Z","caller":"traceutil/trace.go:171","msg":"trace[2062916411] transaction","detail":"{read_only:false; response_revision:86; number_of_response:1; }","duration":"231.781502ms","start":"2026-07-02T09:57:38.303417Z","end":"2026-07-02T09:57:38.535199Z","steps":["trace[2062916411] 'process raft request' (duration: 231.580751ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T09:58:13.594744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.782494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-07-02T09:58:13.594823Z","caller":"traceutil/trace.go:171","msg":"trace[512527838] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:602; }","duration":"195.871205ms","start":"2026-07-02T09:58:13.398934Z","end":"2026-07-02T09:58:13.594806Z","steps":["trace[512527838] 'range keys from in-memory index tree' (duration: 195.669414ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T09:58:19.044325Z","caller":"traceutil/trace.go:171","msg":"trace[2010183592] linearizableReadLoop","detail":"{readStateIndex:677; appliedIndex:676; }","duration":"114.657178ms","start":"2026-07-02T09:58:18.929639Z","end":"2026-07-02T09:58:19.044296Z","steps":["trace[2010183592] 'read index received' (duration: 114.410346ms)","trace[2010183592] 'applied index is now lower than readState.Index' (duration: 243.452µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T09:58:19.044376Z","caller":"traceutil/trace.go:171","msg":"trace[1068268739] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"253.561418ms","start":"2026-07-02T09:58:18.790781Z","end":"2026-07-02T09:58:19.044343Z","steps":["trace[1068268739] 'process raft request' (duration: 253.362026ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T09:58:19.04452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.867929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-846hf\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-02T09:58:19.044566Z","caller":"traceutil/trace.go:171","msg":"trace[1795267058] range","detail":"{range_begin:/registry/pods/kube-system/cilium-846hf; range_end:; response_count:1; response_revision:651; }","duration":"114.96193ms","start":"2026-07-02T09:58:18.929588Z","end":"2026-07-02T09:58:19.04455Z","steps":["trace[1795267058] 'agreement among raft nodes before linearized reading' (duration: 114.810019ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T09:58:19.178413Z","caller":"traceutil/trace.go:171","msg":"trace[16491169] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"118.854999ms","start":"2026-07-02T09:58:19.05952Z","end":"2026-07-02T09:58:19.178375Z","steps":["trace[16491169] 'process raft request' (duration: 118.311666ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T09:59:49.341184Z","caller":"traceutil/trace.go:171","msg":"trace[1586753757] linearizableReadLoop","detail":"{readStateIndex:1902; appliedIndex:1901; }","duration":"174.335833ms","start":"2026-07-02T09:59:49.166822Z","end":"2026-07-02T09:59:49.341157Z","steps":["trace[1586753757] 'read index received' (duration: 174.125008ms)","trace[1586753757] 'applied index is now lower than readState.Index' (duration: 209.005µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T09:59:49.341197Z","caller":"traceutil/trace.go:171","msg":"trace[87516643] transaction","detail":"{read_only:false; response_revision:1826; number_of_response:1; }","duration":"193.337209ms","start":"2026-07-02T09:59:49.147797Z","end":"2026-07-02T09:59:49.341134Z","steps":["trace[87516643] 'process raft request' (duration: 193.160294ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T09:59:49.341374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.526718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-07-02T09:59:49.341427Z","caller":"traceutil/trace.go:171","msg":"trace[932844998] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1826; }","duration":"174.634831ms","start":"2026-07-02T09:59:49.166779Z","end":"2026-07-02T09:59:49.341414Z","steps":["trace[932844998] 'agreement among raft nodes before linearized reading' (duration: 174.466216ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T09:59:49.593679Z","caller":"traceutil/trace.go:171","msg":"trace[973324342] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"176.738443ms","start":"2026-07-02T09:59:49.416901Z","end":"2026-07-02T09:59:49.593639Z","steps":["trace[973324342] 'process raft request' (duration: 168.087097ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T09:59:49.805869Z","caller":"traceutil/trace.go:171","msg":"trace[455380832] linearizableReadLoop","detail":"{readStateIndex:1907; appliedIndex:1906; }","duration":"108.187548ms","start":"2026-07-02T09:59:49.697656Z","end":"2026-07-02T09:59:49.805843Z","steps":["trace[455380832] 'read index received' (duration: 88.544516ms)","trace[455380832] 'applied index is now lower than readState.Index' (duration: 19.640222ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T09:59:49.805888Z","caller":"traceutil/trace.go:171","msg":"trace[1462501162] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"131.672015ms","start":"2026-07-02T09:59:49.674187Z","end":"2026-07-02T09:59:49.805859Z","steps":["trace[1462501162] 'process raft request' (duration: 111.965852ms)","trace[1462501162] 'compare' (duration: 19.5843ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T09:59:49.806127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.460235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-02T09:59:49.806143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.882964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-02T09:59:49.806174Z","caller":"traceutil/trace.go:171","msg":"trace[1333798021] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1830; }","duration":"108.562128ms","start":"2026-07-02T09:59:49.697599Z","end":"2026-07-02T09:59:49.806161Z","steps":["trace[1333798021] 'agreement among raft nodes before linearized reading' (duration: 108.366333ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T09:59:49.806187Z","caller":"traceutil/trace.go:171","msg":"trace[153289342] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1830; }","duration":"106.968517ms","start":"2026-07-02T09:59:49.699208Z","end":"2026-07-02T09:59:49.806176Z","steps":["trace[153289342] 'agreement among raft nodes before linearized reading' (duration: 106.803023ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:00:07.641573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.732307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:00:07.641629Z","caller":"traceutil/trace.go:171","msg":"trace[1114834179] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1969; }","duration":"100.84321ms","start":"2026-07-02T10:00:07.540774Z","end":"2026-07-02T10:00:07.641617Z","steps":["trace[1114834179] 'count revisions from in-memory index tree' (duration: 100.619755ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:00:44.752322Z","caller":"traceutil/trace.go:171","msg":"trace[223346162] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"198.274164ms","start":"2026-07-02T10:00:44.554016Z","end":"2026-07-02T10:00:44.75229Z","steps":["trace[223346162] 'process raft request' (duration: 188.258594ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:00:44.752687Z","caller":"traceutil/trace.go:171","msg":"trace[891920798] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"169.85518ms","start":"2026-07-02T10:00:44.582794Z","end":"2026-07-02T10:00:44.752649Z","steps":["trace[891920798] 'process raft request' (duration: 169.440113ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:01:20.558803Z","caller":"traceutil/trace.go:171","msg":"trace[1995699093] linearizableReadLoop","detail":"{readStateIndex:2567; appliedIndex:2566; }","duration":"194.221435ms","start":"2026-07-02T10:01:20.364557Z","end":"2026-07-02T10:01:20.558778Z","steps":["trace[1995699093] 'read index received' (duration: 194.011362ms)","trace[1995699093] 'applied index is now lower than readState.Index' (duration: 209.023µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:01:20.558879Z","caller":"traceutil/trace.go:171","msg":"trace[158778493] transaction","detail":"{read_only:false; response_revision:2470; number_of_response:1; }","duration":"197.052766ms","start":"2026-07-02T10:01:20.361784Z","end":"2026-07-02T10:01:20.558836Z","steps":["trace[158778493] 'process raft request' (duration: 196.866004ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:01:20.559005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.430048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-02T10:01:20.559041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.210836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-02T10:01:20.559062Z","caller":"traceutil/trace.go:171","msg":"trace[1196060391] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2470; }","duration":"194.493719ms","start":"2026-07-02T10:01:20.364541Z","end":"2026-07-02T10:01:20.559034Z","steps":["trace[1196060391] 'agreement among raft nodes before linearized reading' (duration: 194.358087ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:01:20.559078Z","caller":"traceutil/trace.go:171","msg":"trace[515564465] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2470; }","duration":"194.278646ms","start":"2026-07-02T10:01:20.364787Z","end":"2026-07-02T10:01:20.559066Z","steps":["trace[515564465] 'agreement among raft nodes before linearized reading' (duration: 194.123424ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:01:20.559126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.733736ms","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-07-02T10:01:20.559263Z","caller":"traceutil/trace.go:171","msg":"trace[117552817] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2470; }","duration":"108.810128ms","start":"2026-07-02T10:01:20.450349Z","end":"2026-07-02T10:01:20.559159Z","steps":["trace[117552817] 'agreement among raft nodes before linearized reading' (duration: 108.684846ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:01:53.735954Z","caller":"traceutil/trace.go:171","msg":"trace[1505933312] transaction","detail":"{read_only:false; response_revision:2654; number_of_response:1; }","duration":"117.261334ms","start":"2026-07-02T10:01:53.618667Z","end":"2026-07-02T10:01:53.735929Z","steps":["trace[1505933312] 'process raft request' (duration: 117.100552ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:01:54.145105Z","caller":"traceutil/trace.go:171","msg":"trace[1566924520] transaction","detail":"{read_only:false; response_revision:2655; number_of_response:1; }","duration":"173.52195ms","start":"2026-07-02T10:01:53.971557Z","end":"2026-07-02T10:01:54.145079Z","steps":["trace[1566924520] 'process raft request' (duration: 173.036083ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:01:54.313822Z","caller":"traceutil/trace.go:171","msg":"trace[588239293] transaction","detail":"{read_only:false; response_revision:2657; number_of_response:1; }","duration":"100.685761ms","start":"2026-07-02T10:01:54.21311Z","end":"2026-07-02T10:01:54.313796Z","steps":["trace[588239293] 'process raft request' (duration: 31.346141ms)","trace[588239293] 'compare' (duration: 69.237859ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:05:54.042727Z","caller":"traceutil/trace.go:171","msg":"trace[1966828155] transaction","detail":"{read_only:false; response_revision:4710; number_of_response:1; }","duration":"109.887481ms","start":"2026-07-02T10:05:53.932805Z","end":"2026-07-02T10:05:54.042693Z","steps":["trace[1966828155] 'process raft request' (duration: 109.733437ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:54.157676Z","caller":"traceutil/trace.go:171","msg":"trace[748644589] transaction","detail":"{read_only:false; response_revision:4711; number_of_response:1; }","duration":"108.239348ms","start":"2026-07-02T10:05:54.049409Z","end":"2026-07-02T10:05:54.157648Z","steps":["trace[748644589] 'process raft request' (duration: 99.219879ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:54.169377Z","caller":"traceutil/trace.go:171","msg":"trace[537684188] transaction","detail":"{read_only:false; response_revision:4713; number_of_response:1; }","duration":"118.012155ms","start":"2026-07-02T10:05:54.051349Z","end":"2026-07-02T10:05:54.169361Z","steps":["trace[537684188] 'process raft request' (duration: 117.945703ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:54.169374Z","caller":"traceutil/trace.go:171","msg":"trace[2104157581] transaction","detail":"{read_only:false; response_revision:4712; number_of_response:1; }","duration":"118.108846ms","start":"2026-07-02T10:05:54.051233Z","end":"2026-07-02T10:05:54.169342Z","steps":["trace[2104157581] 'process raft request' (duration: 117.951803ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:54.169543Z","caller":"traceutil/trace.go:171","msg":"trace[610454225] transaction","detail":"{read_only:false; response_revision:4714; number_of_response:1; }","duration":"117.645086ms","start":"2026-07-02T10:05:54.051887Z","end":"2026-07-02T10:05:54.169532Z","steps":["trace[610454225] 'process raft request' (duration: 117.434261ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:54.311313Z","caller":"traceutil/trace.go:171","msg":"trace[881567401] linearizableReadLoop","detail":"{readStateIndex:4902; appliedIndex:4900; }","duration":"128.152969ms","start":"2026-07-02T10:05:54.183136Z","end":"2026-07-02T10:05:54.311289Z","steps":["trace[881567401] 'read index received' (duration: 12.056669ms)","trace[881567401] 'applied index is now lower than readState.Index' (duration: 116.09518ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:05:54.311422Z","caller":"traceutil/trace.go:171","msg":"trace[213986783] transaction","detail":"{read_only:false; response_revision:4717; number_of_response:1; }","duration":"128.5769ms","start":"2026-07-02T10:05:54.18283Z","end":"2026-07-02T10:05:54.311407Z","steps":["trace[213986783] 'process raft request' (duration: 89.646588ms)","trace[213986783] 'compare' (duration: 38.696567ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:05:54.311712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.563498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-6aa8671b-b850-46e5-ae1d-7a2c56f35cdc\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-07-02T10:05:54.311795Z","caller":"traceutil/trace.go:171","msg":"trace[1833474409] range","detail":"{range_begin:/registry/persistentvolumes/pvc-6aa8671b-b850-46e5-ae1d-7a2c56f35cdc; range_end:; response_count:1; response_revision:4717; }","duration":"128.650061ms","start":"2026-07-02T10:05:54.183125Z","end":"2026-07-02T10:05:54.311775Z","steps":["trace[1833474409] 'agreement among raft nodes before linearized reading' (duration: 128.365944ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:06:25.838157Z","caller":"traceutil/trace.go:171","msg":"trace[608439523] transaction","detail":"{read_only:false; response_revision:5080; number_of_response:1; }","duration":"107.921733ms","start":"2026-07-02T10:06:25.730204Z","end":"2026-07-02T10:06:25.838125Z","steps":["trace[608439523] 'process raft request' (duration: 107.650887ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:06:26.466422Z","caller":"traceutil/trace.go:171","msg":"trace[1656791330] linearizableReadLoop","detail":"{readStateIndex:5286; appliedIndex:5285; }","duration":"132.699172ms","start":"2026-07-02T10:06:26.333693Z","end":"2026-07-02T10:06:26.466392Z","steps":["trace[1656791330] 'read index received' (duration: 132.531238ms)","trace[1656791330] 'applied index is now lower than readState.Index' (duration: 166.924µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:06:26.466541Z","caller":"traceutil/trace.go:171","msg":"trace[699443637] transaction","detail":"{read_only:false; response_revision:5090; number_of_response:1; }","duration":"142.606363ms","start":"2026-07-02T10:06:26.32391Z","end":"2026-07-02T10:06:26.466516Z","steps":["trace[699443637] 'process raft request' (duration: 142.343548ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:06:26.46665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.941806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-02T10:06:26.466686Z","caller":"traceutil/trace.go:171","msg":"trace[1103051229] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5090; }","duration":"133.034479ms","start":"2026-07-02T10:06:26.33364Z","end":"2026-07-02T10:06:26.466675Z","steps":["trace[1103051229] 'agreement among raft nodes before linearized reading' (duration: 132.876535ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:06:26.466871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.515168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-02T10:06:26.466961Z","caller":"traceutil/trace.go:171","msg":"trace[133957879] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5090; }","duration":"119.646531ms","start":"2026-07-02T10:06:26.347294Z","end":"2026-07-02T10:06:26.46694Z","steps":["trace[133957879] 'agreement among raft nodes before linearized reading' (duration: 119.430067ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:06:37.323563Z","caller":"traceutil/trace.go:171","msg":"trace[1624892401] transaction","detail":"{read_only:false; response_revision:5163; number_of_response:1; }","duration":"119.218312ms","start":"2026-07-02T10:06:37.204306Z","end":"2026-07-02T10:06:37.323524Z","steps":["trace[1624892401] 'process raft request' (duration: 118.980587ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:35.522082Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2875} {"level":"info","ts":"2026-07-02T10:07:35.611794Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2875,"took":"88.676165ms","hash":1973571176,"current-db-size-bytes":55021568,"current-db-size":"55 MB","current-db-size-in-use-bytes":30097408,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-02T10:07:35.611871Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1973571176,"revision":2875,"compact-revision":-1} {"level":"info","ts":"2026-07-02T10:09:31.68284Z","caller":"traceutil/trace.go:171","msg":"trace[206828273] transaction","detail":"{read_only:false; response_revision:6382; number_of_response:1; }","duration":"199.955768ms","start":"2026-07-02T10:09:31.48285Z","end":"2026-07-02T10:09:31.682806Z","steps":["trace[206828273] 'process raft request' (duration: 199.743385ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:09:31.724839Z","caller":"traceutil/trace.go:171","msg":"trace[991475365] linearizableReadLoop","detail":"{readStateIndex:6622; appliedIndex:6620; }","duration":"221.955871ms","start":"2026-07-02T10:09:31.502853Z","end":"2026-07-02T10:09:31.724809Z","steps":["trace[991475365] 'read index received' (duration: 179.782906ms)","trace[991475365] 'applied index is now lower than readState.Index' (duration: 42.171925ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:09:31.724982Z","caller":"traceutil/trace.go:171","msg":"trace[2100999642] transaction","detail":"{read_only:false; response_revision:6383; number_of_response:1; }","duration":"239.60281ms","start":"2026-07-02T10:09:31.485324Z","end":"2026-07-02T10:09:31.724927Z","steps":["trace[2100999642] 'process raft request' (duration: 239.319965ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:09:31.725163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.282756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-02T10:09:31.725342Z","caller":"traceutil/trace.go:171","msg":"trace[1385945120] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6383; }","duration":"222.443339ms","start":"2026-07-02T10:09:31.502835Z","end":"2026-07-02T10:09:31.725279Z","steps":["trace[1385945120] 'agreement among raft nodes before linearized reading' (duration: 222.125394ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:12:35.528422Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5595} {"level":"info","ts":"2026-07-02T10:12:35.601421Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5595,"took":"71.668891ms","hash":3100930856,"current-db-size-bytes":55021568,"current-db-size":"55 MB","current-db-size-in-use-bytes":18526208,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-02T10:12:35.601534Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3100930856,"revision":5595,"compact-revision":2875} {"level":"info","ts":"2026-07-02T10:17:35.533767Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7398} {"level":"info","ts":"2026-07-02T10:17:35.584438Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7398,"took":"49.592527ms","hash":2078927899,"current-db-size-bytes":55021568,"current-db-size":"55 MB","current-db-size-in-use-bytes":15040512,"current-db-size-in-use":"15 MB"} {"level":"info","ts":"2026-07-02T10:17:35.584496Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2078927899,"revision":7398,"compact-revision":5595}