{"level":"warn","ts":"2026-09-07T08:28:59.35906Z","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-07T08:28:59.359327Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.161: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.161:2380","--initial-cluster=instance=https://162.253.55.161:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.161:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.161: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-07T08:28:59.359428Z","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-07T08:28:59.359442Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.161:2380"]} {"level":"info","ts":"2026-09-07T08:28:59.359467Z","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-07T08:28:59.360158Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.161:2379"]} {"level":"info","ts":"2026-09-07T08:28:59.360273Z","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":16,"max-cpu-available":16,"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.161:2380"],"listen-peer-urls":["https://162.253.55.161:2380"],"advertise-client-urls":["https://162.253.55.161:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.161:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.161: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-07T08:28:59.364089Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.489722ms"} {"level":"info","ts":"2026-09-07T08:28:59.370415Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"383aa7db69884d67","cluster-id":"2ae15ce520a2ef1e"} {"level":"info","ts":"2026-09-07T08:28:59.370508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 switched to configuration voters=()"} {"level":"info","ts":"2026-09-07T08:28:59.370536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 became follower at term 0"} {"level":"info","ts":"2026-09-07T08:28:59.370552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 383aa7db69884d67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-07T08:28:59.370565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 became follower at term 1"} {"level":"info","ts":"2026-09-07T08:28:59.370604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 switched to configuration voters=(4051735375583399271)"} {"level":"warn","ts":"2026-09-07T08:28:59.377028Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-07T08:28:59.378436Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-07T08:28:59.379805Z","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-07T08:28:59.383406Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"383aa7db69884d67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-07T08:28:59.383729Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"383aa7db69884d67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-07T08:28:59.383907Z","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-07T08:28:59.384028Z","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-07T08:28:59.384051Z","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-07T08:28:59.385706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 switched to configuration voters=(4051735375583399271)"} {"level":"info","ts":"2026-09-07T08:28:59.386881Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2ae15ce520a2ef1e","local-member-id":"383aa7db69884d67","added-peer-id":"383aa7db69884d67","added-peer-peer-urls":["https://162.253.55.161:2380"]} {"level":"info","ts":"2026-09-07T08:28:59.38868Z","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-07T08:28:59.388822Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.161:2380"} {"level":"info","ts":"2026-09-07T08:28:59.388853Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.161:2380"} {"level":"info","ts":"2026-09-07T08:28:59.389163Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"383aa7db69884d67","initial-advertise-peer-urls":["https://162.253.55.161:2380"],"listen-peer-urls":["https://162.253.55.161:2380"],"advertise-client-urls":["https://162.253.55.161:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.161:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-07T08:28:59.38922Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-07T08:29:00.37112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 is starting a new election at term 1"} {"level":"info","ts":"2026-09-07T08:29:00.371164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-07T08:29:00.371187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 received MsgPreVoteResp from 383aa7db69884d67 at term 1"} {"level":"info","ts":"2026-09-07T08:29:00.371197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 became candidate at term 2"} {"level":"info","ts":"2026-09-07T08:29:00.371202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 received MsgVoteResp from 383aa7db69884d67 at term 2"} {"level":"info","ts":"2026-09-07T08:29:00.37121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 became leader at term 2"} {"level":"info","ts":"2026-09-07T08:29:00.371216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 383aa7db69884d67 elected leader 383aa7db69884d67 at term 2"} {"level":"info","ts":"2026-09-07T08:29:00.372796Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T08:29:00.372811Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"383aa7db69884d67","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.161:2379]}","request-path":"/0/members/383aa7db69884d67/attributes","cluster-id":"2ae15ce520a2ef1e","publish-timeout":"7s"} {"level":"info","ts":"2026-09-07T08:29:00.372822Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T08:29:00.372865Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T08:29:00.373123Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-07T08:29:00.373193Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-07T08:29:00.373976Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2ae15ce520a2ef1e","local-member-id":"383aa7db69884d67","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T08:29:00.374098Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T08:29:00.374139Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T08:29:00.374986Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.161:2379"} {"level":"info","ts":"2026-09-07T08:29:00.376659Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-09-07T08:29:16.630065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.463904ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T08:29:16.630353Z","caller":"traceutil/trace.go:171","msg":"trace[904702038] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"400.067906ms","start":"2026-09-07T08:29:16.23015Z","end":"2026-09-07T08:29:16.630218Z","steps":["trace[904702038] 'process raft request' (duration: 169.399324ms)","trace[904702038] 'compare' (duration: 228.151575ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:29:16.630523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:29:16.230129Z","time spent":"400.299072ms","remote":"127.0.0.1:40260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7096,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T08:29:27.610953Z","caller":"traceutil/trace.go:171","msg":"trace[1960905027] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"350.426875ms","start":"2026-09-07T08:29:27.260484Z","end":"2026-09-07T08:29:27.610911Z","steps":["trace[1960905027] 'process raft request' (duration: 350.103726ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:29:27.611147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:29:27.260445Z","time spent":"350.61082ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T08:29:27.852827Z","caller":"traceutil/trace.go:171","msg":"trace[1867401365] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"237.735352ms","start":"2026-09-07T08:29:27.615054Z","end":"2026-09-07T08:29:27.85279Z","steps":["trace[1867401365] 'process raft request' (duration: 178.139012ms)","trace[1867401365] 'compare' (duration: 59.364204ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:29:28.079663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.187857ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T08:29:28.079812Z","caller":"traceutil/trace.go:171","msg":"trace[1288652681] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"222.312728ms","start":"2026-09-07T08:29:27.857478Z","end":"2026-09-07T08:29:28.079791Z","steps":["trace[1288652681] 'process raft request' (duration: 117.884564ms)","trace[1288652681] 'compare' (duration: 103.92235ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:29:28.458433Z","caller":"traceutil/trace.go:171","msg":"trace[1152671531] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"119.065156ms","start":"2026-09-07T08:29:28.339341Z","end":"2026-09-07T08:29:28.458406Z","steps":["trace[1152671531] 'process raft request' (duration: 118.902672ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:29:45.336815Z","caller":"traceutil/trace.go:171","msg":"trace[726514686] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"275.142956ms","start":"2026-09-07T08:29:45.061636Z","end":"2026-09-07T08:29:45.336779Z","steps":["trace[726514686] 'process raft request' (duration: 270.83918ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:29:46.111271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.167475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-07T08:29:46.111339Z","caller":"traceutil/trace.go:171","msg":"trace[830444882] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:587; }","duration":"418.288568ms","start":"2026-09-07T08:29:45.693035Z","end":"2026-09-07T08:29:46.111324Z","steps":["trace[830444882] 'range keys from in-memory index tree' (duration: 418.029312ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:29:46.111366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:29:45.693011Z","time spent":"418.34846ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-07T08:29:46.113005Z","caller":"traceutil/trace.go:171","msg":"trace[490940140] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:611; }","duration":"174.953576ms","start":"2026-09-07T08:29:45.93802Z","end":"2026-09-07T08:29:46.112974Z","steps":["trace[490940140] 'read index received' (duration: 171.766581ms)","trace[490940140] 'applied index is now lower than readState.Index' (duration: 3.185965ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:29:46.11308Z","caller":"traceutil/trace.go:171","msg":"trace[848056917] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"232.583604ms","start":"2026-09-07T08:29:45.880473Z","end":"2026-09-07T08:29:46.113057Z","steps":["trace[848056917] 'process raft request' (duration: 230.115607ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:29:46.113194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.154702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-07T08:29:46.113226Z","caller":"traceutil/trace.go:171","msg":"trace[1971486607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:588; }","duration":"175.223024ms","start":"2026-09-07T08:29:45.937992Z","end":"2026-09-07T08:29:46.113215Z","steps":["trace[1971486607] 'agreement among raft nodes before linearized reading' (duration: 175.08746ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:29:46.122647Z","caller":"traceutil/trace.go:171","msg":"trace[1563112746] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"110.929438ms","start":"2026-09-07T08:29:46.011698Z","end":"2026-09-07T08:29:46.122628Z","steps":["trace[1563112746] 'process raft request' (duration: 110.841915ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:29:47.669767Z","caller":"traceutil/trace.go:171","msg":"trace[1986932113] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"119.351543ms","start":"2026-09-07T08:29:47.550367Z","end":"2026-09-07T08:29:47.669718Z","steps":["trace[1986932113] 'process raft request' (duration: 118.927752ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:30:47.295027Z","caller":"traceutil/trace.go:171","msg":"trace[801488821] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"274.786245ms","start":"2026-09-07T08:30:47.02021Z","end":"2026-09-07T08:30:47.294996Z","steps":["trace[801488821] 'process raft request' (duration: 274.645341ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:30:47.296113Z","caller":"traceutil/trace.go:171","msg":"trace[504219611] linearizableReadLoop","detail":"{readStateIndex:1344; appliedIndex:1342; }","duration":"125.827691ms","start":"2026-09-07T08:30:47.170258Z","end":"2026-09-07T08:30:47.296085Z","steps":["trace[504219611] 'read index received' (duration: 124.68667ms)","trace[504219611] 'applied index is now lower than readState.Index' (duration: 1.139821ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:30:47.296281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.001835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T08:30:47.296322Z","caller":"traceutil/trace.go:171","msg":"trace[1698825623] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1301; }","duration":"126.112468ms","start":"2026-09-07T08:30:47.170198Z","end":"2026-09-07T08:30:47.29631Z","steps":["trace[1698825623] 'agreement among raft nodes before linearized reading' (duration: 126.007455ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:30:47.296506Z","caller":"traceutil/trace.go:171","msg":"trace[606729395] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"157.192243ms","start":"2026-09-07T08:30:47.139286Z","end":"2026-09-07T08:30:47.296478Z","steps":["trace[606729395] 'process raft request' (duration: 156.68235ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:30:55.027377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.87045ms","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-07T08:30:55.027502Z","caller":"traceutil/trace.go:171","msg":"trace[748773252] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1428; }","duration":"115.045965ms","start":"2026-09-07T08:30:54.912433Z","end":"2026-09-07T08:30:55.027479Z","steps":["trace[748773252] 'range keys from in-memory index tree' (duration: 114.661424ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:31:21.191315Z","caller":"traceutil/trace.go:171","msg":"trace[936902531] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"279.398517ms","start":"2026-09-07T08:31:20.911886Z","end":"2026-09-07T08:31:21.191285Z","steps":["trace[936902531] 'process raft request' (duration: 279.218212ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:31:21.374488Z","caller":"traceutil/trace.go:171","msg":"trace[1410885007] linearizableReadLoop","detail":"{readStateIndex:1925; appliedIndex:1924; }","duration":"158.614201ms","start":"2026-09-07T08:31:21.215844Z","end":"2026-09-07T08:31:21.374458Z","steps":["trace[1410885007] 'read index received' (duration: 158.363335ms)","trace[1410885007] 'applied index is now lower than readState.Index' (duration: 249.716µs)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:31:21.374718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.865047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-09-07T08:31:21.374953Z","caller":"traceutil/trace.go:171","msg":"trace[849869431] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1851; }","duration":"159.154976ms","start":"2026-09-07T08:31:21.215778Z","end":"2026-09-07T08:31:21.374933Z","steps":["trace[849869431] 'agreement among raft nodes before linearized reading' (duration: 158.797496ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:31:21.374859Z","caller":"traceutil/trace.go:171","msg":"trace[1072050530] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"166.579012ms","start":"2026-09-07T08:31:21.208256Z","end":"2026-09-07T08:31:21.374835Z","steps":["trace[1072050530] 'process raft request' (duration: 165.976456ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:31:21.52108Z","caller":"traceutil/trace.go:171","msg":"trace[849514459] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"140.001167ms","start":"2026-09-07T08:31:21.381046Z","end":"2026-09-07T08:31:21.521047Z","steps":["trace[849514459] 'process raft request' (duration: 85.952372ms)","trace[849514459] 'compare' (duration: 53.921401ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:31:21.541534Z","caller":"traceutil/trace.go:171","msg":"trace[1438290096] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"159.901995ms","start":"2026-09-07T08:31:21.381613Z","end":"2026-09-07T08:31:21.541515Z","steps":["trace[1438290096] 'process raft request' (duration: 159.752971ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:31:21.541746Z","caller":"traceutil/trace.go:171","msg":"trace[465862036] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"159.684839ms","start":"2026-09-07T08:31:21.382049Z","end":"2026-09-07T08:31:21.541733Z","steps":["trace[465862036] 'process raft request' (duration: 159.411912ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:31:21.542133Z","caller":"traceutil/trace.go:171","msg":"trace[20442042] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"159.966517ms","start":"2026-09-07T08:31:21.382149Z","end":"2026-09-07T08:31:21.542115Z","steps":["trace[20442042] 'process raft request' (duration: 159.517515ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:31:21.542567Z","caller":"traceutil/trace.go:171","msg":"trace[2143113754] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"115.419153ms","start":"2026-09-07T08:31:21.427132Z","end":"2026-09-07T08:31:21.542551Z","steps":["trace[2143113754] 'process raft request' (duration: 114.959381ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:31:21.54216Z","caller":"traceutil/trace.go:171","msg":"trace[808490453] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"158.703194ms","start":"2026-09-07T08:31:21.383437Z","end":"2026-09-07T08:31:21.54214Z","steps":["trace[808490453] 'process raft request' (duration: 158.55928ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:31:34.21361Z","caller":"traceutil/trace.go:171","msg":"trace[2074753356] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"141.341003ms","start":"2026-09-07T08:31:34.07224Z","end":"2026-09-07T08:31:34.213581Z","steps":["trace[2074753356] 'process raft request' (duration: 140.87307ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:31:34.231021Z","caller":"traceutil/trace.go:171","msg":"trace[1461682404] transaction","detail":"{read_only:false; response_revision:1961; number_of_response:1; }","duration":"126.284573ms","start":"2026-09-07T08:31:34.104692Z","end":"2026-09-07T08:31:34.230977Z","steps":["trace[1461682404] 'process raft request' (duration: 125.956704ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:31:37.424957Z","caller":"traceutil/trace.go:171","msg":"trace[1198246633] transaction","detail":"{read_only:false; response_revision:1989; number_of_response:1; }","duration":"185.7929ms","start":"2026-09-07T08:31:37.239139Z","end":"2026-09-07T08:31:37.424932Z","steps":["trace[1198246633] 'process raft request' (duration: 185.653877ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:32:10.630861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.872637ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T08:32:10.631017Z","caller":"traceutil/trace.go:171","msg":"trace[717171484] linearizableReadLoop","detail":"{readStateIndex:2259; appliedIndex:2258; }","duration":"133.728807ms","start":"2026-09-07T08:32:10.497258Z","end":"2026-09-07T08:32:10.630986Z","steps":["trace[717171484] 'read index received' (duration: 67.912µs)","trace[717171484] 'applied index is now lower than readState.Index' (duration: 133.659425ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:32:10.631087Z","caller":"traceutil/trace.go:171","msg":"trace[866239558] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"184.468465ms","start":"2026-09-07T08:32:10.446565Z","end":"2026-09-07T08:32:10.631034Z","steps":["trace[866239558] 'process raft request' (duration: 27.33258ms)","trace[866239558] 'compare' (duration: 156.705693ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:32:10.631349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.071526ms","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-09-07T08:32:10.631458Z","caller":"traceutil/trace.go:171","msg":"trace[1767295203] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2173; }","duration":"134.261241ms","start":"2026-09-07T08:32:10.497172Z","end":"2026-09-07T08:32:10.631433Z","steps":["trace[1767295203] 'agreement among raft nodes before linearized reading' (duration: 133.887271ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:32:16.89566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.418643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-07T08:32:16.895775Z","caller":"traceutil/trace.go:171","msg":"trace[118806288] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2203; }","duration":"275.638839ms","start":"2026-09-07T08:32:16.620111Z","end":"2026-09-07T08:32:16.895749Z","steps":["trace[118806288] 'count revisions from in-memory index tree' (duration: 275.215898ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:32:16.895783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.187297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-07T08:32:16.895927Z","caller":"traceutil/trace.go:171","msg":"trace[1809100795] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:2203; }","duration":"242.514556ms","start":"2026-09-07T08:32:16.653389Z","end":"2026-09-07T08:32:16.895903Z","steps":["trace[1809100795] 'count revisions from in-memory index tree' (duration: 241.89333ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:32:16.896132Z","caller":"traceutil/trace.go:171","msg":"trace[795009042] linearizableReadLoop","detail":"{readStateIndex:2291; appliedIndex:2290; }","duration":"190.532515ms","start":"2026-09-07T08:32:16.705562Z","end":"2026-09-07T08:32:16.896094Z","steps":["trace[795009042] 'read index received' (duration: 126.62995ms)","trace[795009042] 'applied index is now lower than readState.Index' (duration: 63.900525ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:32:16.896182Z","caller":"traceutil/trace.go:171","msg":"trace[754124553] transaction","detail":"{read_only:false; response_revision:2204; number_of_response:1; }","duration":"241.278594ms","start":"2026-09-07T08:32:16.654875Z","end":"2026-09-07T08:32:16.896153Z","steps":["trace[754124553] 'process raft request' (duration: 177.289406ms)","trace[754124553] 'compare' (duration: 63.646019ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:32:16.896459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.873665ms","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-09-07T08:32:16.896509Z","caller":"traceutil/trace.go:171","msg":"trace[2045934523] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2204; }","duration":"190.997038ms","start":"2026-09-07T08:32:16.705498Z","end":"2026-09-07T08:32:16.896495Z","steps":["trace[2045934523] 'agreement among raft nodes before linearized reading' (duration: 190.737281ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:32:17.200329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.965108ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T08:32:17.20046Z","caller":"traceutil/trace.go:171","msg":"trace[1776185562] linearizableReadLoop","detail":"{readStateIndex:2292; appliedIndex:2291; }","duration":"255.752165ms","start":"2026-09-07T08:32:16.944687Z","end":"2026-09-07T08:32:17.200439Z","steps":["trace[1776185562] 'read index received' (duration: 59.407867ms)","trace[1776185562] 'applied index is now lower than readState.Index' (duration: 196.342598ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:32:17.200505Z","caller":"traceutil/trace.go:171","msg":"trace[1799446791] transaction","detail":"{read_only:false; response_revision:2205; number_of_response:1; }","duration":"297.217799ms","start":"2026-09-07T08:32:16.903236Z","end":"2026-09-07T08:32:17.200454Z","steps":["trace[1799446791] 'process raft request' (duration: 101.004904ms)","trace[1799446791] 'compare' (duration: 195.814584ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:32:17.200759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.636359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-07T08:32:17.200801Z","caller":"traceutil/trace.go:171","msg":"trace[1845934013] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2205; }","duration":"187.70427ms","start":"2026-09-07T08:32:17.013084Z","end":"2026-09-07T08:32:17.200788Z","steps":["trace[1845934013] 'agreement among raft nodes before linearized reading' (duration: 187.511525ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:32:17.200987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.037815ms","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-07T08:32:17.200974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.267948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-07T08:32:17.201029Z","caller":"traceutil/trace.go:171","msg":"trace[1798061729] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2205; }","duration":"181.138578ms","start":"2026-09-07T08:32:17.019881Z","end":"2026-09-07T08:32:17.201019Z","steps":["trace[1798061729] 'agreement among raft nodes before linearized reading' (duration: 180.934192ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:32:17.201023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.207097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-07T08:32:17.201054Z","caller":"traceutil/trace.go:171","msg":"trace[681572439] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2205; }","duration":"256.401813ms","start":"2026-09-07T08:32:16.94463Z","end":"2026-09-07T08:32:17.201032Z","steps":["trace[681572439] 'agreement among raft nodes before linearized reading' (duration: 255.90266ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:32:17.201084Z","caller":"traceutil/trace.go:171","msg":"trace[1416459969] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2205; }","duration":"132.32504ms","start":"2026-09-07T08:32:17.068742Z","end":"2026-09-07T08:32:17.201067Z","steps":["trace[1416459969] 'agreement among raft nodes before linearized reading' (duration: 132.029622ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:32:17.383619Z","caller":"traceutil/trace.go:171","msg":"trace[1911057034] transaction","detail":"{read_only:false; response_revision:2206; number_of_response:1; }","duration":"175.92089ms","start":"2026-09-07T08:32:17.207637Z","end":"2026-09-07T08:32:17.383558Z","steps":["trace[1911057034] 'process raft request' (duration: 168.318639ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:32:17.383907Z","caller":"traceutil/trace.go:171","msg":"trace[511636213] transaction","detail":"{read_only:false; response_revision:2208; number_of_response:1; }","duration":"175.490538ms","start":"2026-09-07T08:32:17.208386Z","end":"2026-09-07T08:32:17.383876Z","steps":["trace[511636213] 'process raft request' (duration: 175.264912ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:32:17.38387Z","caller":"traceutil/trace.go:171","msg":"trace[1797114597] transaction","detail":"{read_only:false; response_revision:2207; number_of_response:1; }","duration":"176.069464ms","start":"2026-09-07T08:32:17.207758Z","end":"2026-09-07T08:32:17.383827Z","steps":["trace[1797114597] 'process raft request' (duration: 175.701514ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:32:52.791733Z","caller":"traceutil/trace.go:171","msg":"trace[51411099] linearizableReadLoop","detail":"{readStateIndex:2675; appliedIndex:2674; }","duration":"135.476704ms","start":"2026-09-07T08:32:52.656235Z","end":"2026-09-07T08:32:52.791711Z","steps":["trace[51411099] 'read index received' (duration: 135.249668ms)","trace[51411099] 'applied index is now lower than readState.Index' (duration: 224.156µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:32:52.79201Z","caller":"traceutil/trace.go:171","msg":"trace[554841001] transaction","detail":"{read_only:false; response_revision:2574; number_of_response:1; }","duration":"210.370701ms","start":"2026-09-07T08:32:52.581624Z","end":"2026-09-07T08:32:52.791995Z","steps":["trace[554841001] 'process raft request' (duration: 209.961901ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:32:52.792222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.976428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-07T08:32:52.792254Z","caller":"traceutil/trace.go:171","msg":"trace[567551978] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:2574; }","duration":"136.06113ms","start":"2026-09-07T08:32:52.656183Z","end":"2026-09-07T08:32:52.792244Z","steps":["trace[567551978] 'agreement among raft nodes before linearized reading' (duration: 135.989718ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:33:25.871448Z","caller":"traceutil/trace.go:171","msg":"trace[397274360] linearizableReadLoop","detail":"{readStateIndex:2883; appliedIndex:2882; }","duration":"102.424367ms","start":"2026-09-07T08:33:25.769006Z","end":"2026-09-07T08:33:25.87143Z","steps":["trace[397274360] 'read index received' (duration: 102.309914ms)","trace[397274360] 'applied index is now lower than readState.Index' (duration: 113.833µs)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:33:25.871629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.607092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-07T08:33:25.871656Z","caller":"traceutil/trace.go:171","msg":"trace[1252823361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2774; }","duration":"102.666354ms","start":"2026-09-07T08:33:25.768982Z","end":"2026-09-07T08:33:25.871649Z","steps":["trace[1252823361] 'agreement among raft nodes before linearized reading' (duration: 102.560691ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:33:25.871683Z","caller":"traceutil/trace.go:171","msg":"trace[366749946] transaction","detail":"{read_only:false; response_revision:2774; number_of_response:1; }","duration":"104.857192ms","start":"2026-09-07T08:33:25.766628Z","end":"2026-09-07T08:33:25.871485Z","steps":["trace[366749946] 'process raft request' (duration: 104.693378ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:33:26.338106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.402408ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T08:33:26.338217Z","caller":"traceutil/trace.go:171","msg":"trace[345522000] linearizableReadLoop","detail":"{readStateIndex:2886; appliedIndex:2885; }","duration":"172.447525ms","start":"2026-09-07T08:33:26.165753Z","end":"2026-09-07T08:33:26.3382Z","steps":["trace[345522000] 'read index received' (duration: 6.743119ms)","trace[345522000] 'applied index is now lower than readState.Index' (duration: 165.702636ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:33:26.338381Z","caller":"traceutil/trace.go:171","msg":"trace[1784846073] transaction","detail":"{read_only:false; response_revision:2777; number_of_response:1; }","duration":"286.677996ms","start":"2026-09-07T08:33:26.051642Z","end":"2026-09-07T08:33:26.33832Z","steps":["trace[1784846073] 'process raft request' (duration: 120.976849ms)","trace[1784846073] 'compare' (duration: 165.180653ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:33:26.338399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.615359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T08:33:26.338566Z","caller":"traceutil/trace.go:171","msg":"trace[2121896726] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2777; }","duration":"172.785734ms","start":"2026-09-07T08:33:26.16571Z","end":"2026-09-07T08:33:26.338496Z","steps":["trace[2121896726] 'agreement among raft nodes before linearized reading' (duration: 172.559018ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:33:26.558674Z","caller":"traceutil/trace.go:171","msg":"trace[1365107034] transaction","detail":"{read_only:false; response_revision:2779; number_of_response:1; }","duration":"203.808167ms","start":"2026-09-07T08:33:26.354839Z","end":"2026-09-07T08:33:26.558647Z","steps":["trace[1365107034] 'process raft request' (duration: 197.753506ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:36:34.086986Z","caller":"traceutil/trace.go:171","msg":"trace[603557360] linearizableReadLoop","detail":"{readStateIndex:4123; appliedIndex:4122; }","duration":"113.78921ms","start":"2026-09-07T08:36:33.973159Z","end":"2026-09-07T08:36:34.086949Z","steps":["trace[603557360] 'read index received' (duration: 113.521153ms)","trace[603557360] 'applied index is now lower than readState.Index' (duration: 266.577µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:36:34.087079Z","caller":"traceutil/trace.go:171","msg":"trace[153524156] transaction","detail":"{read_only:false; response_revision:3970; number_of_response:1; }","duration":"121.568887ms","start":"2026-09-07T08:36:33.965479Z","end":"2026-09-07T08:36:34.087048Z","steps":["trace[153524156] 'process raft request' (duration: 121.28811ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:36:34.087432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.980915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T08:36:34.087501Z","caller":"traceutil/trace.go:171","msg":"trace[1503794357] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:3970; }","duration":"114.371116ms","start":"2026-09-07T08:36:33.973111Z","end":"2026-09-07T08:36:34.087482Z","steps":["trace[1503794357] 'agreement among raft nodes before linearized reading' (duration: 113.959195ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:38:01.527946Z","caller":"traceutil/trace.go:171","msg":"trace[1083798499] linearizableReadLoop","detail":"{readStateIndex:5226; appliedIndex:5225; }","duration":"281.884126ms","start":"2026-09-07T08:38:01.246029Z","end":"2026-09-07T08:38:01.527913Z","steps":["trace[1083798499] 'read index received' (duration: 231.401058ms)","trace[1083798499] 'applied index is now lower than readState.Index' (duration: 50.481898ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:38:01.528279Z","caller":"traceutil/trace.go:171","msg":"trace[487177620] transaction","detail":"{read_only:false; response_revision:5030; number_of_response:1; }","duration":"303.38897ms","start":"2026-09-07T08:38:01.224682Z","end":"2026-09-07T08:38:01.528071Z","steps":["trace[487177620] 'process raft request' (duration: 252.736188ms)","trace[487177620] 'compare' (duration: 50.348094ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:38:01.528363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.516011ms","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":"warn","ts":"2026-09-07T08:38:01.528418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:38:01.224658Z","time spent":"303.671128ms","remote":"127.0.0.1:45602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2573,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-07T08:38:01.528433Z","caller":"traceutil/trace.go:171","msg":"trace[1870230597] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5030; }","duration":"310.639705ms","start":"2026-09-07T08:38:01.217781Z","end":"2026-09-07T08:38:01.528421Z","steps":["trace[1870230597] 'agreement among raft nodes before linearized reading' (duration: 310.421699ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:38:01.528479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:38:01.217764Z","time spent":"310.708026ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-07T08:38:01.550647Z","caller":"traceutil/trace.go:171","msg":"trace[1830617755] transaction","detail":"{read_only:false; response_revision:5034; number_of_response:1; }","duration":"174.343265ms","start":"2026-09-07T08:38:01.376282Z","end":"2026-09-07T08:38:01.550625Z","steps":["trace[1830617755] 'process raft request' (duration: 174.280244ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:38:01.550659Z","caller":"traceutil/trace.go:171","msg":"trace[1648758543] transaction","detail":"{read_only:false; response_revision:5033; number_of_response:1; }","duration":"183.030248ms","start":"2026-09-07T08:38:01.367598Z","end":"2026-09-07T08:38:01.550629Z","steps":["trace[1648758543] 'process raft request' (duration: 182.913144ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:38:01.550695Z","caller":"traceutil/trace.go:171","msg":"trace[1032482981] transaction","detail":"{read_only:false; response_revision:5032; number_of_response:1; }","duration":"293.112197ms","start":"2026-09-07T08:38:01.257552Z","end":"2026-09-07T08:38:01.550664Z","steps":["trace[1032482981] 'process raft request' (duration: 292.920241ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:38:01.550822Z","caller":"traceutil/trace.go:171","msg":"trace[932759740] transaction","detail":"{read_only:false; response_revision:5031; number_of_response:1; }","duration":"293.25643ms","start":"2026-09-07T08:38:01.257552Z","end":"2026-09-07T08:38:01.550808Z","steps":["trace[932759740] 'process raft request' (duration: 292.771577ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:38:01.550905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.348691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-07T08:38:01.55097Z","caller":"traceutil/trace.go:171","msg":"trace[340278830] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5034; }","duration":"254.444453ms","start":"2026-09-07T08:38:01.296513Z","end":"2026-09-07T08:38:01.550957Z","steps":["trace[340278830] 'agreement among raft nodes before linearized reading' (duration: 254.30155ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:38:01.551074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.756437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-32d362f4-44e6-4c46-8ec1-e74445a03bdf\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-09-07T08:38:01.551119Z","caller":"traceutil/trace.go:171","msg":"trace[47954222] range","detail":"{range_begin:/registry/persistentvolumes/pvc-32d362f4-44e6-4c46-8ec1-e74445a03bdf; range_end:; response_count:1; response_revision:5034; }","duration":"301.87379ms","start":"2026-09-07T08:38:01.249233Z","end":"2026-09-07T08:38:01.551107Z","steps":["trace[47954222] 'agreement among raft nodes before linearized reading' (duration: 301.588863ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:38:01.551173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:38:01.249219Z","time spent":"301.946202ms","remote":"127.0.0.1:40218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1457,"request content":"key:\"/registry/persistentvolumes/pvc-32d362f4-44e6-4c46-8ec1-e74445a03bdf\" "} {"level":"info","ts":"2026-09-07T08:38:03.146465Z","caller":"traceutil/trace.go:171","msg":"trace[1736529540] transaction","detail":"{read_only:false; response_revision:5152; number_of_response:1; }","duration":"100.903684ms","start":"2026-09-07T08:38:03.045543Z","end":"2026-09-07T08:38:03.146447Z","steps":["trace[1736529540] 'process raft request' (duration: 100.788061ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:38:03.20619Z","caller":"traceutil/trace.go:171","msg":"trace[1636810367] linearizableReadLoop","detail":"{readStateIndex:5349; appliedIndex:5347; }","duration":"118.735641ms","start":"2026-09-07T08:38:03.087434Z","end":"2026-09-07T08:38:03.20617Z","steps":["trace[1636810367] 'read index received' (duration: 58.956965ms)","trace[1636810367] 'applied index is now lower than readState.Index' (duration: 59.777826ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:38:03.206421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.971687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-07T08:38:03.206464Z","caller":"traceutil/trace.go:171","msg":"trace[183768001] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:5153; }","duration":"119.068199ms","start":"2026-09-07T08:38:03.087384Z","end":"2026-09-07T08:38:03.206452Z","steps":["trace[183768001] 'agreement among raft nodes before linearized reading' (duration: 118.930186ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:38:03.206807Z","caller":"traceutil/trace.go:171","msg":"trace[1407949610] transaction","detail":"{read_only:false; response_revision:5153; number_of_response:1; }","duration":"152.384279ms","start":"2026-09-07T08:38:03.053869Z","end":"2026-09-07T08:38:03.206253Z","steps":["trace[1407949610] 'process raft request' (duration: 150.430647ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:38:18.166789Z","caller":"traceutil/trace.go:171","msg":"trace[1468691682] linearizableReadLoop","detail":"{readStateIndex:5640; appliedIndex:5639; }","duration":"125.065389ms","start":"2026-09-07T08:38:18.041691Z","end":"2026-09-07T08:38:18.166756Z","steps":["trace[1468691682] 'read index received' (duration: 124.806192ms)","trace[1468691682] 'applied index is now lower than readState.Index' (duration: 257.897µs)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:38:18.16708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.364907ms","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-07T08:38:18.167126Z","caller":"traceutil/trace.go:171","msg":"trace[1769924421] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5435; }","duration":"125.430129ms","start":"2026-09-07T08:38:18.041685Z","end":"2026-09-07T08:38:18.167115Z","steps":["trace[1769924421] 'agreement among raft nodes before linearized reading' (duration: 125.228994ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:38:18.167597Z","caller":"traceutil/trace.go:171","msg":"trace[872572094] transaction","detail":"{read_only:false; response_revision:5435; number_of_response:1; }","duration":"154.979698ms","start":"2026-09-07T08:38:18.012599Z","end":"2026-09-07T08:38:18.167579Z","steps":["trace[872572094] 'process raft request' (duration: 153.988532ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:38:25.843893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.581202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T08:38:25.84409Z","caller":"traceutil/trace.go:171","msg":"trace[468215726] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:5605; }","duration":"186.852399ms","start":"2026-09-07T08:38:25.657218Z","end":"2026-09-07T08:38:25.844071Z","steps":["trace[468215726] 'count revisions from in-memory index tree' (duration: 186.470208ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:38:25.843937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.606719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2d79c19d-f481-4785-b1a6-5777ae9af9ee\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-09-07T08:38:25.844357Z","caller":"traceutil/trace.go:171","msg":"trace[1436416894] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2d79c19d-f481-4785-b1a6-5777ae9af9ee; range_end:; response_count:1; response_revision:5605; }","duration":"197.078722ms","start":"2026-09-07T08:38:25.647221Z","end":"2026-09-07T08:38:25.8443Z","steps":["trace[1436416894] 'range keys from in-memory index tree' (duration: 196.326512ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:38:25.871441Z","caller":"traceutil/trace.go:171","msg":"trace[1864941074] transaction","detail":"{read_only:false; response_revision:5606; number_of_response:1; }","duration":"196.656491ms","start":"2026-09-07T08:38:25.674752Z","end":"2026-09-07T08:38:25.871408Z","steps":["trace[1864941074] 'process raft request' (duration: 196.455516ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:38:26.103289Z","caller":"traceutil/trace.go:171","msg":"trace[1845498533] linearizableReadLoop","detail":"{readStateIndex:5816; appliedIndex:5814; }","duration":"266.744392ms","start":"2026-09-07T08:38:25.836515Z","end":"2026-09-07T08:38:26.10326Z","steps":["trace[1845498533] 'read index received' (duration: 34.674986ms)","trace[1845498533] 'applied index is now lower than readState.Index' (duration: 232.067996ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:38:26.103291Z","caller":"traceutil/trace.go:171","msg":"trace[384675112] transaction","detail":"{read_only:false; response_revision:5607; number_of_response:1; }","duration":"398.319985ms","start":"2026-09-07T08:38:25.704928Z","end":"2026-09-07T08:38:26.103248Z","steps":["trace[384675112] 'process raft request' (duration: 330.511565ms)","trace[384675112] 'compare' (duration: 67.675127ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:38:26.10355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.02473ms","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-07T08:38:26.103632Z","caller":"traceutil/trace.go:171","msg":"trace[705127060] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5607; }","duration":"267.152313ms","start":"2026-09-07T08:38:25.836464Z","end":"2026-09-07T08:38:26.103616Z","steps":["trace[705127060] 'agreement among raft nodes before linearized reading' (duration: 266.932417ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:38:26.103889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.258352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-09-07T08:38:26.103932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:38:25.704896Z","time spent":"398.574862ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T08:38:26.103976Z","caller":"traceutil/trace.go:171","msg":"trace[490660239] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5607; }","duration":"253.384335ms","start":"2026-09-07T08:38:25.85057Z","end":"2026-09-07T08:38:26.103954Z","steps":["trace[490660239] 'agreement among raft nodes before linearized reading' (duration: 253.026775ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:38:26.10402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.837694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-09-07T08:38:26.104215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.118415ms","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-09-07T08:38:26.104294Z","caller":"traceutil/trace.go:171","msg":"trace[1626751905] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5607; }","duration":"254.254569ms","start":"2026-09-07T08:38:25.850022Z","end":"2026-09-07T08:38:26.104276Z","steps":["trace[1626751905] 'agreement among raft nodes before linearized reading' (duration: 253.996572ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:38:26.1043Z","caller":"traceutil/trace.go:171","msg":"trace[1774732159] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5607; }","duration":"267.092641ms","start":"2026-09-07T08:38:25.83717Z","end":"2026-09-07T08:38:26.104263Z","steps":["trace[1774732159] 'agreement among raft nodes before linearized reading' (duration: 266.762972ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:38:37.689989Z","caller":"traceutil/trace.go:171","msg":"trace[844657621] transaction","detail":"{read_only:false; response_revision:5746; number_of_response:1; }","duration":"152.210854ms","start":"2026-09-07T08:38:37.537747Z","end":"2026-09-07T08:38:37.689958Z","steps":["trace[844657621] 'process raft request' (duration: 152.100161ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:38:37.68999Z","caller":"traceutil/trace.go:171","msg":"trace[1469039175] transaction","detail":"{read_only:false; response_revision:5745; number_of_response:1; }","duration":"152.816621ms","start":"2026-09-07T08:38:37.537137Z","end":"2026-09-07T08:38:37.689954Z","steps":["trace[1469039175] 'process raft request' (duration: 99.661212ms)","trace[1469039175] 'compare' (duration: 52.896662ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:38:37.690039Z","caller":"traceutil/trace.go:171","msg":"trace[1700919290] transaction","detail":"{read_only:false; response_revision:5747; number_of_response:1; }","duration":"151.776132ms","start":"2026-09-07T08:38:37.538247Z","end":"2026-09-07T08:38:37.690024Z","steps":["trace[1700919290] 'process raft request' (duration: 151.663629ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:39:00.410644Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2964} {"level":"info","ts":"2026-09-07T08:39:00.491869Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2964,"took":"79.643576ms","hash":2783041799,"current-db-size-bytes":57184256,"current-db-size":"57 MB","current-db-size-in-use-bytes":32174080,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-07T08:39:00.49201Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2783041799,"revision":2964,"compact-revision":-1} {"level":"info","ts":"2026-09-07T08:39:18.292918Z","caller":"traceutil/trace.go:171","msg":"trace[374266933] linearizableReadLoop","detail":"{readStateIndex:6320; appliedIndex:6318; }","duration":"121.83701ms","start":"2026-09-07T08:39:18.17105Z","end":"2026-09-07T08:39:18.292887Z","steps":["trace[374266933] 'read index received' (duration: 74.305156ms)","trace[374266933] 'applied index is now lower than readState.Index' (duration: 47.530074ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:39:18.293033Z","caller":"traceutil/trace.go:171","msg":"trace[37018825] transaction","detail":"{read_only:false; response_revision:6097; number_of_response:1; }","duration":"130.342905ms","start":"2026-09-07T08:39:18.162646Z","end":"2026-09-07T08:39:18.292989Z","steps":["trace[37018825] 'process raft request' (duration: 130.022727ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:39:18.293136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.084166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T08:39:18.293195Z","caller":"traceutil/trace.go:171","msg":"trace[798667611] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6097; }","duration":"122.206809ms","start":"2026-09-07T08:39:18.170971Z","end":"2026-09-07T08:39:18.293178Z","steps":["trace[798667611] 'agreement among raft nodes before linearized reading' (duration: 122.102077ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:42:47.679018Z","caller":"traceutil/trace.go:171","msg":"trace[2023524060] linearizableReadLoop","detail":"{readStateIndex:7749; appliedIndex:7748; }","duration":"100.929494ms","start":"2026-09-07T08:42:47.578068Z","end":"2026-09-07T08:42:47.678997Z","steps":["trace[2023524060] 'read index received' (duration: 100.813931ms)","trace[2023524060] 'applied index is now lower than readState.Index' (duration: 114.493µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:42:47.679097Z","caller":"traceutil/trace.go:171","msg":"trace[1271678475] transaction","detail":"{read_only:false; response_revision:7477; number_of_response:1; }","duration":"108.056925ms","start":"2026-09-07T08:42:47.571003Z","end":"2026-09-07T08:42:47.67906Z","steps":["trace[1271678475] 'process raft request' (duration: 107.838889ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:42:47.679236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.1401ms","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-07T08:42:47.679313Z","caller":"traceutil/trace.go:171","msg":"trace[235153740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7477; }","duration":"101.260383ms","start":"2026-09-07T08:42:47.578039Z","end":"2026-09-07T08:42:47.679299Z","steps":["trace[235153740] 'agreement among raft nodes before linearized reading' (duration: 101.066968ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:42:47.713407Z","caller":"traceutil/trace.go:171","msg":"trace[1437756053] transaction","detail":"{read_only:false; response_revision:7478; number_of_response:1; }","duration":"120.167008ms","start":"2026-09-07T08:42:47.593212Z","end":"2026-09-07T08:42:47.713379Z","steps":["trace[1437756053] 'process raft request' (duration: 119.945622ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:44:00.420139Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5898} {"level":"info","ts":"2026-09-07T08:44:00.519931Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5898,"took":"97.954987ms","hash":2599960341,"current-db-size-bytes":57184256,"current-db-size":"57 MB","current-db-size-in-use-bytes":25931776,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-07T08:44:00.52Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2599960341,"revision":5898,"compact-revision":2964} {"level":"warn","ts":"2026-09-07T08:44:58.9548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.716295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-09-07T08:44:58.954929Z","caller":"traceutil/trace.go:171","msg":"trace[1160893774] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8554; }","duration":"474.835028ms","start":"2026-09-07T08:44:58.480051Z","end":"2026-09-07T08:44:58.954886Z","steps":["trace[1160893774] 'range keys from in-memory index tree' (duration: 474.485658ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:44:58.954985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:44:58.479999Z","time spent":"474.970431ms","remote":"127.0.0.1:40260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-09-07T08:44:58.95512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.217514ms","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-09-07T08:44:58.9552Z","caller":"traceutil/trace.go:171","msg":"trace[1686207413] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8554; }","duration":"411.324687ms","start":"2026-09-07T08:44:58.543853Z","end":"2026-09-07T08:44:58.955178Z","steps":["trace[1686207413] 'range keys from in-memory index tree' (duration: 411.05419ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:44:58.955222Z","caller":"traceutil/trace.go:171","msg":"trace[1979492023] linearizableReadLoop","detail":"{readStateIndex:8861; appliedIndex:8860; }","duration":"298.469793ms","start":"2026-09-07T08:44:58.656729Z","end":"2026-09-07T08:44:58.955199Z","steps":["trace[1979492023] 'read index received' (duration: 267.286553ms)","trace[1979492023] 'applied index is now lower than readState.Index' (duration: 31.18177ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:44:58.955279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:44:58.54384Z","time spent":"411.395659ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-07T08:44:58.955543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.828793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-09-07T08:44:58.955563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.591111ms","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-09-07T08:44:58.955597Z","caller":"traceutil/trace.go:171","msg":"trace[2090007899] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8555; }","duration":"291.648112ms","start":"2026-09-07T08:44:58.663938Z","end":"2026-09-07T08:44:58.955586Z","steps":["trace[2090007899] 'agreement among raft nodes before linearized reading' (duration: 291.55152ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:44:58.9556Z","caller":"traceutil/trace.go:171","msg":"trace[1725588720] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8555; }","duration":"298.961136ms","start":"2026-09-07T08:44:58.656621Z","end":"2026-09-07T08:44:58.955582Z","steps":["trace[1725588720] 'agreement among raft nodes before linearized reading' (duration: 298.821213ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:44:58.95573Z","caller":"traceutil/trace.go:171","msg":"trace[321247466] transaction","detail":"{read_only:false; response_revision:8555; number_of_response:1; }","duration":"346.347008ms","start":"2026-09-07T08:44:58.609364Z","end":"2026-09-07T08:44:58.955711Z","steps":["trace[321247466] 'process raft request' (duration: 314.749657ms)","trace[321247466] 'compare' (duration: 30.609514ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:44:58.955835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:44:58.609341Z","time spent":"346.422399ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T08:44:58.955933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.020734ms","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-07T08:44:58.955972Z","caller":"traceutil/trace.go:171","msg":"trace[1101301427] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8555; }","duration":"238.078426ms","start":"2026-09-07T08:44:58.717882Z","end":"2026-09-07T08:44:58.955961Z","steps":["trace[1101301427] 'agreement among raft nodes before linearized reading' (duration: 237.981484ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:44:58.956494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.388248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-07T08:44:58.956604Z","caller":"traceutil/trace.go:171","msg":"trace[682785782] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8555; }","duration":"240.544012ms","start":"2026-09-07T08:44:58.716033Z","end":"2026-09-07T08:44:58.956577Z","steps":["trace[682785782] 'agreement among raft nodes before linearized reading' (duration: 240.127831ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:45:10.515676Z","caller":"traceutil/trace.go:171","msg":"trace[987315882] transaction","detail":"{read_only:false; response_revision:8618; number_of_response:1; }","duration":"131.15903ms","start":"2026-09-07T08:45:10.384453Z","end":"2026-09-07T08:45:10.515612Z","steps":["trace[987315882] 'process raft request' (duration: 130.749279ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:45:11.274325Z","caller":"traceutil/trace.go:171","msg":"trace[1904647683] linearizableReadLoop","detail":"{readStateIndex:8928; appliedIndex:8927; }","duration":"133.150084ms","start":"2026-09-07T08:45:11.141148Z","end":"2026-09-07T08:45:11.274298Z","steps":["trace[1904647683] 'read index received' (duration: 132.98011ms)","trace[1904647683] 'applied index is now lower than readState.Index' (duration: 168.884µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:45:11.274452Z","caller":"traceutil/trace.go:171","msg":"trace[675263708] transaction","detail":"{read_only:false; response_revision:8619; number_of_response:1; }","duration":"135.540968ms","start":"2026-09-07T08:45:11.138857Z","end":"2026-09-07T08:45:11.274398Z","steps":["trace[675263708] 'process raft request' (duration: 135.23724ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:45:11.274564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.769104ms","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-07T08:45:11.274613Z","caller":"traceutil/trace.go:171","msg":"trace[303224429] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8619; }","duration":"132.853436ms","start":"2026-09-07T08:45:11.141744Z","end":"2026-09-07T08:45:11.274597Z","steps":["trace[303224429] 'agreement among raft nodes before linearized reading' (duration: 132.707172ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:45:11.274607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.436301ms","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-07T08:45:11.274704Z","caller":"traceutil/trace.go:171","msg":"trace[901646498] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8619; }","duration":"133.587545ms","start":"2026-09-07T08:45:11.141092Z","end":"2026-09-07T08:45:11.27468Z","steps":["trace[901646498] 'agreement among raft nodes before linearized reading' (duration: 133.309508ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:45:11.2747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.706445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-09-07T08:45:11.274712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.866743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-07T08:45:11.274763Z","caller":"traceutil/trace.go:171","msg":"trace[629976023] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8619; }","duration":"131.846469ms","start":"2026-09-07T08:45:11.142901Z","end":"2026-09-07T08:45:11.274748Z","steps":["trace[629976023] 'agreement among raft nodes before linearized reading' (duration: 131.684625ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:45:11.274777Z","caller":"traceutil/trace.go:171","msg":"trace[343356359] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8619; }","duration":"130.952055ms","start":"2026-09-07T08:45:11.143807Z","end":"2026-09-07T08:45:11.274759Z","steps":["trace[343356359] 'agreement among raft nodes before linearized reading' (duration: 130.778101ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:45:11.990228Z","caller":"traceutil/trace.go:171","msg":"trace[1392898673] transaction","detail":"{read_only:false; response_revision:8624; number_of_response:1; }","duration":"317.798798ms","start":"2026-09-07T08:45:11.672374Z","end":"2026-09-07T08:45:11.990172Z","steps":["trace[1392898673] 'process raft request' (duration: 317.612463ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:45:11.99047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:45:11.672351Z","time spent":"318.039144ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T08:45:12.06002Z","caller":"traceutil/trace.go:171","msg":"trace[1219137549] transaction","detail":"{read_only:false; response_revision:8625; number_of_response:1; }","duration":"285.95151ms","start":"2026-09-07T08:45:11.77402Z","end":"2026-09-07T08:45:12.059971Z","steps":["trace[1219137549] 'process raft request' (duration: 285.763115ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:45:12.060185Z","caller":"traceutil/trace.go:171","msg":"trace[454208468] linearizableReadLoop","detail":"{readStateIndex:8935; appliedIndex:8932; }","duration":"193.854939ms","start":"2026-09-07T08:45:11.866303Z","end":"2026-09-07T08:45:12.060158Z","steps":["trace[454208468] 'read index received' (duration: 123.682881ms)","trace[454208468] 'applied index is now lower than readState.Index' (duration: 70.170348ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:45:12.06034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.043994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-07T08:45:12.060373Z","caller":"traceutil/trace.go:171","msg":"trace[1433232747] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:8626; }","duration":"194.157727ms","start":"2026-09-07T08:45:11.866207Z","end":"2026-09-07T08:45:12.060365Z","steps":["trace[1433232747] 'agreement among raft nodes before linearized reading' (duration: 194.025344ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:45:12.060393Z","caller":"traceutil/trace.go:171","msg":"trace[862341580] transaction","detail":"{read_only:false; response_revision:8626; number_of_response:1; }","duration":"199.338215ms","start":"2026-09-07T08:45:11.861026Z","end":"2026-09-07T08:45:12.060364Z","steps":["trace[862341580] 'process raft request' (duration: 198.901644ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:45:37.072925Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002397.wal"} {"level":"info","ts":"2026-09-07T08:45:41.682103Z","caller":"traceutil/trace.go:171","msg":"trace[574607026] linearizableReadLoop","detail":"{readStateIndex:9152; appliedIndex:9151; }","duration":"230.485992ms","start":"2026-09-07T08:45:41.451591Z","end":"2026-09-07T08:45:41.682077Z","steps":["trace[574607026] 'read index received' (duration: 230.198604ms)","trace[574607026] 'applied index is now lower than readState.Index' (duration: 286.328µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:45:41.682156Z","caller":"traceutil/trace.go:171","msg":"trace[1378860444] transaction","detail":"{read_only:false; response_revision:8834; number_of_response:1; }","duration":"237.082238ms","start":"2026-09-07T08:45:41.445051Z","end":"2026-09-07T08:45:41.682133Z","steps":["trace[1378860444] 'process raft request' (duration: 236.831482ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:45:41.682374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.761599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-07T08:45:41.68243Z","caller":"traceutil/trace.go:171","msg":"trace[1594780151] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8834; }","duration":"230.840582ms","start":"2026-09-07T08:45:41.451571Z","end":"2026-09-07T08:45:41.682411Z","steps":["trace[1594780151] 'agreement among raft nodes before linearized reading' (duration: 230.641717ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:45:41.682425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.956815ms","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-09-07T08:45:41.682484Z","caller":"traceutil/trace.go:171","msg":"trace[1602837670] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8834; }","duration":"228.035866ms","start":"2026-09-07T08:45:41.454434Z","end":"2026-09-07T08:45:41.68247Z","steps":["trace[1602837670] 'agreement among raft nodes before linearized reading' (duration: 227.872212ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:45:41.682599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.620109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-07T08:45:41.682633Z","caller":"traceutil/trace.go:171","msg":"trace[109363850] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8834; }","duration":"229.689621ms","start":"2026-09-07T08:45:41.452934Z","end":"2026-09-07T08:45:41.682624Z","steps":["trace[109363850] 'agreement among raft nodes before linearized reading' (duration: 229.316881ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:45:41.682658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.41585ms","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-07T08:45:41.682709Z","caller":"traceutil/trace.go:171","msg":"trace[127590497] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8834; }","duration":"221.482472ms","start":"2026-09-07T08:45:41.461218Z","end":"2026-09-07T08:45:41.6827Z","steps":["trace[127590497] 'agreement among raft nodes before linearized reading' (duration: 221.360198ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:45:44.303466Z","caller":"traceutil/trace.go:171","msg":"trace[465685267] transaction","detail":"{read_only:false; response_revision:8853; number_of_response:1; }","duration":"100.954985ms","start":"2026-09-07T08:45:44.202477Z","end":"2026-09-07T08:45:44.303432Z","steps":["trace[465685267] 'process raft request' (duration: 72.395913ms)","trace[465685267] 'compare' (duration: 28.126131ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:45:53.330787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.673792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T08:45:53.330898Z","caller":"traceutil/trace.go:171","msg":"trace[63233397] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8898; }","duration":"159.824796ms","start":"2026-09-07T08:45:53.171049Z","end":"2026-09-07T08:45:53.330873Z","steps":["trace[63233397] 'range keys from in-memory index tree' (duration: 159.528088ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:45:54.415556Z","caller":"traceutil/trace.go:171","msg":"trace[456462078] transaction","detail":"{read_only:false; response_revision:8906; number_of_response:1; }","duration":"147.013343ms","start":"2026-09-07T08:45:54.268508Z","end":"2026-09-07T08:45:54.415521Z","steps":["trace[456462078] 'process raft request' (duration: 73.222364ms)","trace[456462078] 'compare' (duration: 73.618415ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:45:54.656813Z","caller":"traceutil/trace.go:171","msg":"trace[1004455241] transaction","detail":"{read_only:false; response_revision:8908; number_of_response:1; }","duration":"167.304765ms","start":"2026-09-07T08:45:54.489481Z","end":"2026-09-07T08:45:54.656785Z","steps":["trace[1004455241] 'process raft request' (duration: 167.147391ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:47:06.23606Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"383aa7db69884d67","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-07T08:47:06.244173Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-09-07T08:47:06.244351Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-09-07T08:49:00.425446Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8050} {"level":"info","ts":"2026-09-07T08:49:00.499255Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8050,"took":"72.390253ms","hash":265475874,"current-db-size-bytes":57184256,"current-db-size":"57 MB","current-db-size-in-use-bytes":27279360,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-07T08:49:00.499322Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":265475874,"revision":8050,"compact-revision":5898} {"level":"info","ts":"2026-09-07T08:52:44.625701Z","caller":"traceutil/trace.go:171","msg":"trace[1971387813] transaction","detail":"{read_only:false; response_revision:12101; number_of_response:1; }","duration":"129.639198ms","start":"2026-09-07T08:52:44.496035Z","end":"2026-09-07T08:52:44.625674Z","steps":["trace[1971387813] 'process raft request' (duration: 61.298985ms)","trace[1971387813] 'compare' (duration: 68.2223ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:53:04.292075Z","caller":"traceutil/trace.go:171","msg":"trace[1596699173] linearizableReadLoop","detail":"{readStateIndex:12631; appliedIndex:12630; }","duration":"137.816985ms","start":"2026-09-07T08:53:04.154235Z","end":"2026-09-07T08:53:04.292052Z","steps":["trace[1596699173] 'read index received' (duration: 137.736753ms)","trace[1596699173] 'applied index is now lower than readState.Index' (duration: 79.222µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:53:04.292139Z","caller":"traceutil/trace.go:171","msg":"trace[599316777] transaction","detail":"{read_only:false; response_revision:12204; number_of_response:1; }","duration":"151.148951ms","start":"2026-09-07T08:53:04.140975Z","end":"2026-09-07T08:53:04.292124Z","steps":["trace[599316777] 'process raft request' (duration: 150.953266ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:53:04.292304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.066441ms","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-07T08:53:04.292483Z","caller":"traceutil/trace.go:171","msg":"trace[200997527] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:12204; }","duration":"138.298408ms","start":"2026-09-07T08:53:04.154171Z","end":"2026-09-07T08:53:04.292469Z","steps":["trace[200997527] 'agreement among raft nodes before linearized reading' (duration: 137.98011ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:53:04.484781Z","caller":"traceutil/trace.go:171","msg":"trace[2025143758] transaction","detail":"{read_only:false; response_revision:12205; number_of_response:1; }","duration":"279.973556ms","start":"2026-09-07T08:53:04.204787Z","end":"2026-09-07T08:53:04.484761Z","steps":["trace[2025143758] 'process raft request' (duration: 279.766791ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:53:04.485121Z","caller":"traceutil/trace.go:171","msg":"trace[1825891561] linearizableReadLoop","detail":"{readStateIndex:12633; appliedIndex:12631; }","duration":"192.812772ms","start":"2026-09-07T08:53:04.292284Z","end":"2026-09-07T08:53:04.485097Z","steps":["trace[1825891561] 'read index received' (duration: 192.278978ms)","trace[1825891561] 'applied index is now lower than readState.Index' (duration: 532.754µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:53:04.485218Z","caller":"traceutil/trace.go:171","msg":"trace[1417321705] transaction","detail":"{read_only:false; response_revision:12206; number_of_response:1; }","duration":"250.441029ms","start":"2026-09-07T08:53:04.234748Z","end":"2026-09-07T08:53:04.485189Z","steps":["trace[1417321705] 'process raft request' (duration: 250.019248ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:53:04.48544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.259317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-09-07T08:53:04.485445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.470959ms","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-09-07T08:53:04.485481Z","caller":"traceutil/trace.go:171","msg":"trace[1440473461] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12206; }","duration":"219.339829ms","start":"2026-09-07T08:53:04.26613Z","end":"2026-09-07T08:53:04.48547Z","steps":["trace[1440473461] 'agreement among raft nodes before linearized reading' (duration: 219.151274ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:53:04.485487Z","caller":"traceutil/trace.go:171","msg":"trace[56529984] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:12206; }","duration":"208.566052ms","start":"2026-09-07T08:53:04.27691Z","end":"2026-09-07T08:53:04.485476Z","steps":["trace[56529984] 'agreement among raft nodes before linearized reading' (duration: 208.299895ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:53:04.485498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.276152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T08:53:04.485538Z","caller":"traceutil/trace.go:171","msg":"trace[1187731879] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12206; }","duration":"314.341284ms","start":"2026-09-07T08:53:04.171177Z","end":"2026-09-07T08:53:04.485519Z","steps":["trace[1187731879] 'agreement among raft nodes before linearized reading' (duration: 314.289652ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:53:04.485559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:53:04.171157Z","time spent":"314.396055ms","remote":"127.0.0.1:40082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-07T08:53:04.661526Z","caller":"traceutil/trace.go:171","msg":"trace[1945976082] transaction","detail":"{read_only:false; response_revision:12207; number_of_response:1; }","duration":"365.131008ms","start":"2026-09-07T08:53:04.296373Z","end":"2026-09-07T08:53:04.661504Z","steps":["trace[1945976082] 'process raft request' (duration: 364.943463ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:53:04.661626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:53:04.296352Z","time spent":"365.22278ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T08:53:04.661526Z","caller":"traceutil/trace.go:171","msg":"trace[1602340353] transaction","detail":"{read_only:false; response_revision:12208; number_of_response:1; }","duration":"260.569899ms","start":"2026-09-07T08:53:04.400941Z","end":"2026-09-07T08:53:04.661511Z","steps":["trace[1602340353] 'process raft request' (duration: 260.510707ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:53:04.6618Z","caller":"traceutil/trace.go:171","msg":"trace[1691957278] transaction","detail":"{read_only:false; response_revision:12209; number_of_response:1; }","duration":"196.369626ms","start":"2026-09-07T08:53:04.465422Z","end":"2026-09-07T08:53:04.661792Z","steps":["trace[1691957278] 'process raft request' (duration: 196.056028ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:53:04.661913Z","caller":"traceutil/trace.go:171","msg":"trace[730595303] linearizableReadLoop","detail":"{readStateIndex:12636; appliedIndex:12633; }","duration":"176.604089ms","start":"2026-09-07T08:53:04.485184Z","end":"2026-09-07T08:53:04.661788Z","steps":["trace[730595303] 'read index received' (duration: 176.176148ms)","trace[730595303] 'applied index is now lower than readState.Index' (duration: 425.041µs)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:53:04.662018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.664395ms","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-07T08:53:04.66207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.577159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"warn","ts":"2026-09-07T08:53:04.662115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.460323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-07T08:53:04.66213Z","caller":"traceutil/trace.go:171","msg":"trace[1004429483] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12209; }","duration":"292.825689ms","start":"2026-09-07T08:53:04.369273Z","end":"2026-09-07T08:53:04.662099Z","steps":["trace[1004429483] 'agreement among raft nodes before linearized reading' (duration: 292.545372ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:53:04.662161Z","caller":"traceutil/trace.go:171","msg":"trace[1841885909] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:12209; }","duration":"296.719433ms","start":"2026-09-07T08:53:04.365421Z","end":"2026-09-07T08:53:04.66214Z","steps":["trace[1841885909] 'agreement among raft nodes before linearized reading' (duration: 296.407154ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:53:04.662168Z","caller":"traceutil/trace.go:171","msg":"trace[1176788994] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:12209; }","duration":"342.562875ms","start":"2026-09-07T08:53:04.319597Z","end":"2026-09-07T08:53:04.662159Z","steps":["trace[1176788994] 'agreement among raft nodes before linearized reading' (duration: 342.411671ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:53:04.662213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:53:04.319571Z","time spent":"342.634467ms","remote":"127.0.0.1:40332","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-07T08:53:04.670755Z","caller":"traceutil/trace.go:171","msg":"trace[1956971738] transaction","detail":"{read_only:false; response_revision:12210; number_of_response:1; }","duration":"182.178018ms","start":"2026-09-07T08:53:04.488561Z","end":"2026-09-07T08:53:04.670739Z","steps":["trace[1956971738] 'process raft request' (duration: 181.991063ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:53:04.670842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.846079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-v5vt9\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-09-07T08:53:04.670898Z","caller":"traceutil/trace.go:171","msg":"trace[1008983894] range","detail":"{range_begin:/registry/pods/openstack/keepalived-v5vt9; range_end:; response_count:1; response_revision:12211; }","duration":"160.930812ms","start":"2026-09-07T08:53:04.509951Z","end":"2026-09-07T08:53:04.670882Z","steps":["trace[1008983894] 'agreement among raft nodes before linearized reading' (duration: 160.791138ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:53:04.670903Z","caller":"traceutil/trace.go:171","msg":"trace[449433356] transaction","detail":"{read_only:false; response_revision:12211; number_of_response:1; }","duration":"180.661988ms","start":"2026-09-07T08:53:04.490229Z","end":"2026-09-07T08:53:04.670891Z","steps":["trace[449433356] 'process raft request' (duration: 180.434652ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:53:04.670881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.175581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T08:53:04.670962Z","caller":"traceutil/trace.go:171","msg":"trace[193002298] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12211; }","duration":"184.306805ms","start":"2026-09-07T08:53:04.486634Z","end":"2026-09-07T08:53:04.670941Z","steps":["trace[193002298] 'agreement among raft nodes before linearized reading' (duration: 184.165402ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:54:00.435379Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10408} {"level":"info","ts":"2026-09-07T08:54:00.531589Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10408,"took":"93.812411ms","hash":1021792142,"current-db-size-bytes":57184256,"current-db-size":"57 MB","current-db-size-in-use-bytes":25370624,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-09-07T08:54:00.531656Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1021792142,"revision":10408,"compact-revision":8050} {"level":"info","ts":"2026-09-07T08:59:00.442063Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12583} {"level":"info","ts":"2026-09-07T08:59:00.528078Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12583,"took":"83.521205ms","hash":2395457780,"current-db-size-bytes":57184256,"current-db-size":"57 MB","current-db-size-in-use-bytes":27648000,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-07T08:59:00.528136Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2395457780,"revision":12583,"compact-revision":10408} {"level":"info","ts":"2026-09-07T08:59:57.065766Z","caller":"traceutil/trace.go:171","msg":"trace[2009149729] linearizableReadLoop","detail":"{readStateIndex:15459; appliedIndex:15458; }","duration":"110.583185ms","start":"2026-09-07T08:59:56.955164Z","end":"2026-09-07T08:59:57.065747Z","steps":["trace[2009149729] 'read index received' (duration: 110.404501ms)","trace[2009149729] 'applied index is now lower than readState.Index' (duration: 177.924µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:59:57.06586Z","caller":"traceutil/trace.go:171","msg":"trace[1509691167] transaction","detail":"{read_only:false; response_revision:14935; number_of_response:1; }","duration":"117.369246ms","start":"2026-09-07T08:59:56.94848Z","end":"2026-09-07T08:59:57.065849Z","steps":["trace[1509691167] 'process raft request' (duration: 117.13406ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:59:57.06605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.869244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-9z82l\" ","response":"range_response_count:1 size:12364"} {"level":"info","ts":"2026-09-07T08:59:57.066076Z","caller":"traceutil/trace.go:171","msg":"trace[1751622935] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-9z82l; range_end:; response_count:1; response_revision:14935; }","duration":"110.947506ms","start":"2026-09-07T08:59:56.955122Z","end":"2026-09-07T08:59:57.06607Z","steps":["trace[1751622935] 'agreement among raft nodes before linearized reading' (duration: 110.834743ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:59:57.271483Z","caller":"traceutil/trace.go:171","msg":"trace[2011789003] transaction","detail":"{read_only:false; response_revision:14936; number_of_response:1; }","duration":"200.805879ms","start":"2026-09-07T08:59:57.070658Z","end":"2026-09-07T08:59:57.271464Z","steps":["trace[2011789003] 'process raft request' (duration: 200.683926ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:59:57.285495Z","caller":"traceutil/trace.go:171","msg":"trace[969077133] linearizableReadLoop","detail":"{readStateIndex:15464; appliedIndex:15459; }","duration":"152.973035ms","start":"2026-09-07T08:59:57.132505Z","end":"2026-09-07T08:59:57.285478Z","steps":["trace[969077133] 'read index received' (duration: 138.884049ms)","trace[969077133] 'applied index is now lower than readState.Index' (duration: 14.088336ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:59:57.285805Z","caller":"traceutil/trace.go:171","msg":"trace[1916067283] transaction","detail":"{read_only:false; response_revision:14937; number_of_response:1; }","duration":"214.857603ms","start":"2026-09-07T08:59:57.070937Z","end":"2026-09-07T08:59:57.285795Z","steps":["trace[1916067283] 'process raft request' (duration: 214.338599ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:59:57.285916Z","caller":"traceutil/trace.go:171","msg":"trace[684781296] transaction","detail":"{read_only:false; response_revision:14938; number_of_response:1; }","duration":"214.941695ms","start":"2026-09-07T08:59:57.070967Z","end":"2026-09-07T08:59:57.285909Z","steps":["trace[684781296] 'process raft request' (duration: 214.430392ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:59:57.285976Z","caller":"traceutil/trace.go:171","msg":"trace[1870735802] transaction","detail":"{read_only:false; response_revision:14939; number_of_response:1; }","duration":"214.906915ms","start":"2026-09-07T08:59:57.071064Z","end":"2026-09-07T08:59:57.285971Z","steps":["trace[1870735802] 'process raft request' (duration: 214.35787ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:59:57.286098Z","caller":"traceutil/trace.go:171","msg":"trace[203384906] transaction","detail":"{read_only:false; response_revision:14940; number_of_response:1; }","duration":"210.21136ms","start":"2026-09-07T08:59:57.075882Z","end":"2026-09-07T08:59:57.286094Z","steps":["trace[203384906] 'process raft request' (duration: 209.560603ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:59:57.28621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.698065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T08:59:57.286231Z","caller":"traceutil/trace.go:171","msg":"trace[877251738] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:14940; }","duration":"153.735436ms","start":"2026-09-07T08:59:57.13249Z","end":"2026-09-07T08:59:57.286225Z","steps":["trace[877251738] 'agreement among raft nodes before linearized reading' (duration: 153.685824ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:59:57.286365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.116796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T08:59:57.286393Z","caller":"traceutil/trace.go:171","msg":"trace[1823509418] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14940; }","duration":"115.189099ms","start":"2026-09-07T08:59:57.171201Z","end":"2026-09-07T08:59:57.28639Z","steps":["trace[1823509418] 'agreement among raft nodes before linearized reading' (duration: 115.149808ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T09:00:06.684607Z","caller":"traceutil/trace.go:171","msg":"trace[565206021] transaction","detail":"{read_only:false; response_revision:15104; number_of_response:1; }","duration":"157.097205ms","start":"2026-09-07T09:00:06.527463Z","end":"2026-09-07T09:00:06.68456Z","steps":["trace[565206021] 'process raft request' (duration: 156.828118ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T09:00:06.819527Z","caller":"traceutil/trace.go:171","msg":"trace[2102404720] transaction","detail":"{read_only:false; response_revision:15105; number_of_response:1; }","duration":"291.867085ms","start":"2026-09-07T09:00:06.527622Z","end":"2026-09-07T09:00:06.819489Z","steps":["trace[2102404720] 'process raft request' (duration: 247.184945ms)","trace[2102404720] 'compare' (duration: 44.401222ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T09:00:07.132468Z","caller":"traceutil/trace.go:171","msg":"trace[129764484] linearizableReadLoop","detail":"{readStateIndex:15633; appliedIndex:15632; }","duration":"239.963932ms","start":"2026-09-07T09:00:06.892484Z","end":"2026-09-07T09:00:07.132448Z","steps":["trace[129764484] 'read index received' (duration: 239.834218ms)","trace[129764484] 'applied index is now lower than readState.Index' (duration: 128.704µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T09:00:07.132488Z","caller":"traceutil/trace.go:171","msg":"trace[218374463] transaction","detail":"{read_only:false; response_revision:15106; number_of_response:1; }","duration":"314.267002ms","start":"2026-09-07T09:00:06.818194Z","end":"2026-09-07T09:00:07.132461Z","steps":["trace[218374463] 'process raft request' (duration: 314.136599ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T09:00:07.132608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:00:06.818169Z","time spent":"314.374084ms","remote":"127.0.0.1:40154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":854,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-07T09:00:07.132624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.130317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-07T09:00:07.132656Z","caller":"traceutil/trace.go:171","msg":"trace[1590074750] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:15106; }","duration":"240.214689ms","start":"2026-09-07T09:00:06.892429Z","end":"2026-09-07T09:00:07.132644Z","steps":["trace[1590074750] 'agreement among raft nodes before linearized reading' (duration: 240.125477ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T09:01:33.753931Z","caller":"traceutil/trace.go:171","msg":"trace[433571648] transaction","detail":"{read_only:false; response_revision:16129; number_of_response:1; }","duration":"103.079306ms","start":"2026-09-07T09:01:33.650796Z","end":"2026-09-07T09:01:33.753875Z","steps":["trace[433571648] 'process raft request' (duration: 102.790128ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T09:04:00.453965Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14583} {"level":"info","ts":"2026-09-07T09:04:00.547658Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14583,"took":"90.531152ms","hash":119045744,"current-db-size-bytes":57184256,"current-db-size":"57 MB","current-db-size-in-use-bytes":31883264,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-07T09:04:00.547732Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":119045744,"revision":14583,"compact-revision":12583} {"level":"info","ts":"2026-09-07T09:07:35.760477Z","caller":"traceutil/trace.go:171","msg":"trace[1855440642] linearizableReadLoop","detail":"{readStateIndex:19341; appliedIndex:19340; }","duration":"355.164011ms","start":"2026-09-07T09:07:35.405283Z","end":"2026-09-07T09:07:35.760447Z","steps":["trace[1855440642] 'read index received' (duration: 354.75066ms)","trace[1855440642] 'applied index is now lower than readState.Index' (duration: 411.611µs)"],"step_count":2} {"level":"warn","ts":"2026-09-07T09:07:35.760831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.522052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:701"} {"level":"warn","ts":"2026-09-07T09:07:35.760867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.947986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-07T09:07:35.760914Z","caller":"traceutil/trace.go:171","msg":"trace[483475443] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18699; }","duration":"355.667335ms","start":"2026-09-07T09:07:35.405232Z","end":"2026-09-07T09:07:35.7609Z","steps":["trace[483475443] 'agreement among raft nodes before linearized reading' (duration: 355.438429ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T09:07:35.76095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:07:35.405209Z","time spent":"355.735057ms","remote":"127.0.0.1:40240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":723,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "} {"level":"info","ts":"2026-09-07T09:07:35.76096Z","caller":"traceutil/trace.go:171","msg":"trace[1355515454] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:18699; }","duration":"310.053838ms","start":"2026-09-07T09:07:35.450882Z","end":"2026-09-07T09:07:35.760935Z","steps":["trace[1355515454] 'agreement among raft nodes before linearized reading' (duration: 309.875134ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T09:07:35.761029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:07:35.450825Z","time spent":"310.189422ms","remote":"127.0.0.1:41080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":22,"response size":30,"request content":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true "} {"level":"warn","ts":"2026-09-07T09:07:35.761204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.73526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-user\" ","response":"range_response_count:1 size:7382"} {"level":"info","ts":"2026-09-07T09:07:35.761279Z","caller":"traceutil/trace.go:171","msg":"trace[1830394251] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-user; range_end:; response_count:1; response_revision:18699; }","duration":"108.859983ms","start":"2026-09-07T09:07:35.652398Z","end":"2026-09-07T09:07:35.761258Z","steps":["trace[1830394251] 'agreement among raft nodes before linearized reading' (duration: 108.572945ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T09:07:35.761346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.040111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-user\" ","response":"range_response_count:1 size:7382"} {"level":"info","ts":"2026-09-07T09:07:35.761408Z","caller":"traceutil/trace.go:171","msg":"trace[118106804] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-user; range_end:; response_count:1; response_revision:18699; }","duration":"144.156654ms","start":"2026-09-07T09:07:35.617234Z","end":"2026-09-07T09:07:35.761391Z","steps":["trace[118106804] 'agreement among raft nodes before linearized reading' (duration: 143.938579ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T09:07:35.760893Z","caller":"traceutil/trace.go:171","msg":"trace[704965281] transaction","detail":"{read_only:false; response_revision:18699; number_of_response:1; }","duration":"441.559476ms","start":"2026-09-07T09:07:35.319286Z","end":"2026-09-07T09:07:35.760846Z","steps":["trace[704965281] 'process raft request' (duration: 440.921159ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T09:07:35.762084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:07:35.319261Z","time spent":"442.753677ms","remote":"127.0.0.1:40260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20857,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T09:07:36.133497Z","caller":"traceutil/trace.go:171","msg":"trace[1138170072] transaction","detail":"{read_only:false; response_revision:18700; number_of_response:1; }","duration":"369.222677ms","start":"2026-09-07T09:07:35.764237Z","end":"2026-09-07T09:07:36.13346Z","steps":["trace[1138170072] 'process raft request' (duration: 366.966577ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T09:07:36.133718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:07:35.764214Z","time spent":"369.399031ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T09:07:36.153156Z","caller":"traceutil/trace.go:171","msg":"trace[1778949462] linearizableReadLoop","detail":"{readStateIndex:19345; appliedIndex:19341; }","duration":"301.411778ms","start":"2026-09-07T09:07:35.851713Z","end":"2026-09-07T09:07:36.153125Z","steps":["trace[1778949462] 'read index received' (duration: 279.530185ms)","trace[1778949462] 'applied index is now lower than readState.Index' (duration: 21.880313ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T09:07:36.153489Z","caller":"traceutil/trace.go:171","msg":"trace[110551080] transaction","detail":"{read_only:false; response_revision:18701; number_of_response:1; }","duration":"385.84973ms","start":"2026-09-07T09:07:35.767622Z","end":"2026-09-07T09:07:36.153472Z","steps":["trace[110551080] 'process raft request' (duration: 385.173122ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T09:07:36.153639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:07:35.767598Z","time spent":"385.935422ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T09:07:36.153833Z","caller":"traceutil/trace.go:171","msg":"trace[668037773] transaction","detail":"{read_only:false; response_revision:18702; number_of_response:1; }","duration":"386.110757ms","start":"2026-09-07T09:07:35.767712Z","end":"2026-09-07T09:07:36.153823Z","steps":["trace[668037773] 'process raft request' (duration: 385.228424ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T09:07:36.153894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:07:35.767705Z","time spent":"386.157198ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T09:07:36.154089Z","caller":"traceutil/trace.go:171","msg":"trace[1446880026] transaction","detail":"{read_only:false; response_revision:18703; number_of_response:1; }","duration":"386.21765ms","start":"2026-09-07T09:07:35.767857Z","end":"2026-09-07T09:07:36.154075Z","steps":["trace[1446880026] 'process raft request' (duration: 385.148841ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T09:07:36.15418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:07:35.76785Z","time spent":"386.284541ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T09:07:36.15437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.645961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-09-07T09:07:36.154449Z","caller":"traceutil/trace.go:171","msg":"trace[1812841602] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18704; }","duration":"302.754924ms","start":"2026-09-07T09:07:35.851675Z","end":"2026-09-07T09:07:36.15443Z","steps":["trace[1812841602] 'agreement among raft nodes before linearized reading' (duration: 302.512768ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T09:07:36.154489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:07:35.851659Z","time spent":"302.818855ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-07T09:07:36.609262Z","caller":"traceutil/trace.go:171","msg":"trace[280175252] transaction","detail":"{read_only:false; response_revision:18706; number_of_response:1; }","duration":"425.98491ms","start":"2026-09-07T09:07:36.18325Z","end":"2026-09-07T09:07:36.609235Z","steps":["trace[280175252] 'process raft request' (duration: 389.710983ms)","trace[280175252] 'compare' (duration: 35.865816ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T09:07:36.609385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:07:36.183219Z","time spent":"426.102344ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T09:07:36.616134Z","caller":"traceutil/trace.go:171","msg":"trace[1630175605] transaction","detail":"{read_only:false; response_revision:18707; number_of_response:1; }","duration":"108.061492ms","start":"2026-09-07T09:07:36.508049Z","end":"2026-09-07T09:07:36.61611Z","steps":["trace[1630175605] 'process raft request' (duration: 107.935218ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T09:07:36.882784Z","caller":"traceutil/trace.go:171","msg":"trace[1186045249] linearizableReadLoop","detail":"{readStateIndex:19350; appliedIndex:19348; }","duration":"271.809439ms","start":"2026-09-07T09:07:36.61095Z","end":"2026-09-07T09:07:36.882759Z","steps":["trace[1186045249] 'read index received' (duration: 5.018294ms)","trace[1186045249] 'applied index is now lower than readState.Index' (duration: 266.790025ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T09:07:36.882806Z","caller":"traceutil/trace.go:171","msg":"trace[1541810429] transaction","detail":"{read_only:false; response_revision:18708; number_of_response:1; }","duration":"296.578179ms","start":"2026-09-07T09:07:36.586193Z","end":"2026-09-07T09:07:36.882772Z","steps":["trace[1541810429] 'process raft request' (duration: 207.433692ms)","trace[1541810429] 'compare' (duration: 88.818798ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T09:07:36.883002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.037845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-b5bvs\" ","response":"range_response_count:1 size:22093"} {"level":"info","ts":"2026-09-07T09:07:36.883039Z","caller":"traceutil/trace.go:171","msg":"trace[2092193508] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-b5bvs; range_end:; response_count:1; response_revision:18708; }","duration":"272.129957ms","start":"2026-09-07T09:07:36.610898Z","end":"2026-09-07T09:07:36.883028Z","steps":["trace[2092193508] 'agreement among raft nodes before linearized reading' (duration: 271.980093ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T09:08:39.596495Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"383aa7db69884d67","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-07T09:08:39.602441Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-09-07T09:08:39.602553Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-09-07T09:09:00.467129Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17092} {"level":"info","ts":"2026-09-07T09:09:00.581244Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17092,"took":"109.267283ms","hash":1533742488,"current-db-size-bytes":57184256,"current-db-size":"57 MB","current-db-size-in-use-bytes":33849344,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-09-07T09:09:00.58131Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1533742488,"revision":17092,"compact-revision":14583} {"level":"info","ts":"2026-09-07T09:14:00.475605Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19628} {"level":"info","ts":"2026-09-07T09:14:00.614637Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19628,"took":"135.803351ms","hash":3599946524,"current-db-size-bytes":57184256,"current-db-size":"57 MB","current-db-size-in-use-bytes":30179328,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-09-07T09:14:00.614741Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3599946524,"revision":19628,"compact-revision":17092} {"level":"info","ts":"2026-09-07T09:14:18.733125Z","caller":"traceutil/trace.go:171","msg":"trace[1662661335] transaction","detail":"{read_only:false; response_revision:21769; number_of_response:1; }","duration":"102.42397ms","start":"2026-09-07T09:14:18.630678Z","end":"2026-09-07T09:14:18.733102Z","steps":["trace[1662661335] 'process raft request' (duration: 102.305377ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T09:14:24.467689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.084928ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-07T09:14:24.468061Z","caller":"traceutil/trace.go:171","msg":"trace[93811929] transaction","detail":"{read_only:false; response_revision:21793; number_of_response:1; }","duration":"189.647266ms","start":"2026-09-07T09:14:24.278399Z","end":"2026-09-07T09:14:24.468047Z","steps":["trace[93811929] 'process raft request' (duration: 53.141216ms)","trace[93811929] 'compare' (duration: 135.834372ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T09:14:24.468156Z","caller":"traceutil/trace.go:171","msg":"trace[525824201] transaction","detail":"{read_only:false; response_revision:21794; number_of_response:1; }","duration":"189.112251ms","start":"2026-09-07T09:14:24.279035Z","end":"2026-09-07T09:14:24.468147Z","steps":["trace[525824201] 'process raft request' (duration: 188.722551ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T09:14:24.892309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.851565ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-07T09:14:24.892473Z","caller":"traceutil/trace.go:171","msg":"trace[635257686] transaction","detail":"{read_only:false; response_revision:21796; number_of_response:1; }","duration":"360.095301ms","start":"2026-09-07T09:14:24.53236Z","end":"2026-09-07T09:14:24.892455Z","steps":["trace[635257686] 'process raft request' (duration: 360.040479ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T09:14:24.892466Z","caller":"traceutil/trace.go:171","msg":"trace[202866186] transaction","detail":"{read_only:false; response_revision:21795; number_of_response:1; }","duration":"421.24787ms","start":"2026-09-07T09:14:24.471193Z","end":"2026-09-07T09:14:24.892441Z","steps":["trace[202866186] 'process raft request' (duration: 124.1915ms)","trace[202866186] 'compare' (duration: 296.743822ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T09:14:24.892539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:14:24.532339Z","time spent":"360.168432ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T09:14:24.89258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:14:24.471178Z","time spent":"421.339323ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T09:14:24.892668Z","caller":"traceutil/trace.go:171","msg":"trace[988260634] linearizableReadLoop","detail":"{readStateIndex:22540; appliedIndex:22539; }","duration":"377.846844ms","start":"2026-09-07T09:14:24.514812Z","end":"2026-09-07T09:14:24.892659Z","steps":["trace[988260634] 'read index received' (duration: 80.63926ms)","trace[988260634] 'applied index is now lower than readState.Index' (duration: 297.206644ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T09:14:24.893037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.212253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-09-07T09:14:24.893084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.519833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-07T09:14:24.893119Z","caller":"traceutil/trace.go:171","msg":"trace[2082344338] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21796; }","duration":"378.328937ms","start":"2026-09-07T09:14:24.514768Z","end":"2026-09-07T09:14:24.893097Z","steps":["trace[2082344338] 'agreement among raft nodes before linearized reading' (duration: 377.964227ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T09:14:24.893154Z","caller":"traceutil/trace.go:171","msg":"trace[555908997] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:21796; }","duration":"102.648427ms","start":"2026-09-07T09:14:24.790487Z","end":"2026-09-07T09:14:24.893136Z","steps":["trace[555908997] 'agreement among raft nodes before linearized reading' (duration: 102.499913ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T09:14:24.893166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:14:24.514757Z","time spent":"378.396818ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-07T09:14:24.893194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.080474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"warn","ts":"2026-09-07T09:14:24.893214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.73436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-07T09:14:24.893235Z","caller":"traceutil/trace.go:171","msg":"trace[172960947] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:21796; }","duration":"260.122375ms","start":"2026-09-07T09:14:24.633102Z","end":"2026-09-07T09:14:24.893225Z","steps":["trace[172960947] 'agreement among raft nodes before linearized reading' (duration: 259.91791ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T09:14:24.89326Z","caller":"traceutil/trace.go:171","msg":"trace[1907625137] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21796; }","duration":"377.790102ms","start":"2026-09-07T09:14:24.515457Z","end":"2026-09-07T09:14:24.893247Z","steps":["trace[1907625137] 'agreement among raft nodes before linearized reading' (duration: 377.305109ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T09:14:24.893235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.616705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-09-07T09:14:24.893304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:14:24.515452Z","time spent":"377.843934ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-07T09:14:24.893365Z","caller":"traceutil/trace.go:171","msg":"trace[760415560] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21796; }","duration":"135.78086ms","start":"2026-09-07T09:14:24.75755Z","end":"2026-09-07T09:14:24.893331Z","steps":["trace[760415560] 'agreement among raft nodes before linearized reading' (duration: 135.459611ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T09:14:25.254593Z","caller":"traceutil/trace.go:171","msg":"trace[346540844] transaction","detail":"{read_only:false; response_revision:21797; number_of_response:1; }","duration":"347.029841ms","start":"2026-09-07T09:14:24.907529Z","end":"2026-09-07T09:14:25.254559Z","steps":["trace[346540844] 'process raft request' (duration: 317.626548ms)","trace[346540844] 'compare' (duration: 29.238439ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T09:14:25.254813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:14:24.907498Z","time spent":"347.168115ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T09:14:25.255577Z","caller":"traceutil/trace.go:171","msg":"trace[1073384267] transaction","detail":"{read_only:false; response_revision:21799; number_of_response:1; }","duration":"347.856494ms","start":"2026-09-07T09:14:24.907706Z","end":"2026-09-07T09:14:25.255563Z","steps":["trace[1073384267] 'process raft request' (duration: 347.786152ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T09:14:25.255703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:14:24.907522Z","time spent":"348.09373ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T09:14:25.255717Z","caller":"traceutil/trace.go:171","msg":"trace[927784403] transaction","detail":"{read_only:false; response_revision:21798; number_of_response:1; }","duration":"347.961797ms","start":"2026-09-07T09:14:24.907675Z","end":"2026-09-07T09:14:25.255637Z","steps":["trace[927784403] 'process raft request' (duration: 347.732981ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T09:14:25.25593Z","caller":"traceutil/trace.go:171","msg":"trace[1747934329] transaction","detail":"{read_only:false; response_revision:21800; number_of_response:1; }","duration":"348.073959ms","start":"2026-09-07T09:14:24.907838Z","end":"2026-09-07T09:14:25.255912Z","steps":["trace[1747934329] 'process raft request' (duration: 347.693549ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T09:14:25.256027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:14:24.907639Z","time spent":"348.241274ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T09:14:25.256122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T09:14:24.907826Z","time spent":"348.206064ms","remote":"127.0.0.1:40332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T09:14:25.982928Z","caller":"traceutil/trace.go:171","msg":"trace[290303839] transaction","detail":"{read_only:false; response_revision:21802; number_of_response:1; }","duration":"193.820908ms","start":"2026-09-07T09:14:25.789086Z","end":"2026-09-07T09:14:25.982907Z","steps":["trace[290303839] 'process raft request' (duration: 162.804651ms)","trace[290303839] 'compare' (duration: 30.861362ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T09:18:42.28295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.840179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-07T09:18:42.283014Z","caller":"traceutil/trace.go:171","msg":"trace[1299402603] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24369; }","duration":"112.938781ms","start":"2026-09-07T09:18:42.170063Z","end":"2026-09-07T09:18:42.283001Z","steps":["trace[1299402603] 'range keys from in-memory index tree' (duration: 112.792476ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T09:18:42.704573Z","caller":"traceutil/trace.go:171","msg":"trace[1605638438] transaction","detail":"{read_only:false; response_revision:24371; number_of_response:1; }","duration":"252.510482ms","start":"2026-09-07T09:18:42.452042Z","end":"2026-09-07T09:18:42.704553Z","steps":["trace[1605638438] 'process raft request' (duration: 174.913354ms)","trace[1605638438] 'compare' (duration: 77.506236ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T09:19:00.481452Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21675} {"level":"info","ts":"2026-09-07T09:19:00.5936Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21675,"took":"109.16249ms","hash":3440484345,"current-db-size-bytes":57184256,"current-db-size":"57 MB","current-db-size-in-use-bytes":41742336,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-09-07T09:19:00.593739Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3440484345,"revision":21675,"compact-revision":19628} {"level":"info","ts":"2026-09-07T09:22:16.329772Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006a19.wal"} {"level":"info","ts":"2026-09-07T09:24:00.486925Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24540} {"level":"info","ts":"2026-09-07T09:24:00.634922Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24540,"took":"145.138831ms","hash":3605347062,"current-db-size-bytes":57606144,"current-db-size":"58 MB","current-db-size-in-use-bytes":33308672,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-09-07T09:24:00.635039Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3605347062,"revision":24540,"compact-revision":21675} {"level":"info","ts":"2026-09-07T09:28:29.832355Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"383aa7db69884d67","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-07T09:28:29.838689Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-09-07T09:28:29.838785Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-09-07T09:29:00.492368Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27043} {"level":"info","ts":"2026-09-07T09:29:00.610866Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27043,"took":"115.906522ms","hash":981651916,"current-db-size-bytes":57606144,"current-db-size":"58 MB","current-db-size-in-use-bytes":30384128,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-09-07T09:29:00.610922Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":981651916,"revision":27043,"compact-revision":24540}