{"level":"warn","ts":"2026-10-14T12:59:29.344329Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-14T12:59:29.344468Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.91: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.91:2380","--initial-cluster=instance=https://162.253.55.91:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.91:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.91: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-10-14T12:59:29.34456Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-14T12:59:29.344579Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.91:2380"]} {"level":"info","ts":"2026-10-14T12:59:29.344602Z","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-10-14T12:59:29.345493Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.91:2379"]} {"level":"info","ts":"2026-10-14T12:59:29.345602Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.91:2380"],"listen-peer-urls":["https://162.253.55.91:2380"],"advertise-client-urls":["https://162.253.55.91:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.91:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.91: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-10-14T12:59:29.35445Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.526654ms"} {"level":"info","ts":"2026-10-14T12:59:29.366484Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8a5b61ed9120d6b3","cluster-id":"9e0c1e8055c016ad"} {"level":"info","ts":"2026-10-14T12:59:29.366649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a5b61ed9120d6b3 switched to configuration voters=()"} {"level":"info","ts":"2026-10-14T12:59:29.366674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a5b61ed9120d6b3 became follower at term 0"} {"level":"info","ts":"2026-10-14T12:59:29.366685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8a5b61ed9120d6b3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-14T12:59:29.366699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a5b61ed9120d6b3 became follower at term 1"} {"level":"info","ts":"2026-10-14T12:59:29.366752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a5b61ed9120d6b3 switched to configuration voters=(9969669873084716723)"} {"level":"warn","ts":"2026-10-14T12:59:29.390129Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-14T12:59:29.395017Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-14T12:59:29.398715Z","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-10-14T12:59:29.40249Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8a5b61ed9120d6b3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-14T12:59:29.404056Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8a5b61ed9120d6b3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-14T12:59:29.404312Z","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-10-14T12:59:29.404388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a5b61ed9120d6b3 switched to configuration voters=(9969669873084716723)"} {"level":"info","ts":"2026-10-14T12:59:29.404413Z","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-10-14T12:59:29.404547Z","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-10-14T12:59:29.404714Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9e0c1e8055c016ad","local-member-id":"8a5b61ed9120d6b3","added-peer-id":"8a5b61ed9120d6b3","added-peer-peer-urls":["https://162.253.55.91:2380"]} {"level":"info","ts":"2026-10-14T12:59:29.410796Z","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-10-14T12:59:29.411014Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.91:2380"} {"level":"info","ts":"2026-10-14T12:59:29.41104Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.91:2380"} {"level":"info","ts":"2026-10-14T12:59:29.411191Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8a5b61ed9120d6b3","initial-advertise-peer-urls":["https://162.253.55.91:2380"],"listen-peer-urls":["https://162.253.55.91:2380"],"advertise-client-urls":["https://162.253.55.91:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.91:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-14T12:59:29.411239Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-14T12:59:29.867678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a5b61ed9120d6b3 is starting a new election at term 1"} {"level":"info","ts":"2026-10-14T12:59:29.867733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a5b61ed9120d6b3 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-14T12:59:29.867773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a5b61ed9120d6b3 received MsgPreVoteResp from 8a5b61ed9120d6b3 at term 1"} {"level":"info","ts":"2026-10-14T12:59:29.867815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a5b61ed9120d6b3 became candidate at term 2"} {"level":"info","ts":"2026-10-14T12:59:29.867823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a5b61ed9120d6b3 received MsgVoteResp from 8a5b61ed9120d6b3 at term 2"} {"level":"info","ts":"2026-10-14T12:59:29.867834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a5b61ed9120d6b3 became leader at term 2"} {"level":"info","ts":"2026-10-14T12:59:29.867849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8a5b61ed9120d6b3 elected leader 8a5b61ed9120d6b3 at term 2"} {"level":"info","ts":"2026-10-14T12:59:29.869329Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T12:59:29.870899Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T12:59:29.870889Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8a5b61ed9120d6b3","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.91:2379]}","request-path":"/0/members/8a5b61ed9120d6b3/attributes","cluster-id":"9e0c1e8055c016ad","publish-timeout":"7s"} {"level":"info","ts":"2026-10-14T12:59:29.871165Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T12:59:29.871555Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9e0c1e8055c016ad","local-member-id":"8a5b61ed9120d6b3","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T12:59:29.871673Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T12:59:29.871713Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T12:59:29.872127Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-14T12:59:29.872247Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-14T12:59:29.873575Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-14T12:59:29.87453Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.91:2379"} {"level":"info","ts":"2026-10-14T12:59:55.004082Z","caller":"traceutil/trace.go:171","msg":"trace[1526598260] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"227.149946ms","start":"2026-10-14T12:59:54.776894Z","end":"2026-10-14T12:59:55.004044Z","steps":["trace[1526598260] 'process raft request' (duration: 226.802329ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:14.569895Z","caller":"traceutil/trace.go:171","msg":"trace[835326805] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"124.006573ms","start":"2026-10-14T13:00:14.445871Z","end":"2026-10-14T13:00:14.569877Z","steps":["trace[835326805] 'process raft request' (duration: 123.882891ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:14.627698Z","caller":"traceutil/trace.go:171","msg":"trace[1947399162] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"163.219114ms","start":"2026-10-14T13:00:14.464449Z","end":"2026-10-14T13:00:14.627669Z","steps":["trace[1947399162] 'process raft request' (duration: 163.114052ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:14.627714Z","caller":"traceutil/trace.go:171","msg":"trace[1149890255] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"151.19842ms","start":"2026-10-14T13:00:14.476491Z","end":"2026-10-14T13:00:14.627689Z","steps":["trace[1149890255] 'process raft request' (duration: 151.104598ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:14.627903Z","caller":"traceutil/trace.go:171","msg":"trace[23682026] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"147.281067ms","start":"2026-10-14T13:00:14.480606Z","end":"2026-10-14T13:00:14.627887Z","steps":["trace[23682026] 'process raft request' (duration: 147.020052ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:14.627914Z","caller":"traceutil/trace.go:171","msg":"trace[434916725] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"139.575524ms","start":"2026-10-14T13:00:14.488327Z","end":"2026-10-14T13:00:14.627902Z","steps":["trace[434916725] 'process raft request' (duration: 139.324589ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:14.627953Z","caller":"traceutil/trace.go:171","msg":"trace[1113796823] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"110.41559ms","start":"2026-10-14T13:00:14.517532Z","end":"2026-10-14T13:00:14.627947Z","steps":["trace[1113796823] 'process raft request' (duration: 110.170765ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:14.627895Z","caller":"traceutil/trace.go:171","msg":"trace[775759650] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"136.182351ms","start":"2026-10-14T13:00:14.491707Z","end":"2026-10-14T13:00:14.627889Z","steps":["trace[775759650] 'process raft request' (duration: 135.967857ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:14.627647Z","caller":"traceutil/trace.go:171","msg":"trace[300446623] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"176.38397ms","start":"2026-10-14T13:00:14.451209Z","end":"2026-10-14T13:00:14.627593Z","steps":["trace[300446623] 'process raft request' (duration: 176.169766ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:14.628275Z","caller":"traceutil/trace.go:171","msg":"trace[1536527854] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"167.81005ms","start":"2026-10-14T13:00:14.460449Z","end":"2026-10-14T13:00:14.628259Z","steps":["trace[1536527854] 'process raft request' (duration: 167.086917ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:14.841587Z","caller":"traceutil/trace.go:171","msg":"trace[984531984] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"146.171037ms","start":"2026-10-14T13:00:14.695394Z","end":"2026-10-14T13:00:14.841565Z","steps":["trace[984531984] 'process raft request' (duration: 145.989563ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:14.841798Z","caller":"traceutil/trace.go:171","msg":"trace[211684673] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"167.623766ms","start":"2026-10-14T13:00:14.674115Z","end":"2026-10-14T13:00:14.841739Z","steps":["trace[211684673] 'process raft request' (duration: 76.258852ms)","trace[211684673] 'compare' (duration: 90.831694ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:00:15.013017Z","caller":"traceutil/trace.go:171","msg":"trace[1876412798] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"293.673766ms","start":"2026-10-14T13:00:14.719317Z","end":"2026-10-14T13:00:15.012991Z","steps":["trace[1876412798] 'process raft request' (duration: 283.585769ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:15.013268Z","caller":"traceutil/trace.go:171","msg":"trace[1656250350] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"266.593361ms","start":"2026-10-14T13:00:14.746665Z","end":"2026-10-14T13:00:15.013259Z","steps":["trace[1656250350] 'process raft request' (duration: 266.55559ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:15.013358Z","caller":"traceutil/trace.go:171","msg":"trace[373016989] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"282.098791ms","start":"2026-10-14T13:00:14.731248Z","end":"2026-10-14T13:00:15.013346Z","steps":["trace[373016989] 'process raft request' (duration: 281.674493ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:15.018241Z","caller":"traceutil/trace.go:171","msg":"trace[1136606095] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"166.951063ms","start":"2026-10-14T13:00:14.851239Z","end":"2026-10-14T13:00:15.01819Z","steps":["trace[1136606095] 'process raft request' (duration: 166.869031ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:15.018386Z","caller":"traceutil/trace.go:171","msg":"trace[459028934] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"248.744258ms","start":"2026-10-14T13:00:14.769631Z","end":"2026-10-14T13:00:15.018375Z","steps":["trace[459028934] 'process raft request' (duration: 248.177998ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:15.018546Z","caller":"traceutil/trace.go:171","msg":"trace[658905979] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"167.613165ms","start":"2026-10-14T13:00:14.85092Z","end":"2026-10-14T13:00:15.018533Z","steps":["trace[658905979] 'process raft request' (duration: 167.100986ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:15.520804Z","caller":"traceutil/trace.go:171","msg":"trace[2103467891] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"168.861769ms","start":"2026-10-14T13:00:15.351905Z","end":"2026-10-14T13:00:15.520767Z","steps":["trace[2103467891] 'process raft request' (duration: 154.666845ms)","trace[2103467891] 'compare' (duration: 13.399669ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:00:15.524817Z","caller":"traceutil/trace.go:171","msg":"trace[654668879] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"152.703589ms","start":"2026-10-14T13:00:15.372094Z","end":"2026-10-14T13:00:15.524798Z","steps":["trace[654668879] 'process raft request' (duration: 152.308491ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:15.735745Z","caller":"traceutil/trace.go:171","msg":"trace[1174576079] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"130.407065ms","start":"2026-10-14T13:00:15.605317Z","end":"2026-10-14T13:00:15.735724Z","steps":["trace[1174576079] 'process raft request' (duration: 67.729119ms)","trace[1174576079] 'compare' (duration: 62.573324ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:00:16.208125Z","caller":"traceutil/trace.go:171","msg":"trace[263061292] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"100.760376ms","start":"2026-10-14T13:00:16.107348Z","end":"2026-10-14T13:00:16.208108Z","steps":["trace[263061292] 'process raft request' (duration: 100.542472ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:16.690115Z","caller":"traceutil/trace.go:171","msg":"trace[1982693470] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"154.102845ms","start":"2026-10-14T13:00:16.535986Z","end":"2026-10-14T13:00:16.690089Z","steps":["trace[1982693470] 'process raft request' (duration: 151.373694ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:00:16.690216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.352759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:74769"} {"level":"info","ts":"2026-10-14T13:00:16.690338Z","caller":"traceutil/trace.go:171","msg":"trace[232368917] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:607; }","duration":"168.485012ms","start":"2026-10-14T13:00:16.52183Z","end":"2026-10-14T13:00:16.690315Z","steps":["trace[232368917] 'range keys from in-memory index tree' (duration: 168.173016ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:21.986557Z","caller":"traceutil/trace.go:171","msg":"trace[352643015] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"278.883734ms","start":"2026-10-14T13:00:21.707466Z","end":"2026-10-14T13:00:21.98635Z","steps":["trace[352643015] 'process raft request' (duration: 278.206242ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:22.206636Z","caller":"traceutil/trace.go:171","msg":"trace[1457761887] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"210.72199ms","start":"2026-10-14T13:00:21.995887Z","end":"2026-10-14T13:00:22.206609Z","steps":["trace[1457761887] 'process raft request' (duration: 173.898011ms)","trace[1457761887] 'compare' (duration: 36.672116ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:00:22.24289Z","caller":"traceutil/trace.go:171","msg":"trace[1808603000] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"183.490885ms","start":"2026-10-14T13:00:22.059372Z","end":"2026-10-14T13:00:22.242863Z","steps":["trace[1808603000] 'process raft request' (duration: 183.437994ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:22.242948Z","caller":"traceutil/trace.go:171","msg":"trace[2145907381] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"215.846383ms","start":"2026-10-14T13:00:22.027034Z","end":"2026-10-14T13:00:22.24288Z","steps":["trace[2145907381] 'process raft request' (duration: 215.630209ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:22.924193Z","caller":"traceutil/trace.go:171","msg":"trace[1537971475] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"293.107016ms","start":"2026-10-14T13:00:22.631069Z","end":"2026-10-14T13:00:22.924176Z","steps":["trace[1537971475] 'process raft request' (duration: 292.77181ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:00:22.924188Z","caller":"traceutil/trace.go:171","msg":"trace[906187948] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"656.457508ms","start":"2026-10-14T13:00:22.267687Z","end":"2026-10-14T13:00:22.924145Z","steps":["trace[906187948] 'process raft request' (duration: 582.283401ms)","trace[906187948] 'compare' (duration: 73.717639ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:00:22.924805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:00:22.267663Z","time spent":"656.604722ms","remote":"127.0.0.1:53676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T13:00:39.334328Z","caller":"traceutil/trace.go:171","msg":"trace[1886160120] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"321.346951ms","start":"2026-10-14T13:00:39.012951Z","end":"2026-10-14T13:00:39.334298Z","steps":["trace[1886160120] 'process raft request' (duration: 320.914533ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:00:39.334797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:00:39.012918Z","time spent":"321.527814ms","remote":"127.0.0.1:53676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4024,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T13:01:34.737635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.926312ms","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-10-14T13:01:34.73786Z","caller":"traceutil/trace.go:171","msg":"trace[2049965530] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1480; }","duration":"117.229307ms","start":"2026-10-14T13:01:34.620606Z","end":"2026-10-14T13:01:34.737836Z","steps":["trace[2049965530] 'range keys from in-memory index tree' (duration: 116.720389ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:01:40.059508Z","caller":"traceutil/trace.go:171","msg":"trace[818922769] transaction","detail":"{read_only:false; response_revision:1532; number_of_response:1; }","duration":"146.87376ms","start":"2026-10-14T13:01:39.91261Z","end":"2026-10-14T13:01:40.059484Z","steps":["trace[818922769] 'process raft request' (duration: 146.678817ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:01:59.270407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.280962ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T13:01:59.270546Z","caller":"traceutil/trace.go:171","msg":"trace[1192911835] linearizableReadLoop","detail":"{readStateIndex:1926; appliedIndex:1925; }","duration":"170.574494ms","start":"2026-10-14T13:01:59.099947Z","end":"2026-10-14T13:01:59.270521Z","steps":["trace[1192911835] 'read index received' (duration: 53.711µs)","trace[1192911835] 'applied index is now lower than readState.Index' (duration: 170.518983ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:01:59.270566Z","caller":"traceutil/trace.go:171","msg":"trace[143203921] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"369.333462ms","start":"2026-10-14T13:01:58.901203Z","end":"2026-10-14T13:01:59.270536Z","steps":["trace[143203921] 'process raft request' (duration: 155.582204ms)","trace[143203921] 'compare' (duration: 213.016137ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:01:59.27071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:01:58.901167Z","time spent":"369.457403ms","remote":"127.0.0.1:53754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T13:01:59.270855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.438047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-14T13:01:59.270922Z","caller":"traceutil/trace.go:171","msg":"trace[1251230368] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1874; }","duration":"169.576359ms","start":"2026-10-14T13:01:59.101331Z","end":"2026-10-14T13:01:59.270908Z","steps":["trace[1251230368] 'agreement among raft nodes before linearized reading' (duration: 169.318365ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:01:59.270967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.009581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-010e1939-4e1c-4c79-be09-0e2bbf5d8272\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-10-14T13:01:59.271109Z","caller":"traceutil/trace.go:171","msg":"trace[1069893185] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-010e1939-4e1c-4c79-be09-0e2bbf5d8272; range_end:; response_count:1; response_revision:1874; }","duration":"171.216464ms","start":"2026-10-14T13:01:59.099866Z","end":"2026-10-14T13:01:59.271082Z","steps":["trace[1069893185] 'agreement among raft nodes before linearized reading' (duration: 170.736247ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:01:59.732513Z","caller":"traceutil/trace.go:171","msg":"trace[623463058] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"292.944336ms","start":"2026-10-14T13:01:59.439535Z","end":"2026-10-14T13:01:59.732479Z","steps":["trace[623463058] 'process raft request' (duration: 292.674052ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:01:59.948776Z","caller":"traceutil/trace.go:171","msg":"trace[556804629] linearizableReadLoop","detail":"{readStateIndex:1929; appliedIndex:1928; }","duration":"346.297507ms","start":"2026-10-14T13:01:59.602439Z","end":"2026-10-14T13:01:59.948737Z","steps":["trace[556804629] 'read index received' (duration: 130.025681ms)","trace[556804629] 'applied index is now lower than readState.Index' (duration: 216.270106ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:01:59.948882Z","caller":"traceutil/trace.go:171","msg":"trace[1621606748] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"508.640024ms","start":"2026-10-14T13:01:59.440171Z","end":"2026-10-14T13:01:59.948811Z","steps":["trace[1621606748] 'process raft request' (duration: 496.315854ms)","trace[1621606748] 'compare' (duration: 11.738491ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:01:59.949158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:01:59.440148Z","time spent":"508.797367ms","remote":"127.0.0.1:53578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":644,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T13:01:59.949261Z","caller":"traceutil/trace.go:171","msg":"trace[325072711] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"293.655147ms","start":"2026-10-14T13:01:59.655582Z","end":"2026-10-14T13:01:59.949237Z","steps":["trace[325072711] 'process raft request' (duration: 292.962477ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:01:59.949392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.915617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"} {"level":"info","ts":"2026-10-14T13:01:59.949513Z","caller":"traceutil/trace.go:171","msg":"trace[1153148615] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1878; }","duration":"347.167321ms","start":"2026-10-14T13:01:59.60232Z","end":"2026-10-14T13:01:59.949487Z","steps":["trace[1153148615] 'agreement among raft nodes before linearized reading' (duration: 346.722274ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:01:59.94931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.491372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"} {"level":"info","ts":"2026-10-14T13:01:59.949775Z","caller":"traceutil/trace.go:171","msg":"trace[1783587352] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1878; }","duration":"207.949568ms","start":"2026-10-14T13:01:59.741762Z","end":"2026-10-14T13:01:59.949712Z","steps":["trace[1783587352] 'agreement among raft nodes before linearized reading' (duration: 207.307979ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:01:59.949586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:01:59.60229Z","time spent":"347.259512ms","remote":"127.0.0.1:32916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":4615,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-10-14T13:02:06.279741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.04566ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T13:02:06.279861Z","caller":"traceutil/trace.go:171","msg":"trace[903793437] linearizableReadLoop","detail":"{readStateIndex:2008; appliedIndex:2007; }","duration":"169.831787ms","start":"2026-10-14T13:02:06.110011Z","end":"2026-10-14T13:02:06.279843Z","steps":["trace[903793437] 'read index received' (duration: 20.530413ms)","trace[903793437] 'applied index is now lower than readState.Index' (duration: 149.299574ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:02:06.279962Z","caller":"traceutil/trace.go:171","msg":"trace[32121002] transaction","detail":"{read_only:false; response_revision:1954; number_of_response:1; }","duration":"172.145333ms","start":"2026-10-14T13:02:06.107801Z","end":"2026-10-14T13:02:06.279946Z","steps":["trace[32121002] 'process raft request' (duration: 22.792728ms)","trace[32121002] 'compare' (duration: 148.892648ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:02:06.28042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.379456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:551"} {"level":"info","ts":"2026-10-14T13:02:06.280489Z","caller":"traceutil/trace.go:171","msg":"trace[1389232133] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1954; }","duration":"170.476078ms","start":"2026-10-14T13:02:06.109992Z","end":"2026-10-14T13:02:06.280468Z","steps":["trace[1389232133] 'agreement among raft nodes before linearized reading' (duration: 170.223064ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:02:32.701424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.913163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18de66fdec1f7abb\" ","response":"range_response_count:1 size:846"} {"level":"warn","ts":"2026-10-14T13:02:32.701438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.719102ms","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-10-14T13:02:32.701716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.100493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:525"} {"level":"info","ts":"2026-10-14T13:02:32.70179Z","caller":"traceutil/trace.go:171","msg":"trace[1581896233] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:2146; }","duration":"160.232388ms","start":"2026-10-14T13:02:32.541538Z","end":"2026-10-14T13:02:32.701771Z","steps":["trace[1581896233] 'range keys from in-memory index tree' (duration: 159.935356ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:02:32.701668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.020481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-10-14T13:02:32.701866Z","caller":"traceutil/trace.go:171","msg":"trace[1500144424] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2146; }","duration":"343.269882ms","start":"2026-10-14T13:02:32.358567Z","end":"2026-10-14T13:02:32.701837Z","steps":["trace[1500144424] 'range keys from in-memory index tree' (duration: 342.875316ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:02:32.701938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:02:32.358471Z","time spent":"343.443589ms","remote":"127.0.0.1:53754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-10-14T13:02:32.702091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.927286ms","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-10-14T13:02:32.702175Z","caller":"traceutil/trace.go:171","msg":"trace[335990835] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2146; }","duration":"158.024661ms","start":"2026-10-14T13:02:32.544136Z","end":"2026-10-14T13:02:32.70216Z","steps":["trace[335990835] 'range keys from in-memory index tree' (duration: 157.098644ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:02:32.702402Z","caller":"traceutil/trace.go:171","msg":"trace[1914834613] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2146; }","duration":"178.065956ms","start":"2026-10-14T13:02:32.523645Z","end":"2026-10-14T13:02:32.701711Z","steps":["trace[1914834613] 'range keys from in-memory index tree' (duration: 177.542265ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:02:32.701571Z","caller":"traceutil/trace.go:171","msg":"trace[965648240] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18de66fdec1f7abb; range_end:; response_count:1; response_revision:2146; }","duration":"199.124711ms","start":"2026-10-14T13:02:32.502418Z","end":"2026-10-14T13:02:32.701543Z","steps":["trace[965648240] 'range keys from in-memory index tree' (duration: 198.666773ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:02:32.916318Z","caller":"traceutil/trace.go:171","msg":"trace[942205077] linearizableReadLoop","detail":"{readStateIndex:2216; appliedIndex:2210; }","duration":"203.679272ms","start":"2026-10-14T13:02:32.712618Z","end":"2026-10-14T13:02:32.916297Z","steps":["trace[942205077] 'read index received' (duration: 5.707856ms)","trace[942205077] 'applied index is now lower than readState.Index' (duration: 197.970226ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:02:32.916485Z","caller":"traceutil/trace.go:171","msg":"trace[1270763115] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"209.026965ms","start":"2026-10-14T13:02:32.707405Z","end":"2026-10-14T13:02:32.916432Z","steps":["trace[1270763115] 'process raft request' (duration: 208.711982ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:02:32.916615Z","caller":"traceutil/trace.go:171","msg":"trace[2083775805] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"208.91835ms","start":"2026-10-14T13:02:32.707608Z","end":"2026-10-14T13:02:32.916526Z","steps":["trace[2083775805] 'process raft request' (duration: 208.615718ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:02:32.916823Z","caller":"traceutil/trace.go:171","msg":"trace[1968533636] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"209.188562ms","start":"2026-10-14T13:02:32.70762Z","end":"2026-10-14T13:02:32.916808Z","steps":["trace[1968533636] 'process raft request' (duration: 208.64081ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:02:32.917227Z","caller":"traceutil/trace.go:171","msg":"trace[570117066] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"209.598888ms","start":"2026-10-14T13:02:32.70761Z","end":"2026-10-14T13:02:32.917209Z","steps":["trace[570117066] 'process raft request' (duration: 208.568387ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:02:32.917254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.6139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:659"} {"level":"info","ts":"2026-10-14T13:02:32.917383Z","caller":"traceutil/trace.go:171","msg":"trace[1946575883] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2152; }","duration":"204.802817ms","start":"2026-10-14T13:02:32.712563Z","end":"2026-10-14T13:02:32.917366Z","steps":["trace[1946575883] 'agreement among raft nodes before linearized reading' (duration: 204.468484ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:02:32.918259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.110743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"} {"level":"info","ts":"2026-10-14T13:02:32.917117Z","caller":"traceutil/trace.go:171","msg":"trace[1480974441] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"209.967502ms","start":"2026-10-14T13:02:32.706783Z","end":"2026-10-14T13:02:32.91675Z","steps":["trace[1480974441] 'process raft request' (duration: 209.14374ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:02:32.918321Z","caller":"traceutil/trace.go:171","msg":"trace[162700118] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2152; }","duration":"161.245009ms","start":"2026-10-14T13:02:32.757062Z","end":"2026-10-14T13:02:32.918307Z","steps":["trace[162700118] 'agreement among raft nodes before linearized reading' (duration: 159.894296ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:02:33.16282Z","caller":"traceutil/trace.go:171","msg":"trace[1373180731] linearizableReadLoop","detail":"{readStateIndex:2220; appliedIndex:2218; }","duration":"193.7207ms","start":"2026-10-14T13:02:32.969076Z","end":"2026-10-14T13:02:33.162797Z","steps":["trace[1373180731] 'read index received' (duration: 160.613032ms)","trace[1373180731] 'applied index is now lower than readState.Index' (duration: 33.106698ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:02:33.162859Z","caller":"traceutil/trace.go:171","msg":"trace[621347863] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"216.114919ms","start":"2026-10-14T13:02:32.946693Z","end":"2026-10-14T13:02:33.162808Z","steps":["trace[621347863] 'process raft request' (duration: 182.96885ms)","trace[621347863] 'compare' (duration: 32.90398ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:02:33.162875Z","caller":"traceutil/trace.go:171","msg":"trace[844490731] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"215.762605ms","start":"2026-10-14T13:02:32.947089Z","end":"2026-10-14T13:02:33.162851Z","steps":["trace[844490731] 'process raft request' (duration: 215.665471ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:02:33.16311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.017082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-10-14T13:02:33.1633Z","caller":"traceutil/trace.go:171","msg":"trace[788937635] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:2155; }","duration":"194.192959ms","start":"2026-10-14T13:02:32.969062Z","end":"2026-10-14T13:02:33.163255Z","steps":["trace[788937635] 'agreement among raft nodes before linearized reading' (duration: 193.812454ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:03:25.894029Z","caller":"traceutil/trace.go:171","msg":"trace[1556822085] transaction","detail":"{read_only:false; response_revision:2615; number_of_response:1; }","duration":"140.104025ms","start":"2026-10-14T13:03:25.753905Z","end":"2026-10-14T13:03:25.894009Z","steps":["trace[1556822085] 'process raft request' (duration: 139.902898ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:04:03.194605Z","caller":"traceutil/trace.go:171","msg":"trace[1472496622] linearizableReadLoop","detail":"{readStateIndex:2974; appliedIndex:2973; }","duration":"372.08133ms","start":"2026-10-14T13:04:02.822503Z","end":"2026-10-14T13:04:03.194585Z","steps":["trace[1472496622] 'read index received' (duration: 371.929006ms)","trace[1472496622] 'applied index is now lower than readState.Index' (duration: 151.554µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:04:03.194779Z","caller":"traceutil/trace.go:171","msg":"trace[1733150338] transaction","detail":"{read_only:false; response_revision:2869; number_of_response:1; }","duration":"378.191695ms","start":"2026-10-14T13:04:02.816563Z","end":"2026-10-14T13:04:03.194755Z","steps":["trace[1733150338] 'process raft request' (duration: 377.891866ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:04:03.195138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:04:02.816544Z","time spent":"378.348339ms","remote":"127.0.0.1:53754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T13:04:03.195174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.954682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-10-14T13:04:03.195251Z","caller":"traceutil/trace.go:171","msg":"trace[81634942] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2869; }","duration":"206.067245ms","start":"2026-10-14T13:04:02.989162Z","end":"2026-10-14T13:04:03.195229Z","steps":["trace[81634942] 'agreement among raft nodes before linearized reading' (duration: 205.929151ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:04:03.19501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.628621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.91\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-10-14T13:04:03.195587Z","caller":"traceutil/trace.go:171","msg":"trace[1417151519] range","detail":"{range_begin:/registry/masterleases/162.253.55.91; range_end:; response_count:1; response_revision:2869; }","duration":"285.268928ms","start":"2026-10-14T13:04:02.910306Z","end":"2026-10-14T13:04:03.195575Z","steps":["trace[1417151519] 'agreement among raft nodes before linearized reading' (duration: 284.549158ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:04:03.195477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.358808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-14T13:04:03.195803Z","caller":"traceutil/trace.go:171","msg":"trace[575372943] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:2869; }","duration":"373.232543ms","start":"2026-10-14T13:04:02.822471Z","end":"2026-10-14T13:04:03.195704Z","steps":["trace[575372943] 'agreement among raft nodes before linearized reading' (duration: 372.308087ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:04:03.195945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:04:02.822458Z","time spent":"373.431758ms","remote":"127.0.0.1:53686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":59,"response size":31,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-10-14T13:04:03.195538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.314932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1296"} {"level":"info","ts":"2026-10-14T13:04:03.196452Z","caller":"traceutil/trace.go:171","msg":"trace[2108317149] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2869; }","duration":"179.30453ms","start":"2026-10-14T13:04:03.017133Z","end":"2026-10-14T13:04:03.196438Z","steps":["trace[2108317149] 'agreement among raft nodes before linearized reading' (duration: 177.939181ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:06:24.62888Z","caller":"traceutil/trace.go:171","msg":"trace[1623102492] linearizableReadLoop","detail":"{readStateIndex:4186; appliedIndex:4184; }","duration":"112.970749ms","start":"2026-10-14T13:06:24.515881Z","end":"2026-10-14T13:06:24.628851Z","steps":["trace[1623102492] 'read index received' (duration: 112.694713ms)","trace[1623102492] 'applied index is now lower than readState.Index' (duration: 275.096µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:06:24.629143Z","caller":"traceutil/trace.go:171","msg":"trace[1997012636] transaction","detail":"{read_only:false; response_revision:4005; number_of_response:1; }","duration":"162.189427ms","start":"2026-10-14T13:06:24.466928Z","end":"2026-10-14T13:06:24.629118Z","steps":["trace[1997012636] 'process raft request' (duration: 161.710007ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:06:24.629131Z","caller":"traceutil/trace.go:171","msg":"trace[418273996] transaction","detail":"{read_only:false; response_revision:4006; number_of_response:1; }","duration":"161.153276ms","start":"2026-10-14T13:06:24.467941Z","end":"2026-10-14T13:06:24.629094Z","steps":["trace[418273996] 'process raft request' (duration: 160.857049ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:06:24.629384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.444208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:06:24.629522Z","caller":"traceutil/trace.go:171","msg":"trace[2108396778] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4006; }","duration":"113.654883ms","start":"2026-10-14T13:06:24.515811Z","end":"2026-10-14T13:06:24.629465Z","steps":["trace[2108396778] 'agreement among raft nodes before linearized reading' (duration: 113.177612ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:06:32.046731Z","caller":"traceutil/trace.go:171","msg":"trace[358299266] transaction","detail":"{read_only:false; response_revision:4417; number_of_response:1; }","duration":"228.382314ms","start":"2026-10-14T13:06:31.818314Z","end":"2026-10-14T13:06:32.046697Z","steps":["trace[358299266] 'process raft request' (duration: 228.17221ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:06:32.087566Z","caller":"traceutil/trace.go:171","msg":"trace[119390069] transaction","detail":"{read_only:false; response_revision:4418; number_of_response:1; }","duration":"268.428479ms","start":"2026-10-14T13:06:31.819085Z","end":"2026-10-14T13:06:32.087513Z","steps":["trace[119390069] 'process raft request' (duration: 268.119442ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:06:32.087768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.07606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/local-path-storage/\" range_end:\"/registry/limitranges/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:06:32.087832Z","caller":"traceutil/trace.go:171","msg":"trace[461036286] range","detail":"{range_begin:/registry/limitranges/local-path-storage/; range_end:/registry/limitranges/local-path-storage0; response_count:0; response_revision:4421; }","duration":"267.196813ms","start":"2026-10-14T13:06:31.820624Z","end":"2026-10-14T13:06:32.08782Z","steps":["trace[461036286] 'agreement among raft nodes before linearized reading' (duration: 267.06355ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:06:32.087596Z","caller":"traceutil/trace.go:171","msg":"trace[43445914] linearizableReadLoop","detail":"{readStateIndex:4607; appliedIndex:4604; }","duration":"266.900927ms","start":"2026-10-14T13:06:31.820666Z","end":"2026-10-14T13:06:32.087567Z","steps":["trace[43445914] 'read index received' (duration: 226.000704ms)","trace[43445914] 'applied index is now lower than readState.Index' (duration: 40.899033ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:06:32.088109Z","caller":"traceutil/trace.go:171","msg":"trace[1533399065] transaction","detail":"{read_only:false; response_revision:4421; number_of_response:1; }","duration":"161.108292ms","start":"2026-10-14T13:06:31.926991Z","end":"2026-10-14T13:06:32.0881Z","steps":["trace[1533399065] 'process raft request' (duration: 160.52935ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:06:32.088214Z","caller":"traceutil/trace.go:171","msg":"trace[165971270] transaction","detail":"{read_only:false; response_revision:4419; number_of_response:1; }","duration":"268.706245ms","start":"2026-10-14T13:06:31.819481Z","end":"2026-10-14T13:06:32.088187Z","steps":["trace[165971270] 'process raft request' (duration: 267.869017ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:06:32.088241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.780874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:46603"} {"level":"info","ts":"2026-10-14T13:06:32.088294Z","caller":"traceutil/trace.go:171","msg":"trace[752678529] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4421; }","duration":"266.896657ms","start":"2026-10-14T13:06:31.821382Z","end":"2026-10-14T13:06:32.088279Z","steps":["trace[752678529] 'agreement among raft nodes before linearized reading' (duration: 266.536239ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:06:32.088297Z","caller":"traceutil/trace.go:171","msg":"trace[898981228] transaction","detail":"{read_only:false; response_revision:4420; number_of_response:1; }","duration":"264.531177ms","start":"2026-10-14T13:06:31.823722Z","end":"2026-10-14T13:06:32.088254Z","steps":["trace[898981228] 'process raft request' (duration: 263.73622ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:06:32.088584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.12071ms","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:7"} {"level":"warn","ts":"2026-10-14T13:06:32.088609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.911566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-10-14T13:06:32.088654Z","caller":"traceutil/trace.go:171","msg":"trace[625370458] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4421; }","duration":"266.967998ms","start":"2026-10-14T13:06:31.821677Z","end":"2026-10-14T13:06:32.088645Z","steps":["trace[625370458] 'agreement among raft nodes before linearized reading' (duration: 266.874466ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:06:32.088652Z","caller":"traceutil/trace.go:171","msg":"trace[817659582] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4421; }","duration":"212.203241ms","start":"2026-10-14T13:06:31.87641Z","end":"2026-10-14T13:06:32.088613Z","steps":["trace[817659582] 'agreement among raft nodes before linearized reading' (duration: 212.124259ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:06:32.094096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.906404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:46 size:2109529"} {"level":"info","ts":"2026-10-14T13:06:32.094191Z","caller":"traceutil/trace.go:171","msg":"trace[615717890] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:46; response_revision:4421; }","duration":"167.043447ms","start":"2026-10-14T13:06:31.927125Z","end":"2026-10-14T13:06:32.094169Z","steps":["trace[615717890] 'agreement among raft nodes before linearized reading' (duration: 161.135312ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:06:39.188944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.467057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2360973"} {"level":"info","ts":"2026-10-14T13:06:39.189023Z","caller":"traceutil/trace.go:171","msg":"trace[529585191] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4607; }","duration":"202.59365ms","start":"2026-10-14T13:06:38.986414Z","end":"2026-10-14T13:06:39.189008Z","steps":["trace[529585191] 'range keys from in-memory index tree' (duration: 201.538967ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:06:40.696078Z","caller":"traceutil/trace.go:171","msg":"trace[1436805487] transaction","detail":"{read_only:false; response_revision:4620; number_of_response:1; }","duration":"126.084784ms","start":"2026-10-14T13:06:40.569963Z","end":"2026-10-14T13:06:40.696047Z","steps":["trace[1436805487] 'process raft request' (duration: 125.87654ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:06:44.003964Z","caller":"traceutil/trace.go:171","msg":"trace[1549393671] transaction","detail":"{read_only:false; response_revision:4697; number_of_response:1; }","duration":"126.27381ms","start":"2026-10-14T13:06:43.877669Z","end":"2026-10-14T13:06:44.003942Z","steps":["trace[1549393671] 'process raft request' (duration: 125.932323ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:06:54.391124Z","caller":"traceutil/trace.go:171","msg":"trace[590902435] linearizableReadLoop","detail":"{readStateIndex:5062; appliedIndex:5061; }","duration":"140.729615ms","start":"2026-10-14T13:06:54.250357Z","end":"2026-10-14T13:06:54.391086Z","steps":["trace[590902435] 'read index received' (duration: 140.339497ms)","trace[590902435] 'applied index is now lower than readState.Index' (duration: 388.358µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:06:54.391203Z","caller":"traceutil/trace.go:171","msg":"trace[996714248] transaction","detail":"{read_only:false; response_revision:4856; number_of_response:1; }","duration":"141.696205ms","start":"2026-10-14T13:06:54.249476Z","end":"2026-10-14T13:06:54.391172Z","steps":["trace[996714248] 'process raft request' (duration: 141.365538ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:06:54.391351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.96581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:06:54.391463Z","caller":"traceutil/trace.go:171","msg":"trace[1117375918] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4856; }","duration":"141.121553ms","start":"2026-10-14T13:06:54.250314Z","end":"2026-10-14T13:06:54.391436Z","steps":["trace[1117375918] 'agreement among raft nodes before linearized reading' (duration: 140.912989ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:06:54.391483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.573305ms","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-10-14T13:06:54.391581Z","caller":"traceutil/trace.go:171","msg":"trace[2072605271] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4856; }","duration":"111.694888ms","start":"2026-10-14T13:06:54.27987Z","end":"2026-10-14T13:06:54.391565Z","steps":["trace[2072605271] 'agreement among raft nodes before linearized reading' (duration: 111.460003ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:06:54.50907Z","caller":"traceutil/trace.go:171","msg":"trace[1308192627] transaction","detail":"{read_only:false; response_revision:4857; number_of_response:1; }","duration":"112.250009ms","start":"2026-10-14T13:06:54.396779Z","end":"2026-10-14T13:06:54.509029Z","steps":["trace[1308192627] 'process raft request' (duration: 88.446469ms)","trace[1308192627] 'compare' (duration: 23.243078ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:06:58.983664Z","caller":"traceutil/trace.go:171","msg":"trace[700554808] linearizableReadLoop","detail":"{readStateIndex:5094; appliedIndex:5093; }","duration":"460.398812ms","start":"2026-10-14T13:06:58.523231Z","end":"2026-10-14T13:06:58.98363Z","steps":["trace[700554808] 'read index received' (duration: 460.097125ms)","trace[700554808] 'applied index is now lower than readState.Index' (duration: 300.307µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:06:58.98374Z","caller":"traceutil/trace.go:171","msg":"trace[1295635594] transaction","detail":"{read_only:false; response_revision:4886; number_of_response:1; }","duration":"545.270101ms","start":"2026-10-14T13:06:58.438422Z","end":"2026-10-14T13:06:58.983692Z","steps":["trace[1295635594] 'process raft request' (duration: 544.958334ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:06:58.983965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:06:58.438391Z","time spent":"545.446434ms","remote":"127.0.0.1:53676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11654,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T13:06:58.984037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.75949ms","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-10-14T13:06:58.9841Z","caller":"traceutil/trace.go:171","msg":"trace[1567880167] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4886; }","duration":"460.915213ms","start":"2026-10-14T13:06:58.523164Z","end":"2026-10-14T13:06:58.984079Z","steps":["trace[1567880167] 'agreement among raft nodes before linearized reading' (duration: 460.687648ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:06:58.98416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.292978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-10-14T13:06:58.984206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:06:58.523131Z","time spent":"461.014654ms","remote":"127.0.0.1:53754","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":"warn","ts":"2026-10-14T13:06:58.984302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.029855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-10-14T13:06:58.984352Z","caller":"traceutil/trace.go:171","msg":"trace[878355710] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:4886; }","duration":"256.115707ms","start":"2026-10-14T13:06:58.728225Z","end":"2026-10-14T13:06:58.98434Z","steps":["trace[878355710] 'agreement among raft nodes before linearized reading' (duration: 255.919763ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:06:58.984329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.539582ms","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-10-14T13:06:58.984239Z","caller":"traceutil/trace.go:171","msg":"trace[646224377] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4886; }","duration":"436.421311ms","start":"2026-10-14T13:06:58.547795Z","end":"2026-10-14T13:06:58.984216Z","steps":["trace[646224377] 'agreement among raft nodes before linearized reading' (duration: 436.254937ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:06:58.984438Z","caller":"traceutil/trace.go:171","msg":"trace[1509574569] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4886; }","duration":"186.670864ms","start":"2026-10-14T13:06:58.797738Z","end":"2026-10-14T13:06:58.984409Z","steps":["trace[1509574569] 'agreement among raft nodes before linearized reading' (duration: 186.354948ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:06:58.9845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:06:58.547766Z","time spent":"436.722847ms","remote":"127.0.0.1:53754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-10-14T13:06:59.445536Z","caller":"traceutil/trace.go:171","msg":"trace[107674184] linearizableReadLoop","detail":"{readStateIndex:5110; appliedIndex:5109; }","duration":"196.237066ms","start":"2026-10-14T13:06:59.249269Z","end":"2026-10-14T13:06:59.445506Z","steps":["trace[107674184] 'read index received' (duration: 123.934476ms)","trace[107674184] 'applied index is now lower than readState.Index' (duration: 72.30145ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:06:59.44563Z","caller":"traceutil/trace.go:171","msg":"trace[566103585] transaction","detail":"{read_only:false; response_revision:4902; number_of_response:1; }","duration":"210.698532ms","start":"2026-10-14T13:06:59.234879Z","end":"2026-10-14T13:06:59.445578Z","steps":["trace[566103585] 'process raft request' (duration: 138.481944ms)","trace[566103585] 'compare' (duration: 71.996803ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:06:59.445899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.609263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:06:59.446916Z","caller":"traceutil/trace.go:171","msg":"trace[1923563785] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4902; }","duration":"197.677776ms","start":"2026-10-14T13:06:59.249218Z","end":"2026-10-14T13:06:59.446895Z","steps":["trace[1923563785] 'agreement among raft nodes before linearized reading' (duration: 196.43619ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:06:59.446854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.769785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-14T13:06:59.447118Z","caller":"traceutil/trace.go:171","msg":"trace[127487151] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4902; }","duration":"129.066091ms","start":"2026-10-14T13:06:59.317999Z","end":"2026-10-14T13:06:59.447065Z","steps":["trace[127487151] 'agreement among raft nodes before linearized reading' (duration: 128.645812ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:06:59.447391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.169226ms","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-10-14T13:06:59.447481Z","caller":"traceutil/trace.go:171","msg":"trace[1991541157] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4902; }","duration":"113.325749ms","start":"2026-10-14T13:06:59.334131Z","end":"2026-10-14T13:06:59.447457Z","steps":["trace[1991541157] 'agreement among raft nodes before linearized reading' (duration: 112.951801ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:06:59.582067Z","caller":"traceutil/trace.go:171","msg":"trace[1722858394] linearizableReadLoop","detail":"{readStateIndex:5113; appliedIndex:5110; }","duration":"108.671134ms","start":"2026-10-14T13:06:59.473367Z","end":"2026-10-14T13:06:59.582038Z","steps":["trace[1722858394] 'read index received' (duration: 18.532229ms)","trace[1722858394] 'applied index is now lower than readState.Index' (duration: 90.137465ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:06:59.582115Z","caller":"traceutil/trace.go:171","msg":"trace[509991947] transaction","detail":"{read_only:false; response_revision:4904; number_of_response:1; }","duration":"128.99806ms","start":"2026-10-14T13:06:59.453084Z","end":"2026-10-14T13:06:59.582082Z","steps":["trace[509991947] 'process raft request' (duration: 94.216328ms)","trace[509991947] 'compare' (duration: 34.445385ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:06:59.582419Z","caller":"traceutil/trace.go:171","msg":"trace[885030798] transaction","detail":"{read_only:false; response_revision:4905; number_of_response:1; }","duration":"126.235423ms","start":"2026-10-14T13:06:59.456147Z","end":"2026-10-14T13:06:59.582383Z","steps":["trace[885030798] 'process raft request' (duration: 125.810995ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:06:59.582495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.887028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:06:59.582627Z","caller":"traceutil/trace.go:171","msg":"trace[1980629971] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:4905; }","duration":"109.184494ms","start":"2026-10-14T13:06:59.473346Z","end":"2026-10-14T13:06:59.58253Z","steps":["trace[1980629971] 'agreement among raft nodes before linearized reading' (duration: 108.829187ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:07:43.836209Z","caller":"traceutil/trace.go:171","msg":"trace[2113011650] transaction","detail":"{read_only:false; response_revision:5345; number_of_response:1; }","duration":"102.407546ms","start":"2026-10-14T13:07:43.733776Z","end":"2026-10-14T13:07:43.836183Z","steps":["trace[2113011650] 'process raft request' (duration: 102.221632ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:09:29.904928Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3048} {"level":"info","ts":"2026-10-14T13:09:30.02271Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3048,"took":"115.466346ms","hash":688763774,"current-db-size-bytes":58204160,"current-db-size":"58 MB","current-db-size-in-use-bytes":30736384,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-14T13:09:30.02279Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":688763774,"revision":3048,"compact-revision":-1} {"level":"info","ts":"2026-10-14T13:14:29.915029Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6162} {"level":"info","ts":"2026-10-14T13:14:30.023708Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6162,"took":"106.268046ms","hash":7454241,"current-db-size-bytes":58204160,"current-db-size":"58 MB","current-db-size-in-use-bytes":18776064,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-14T13:14:30.02377Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":7454241,"revision":6162,"compact-revision":3048}