{"level":"warn","ts":"2026-10-11T07:49:12.344047Z","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-11T07:49:12.344127Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.193: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.193:2380","--initial-cluster=instance=https://162.253.55.193:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.193:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.193: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-11T07:49:12.344187Z","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-11T07:49:12.344195Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.193:2380"]} {"level":"info","ts":"2026-10-11T07:49:12.344211Z","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-11T07:49:12.34478Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.193:2379"]} {"level":"info","ts":"2026-10-11T07:49:12.344863Z","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.193:2380"],"listen-peer-urls":["https://162.253.55.193:2380"],"advertise-client-urls":["https://162.253.55.193:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.193:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.193: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-11T07:49:12.350012Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.919514ms"} {"level":"info","ts":"2026-10-11T07:49:12.357107Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6814e3e3d6b4d713","cluster-id":"e5e99c9118b1492a"} {"level":"info","ts":"2026-10-11T07:49:12.357211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 switched to configuration voters=()"} {"level":"info","ts":"2026-10-11T07:49:12.357253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became follower at term 0"} {"level":"info","ts":"2026-10-11T07:49:12.357263Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6814e3e3d6b4d713 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-11T07:49:12.357274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became follower at term 1"} {"level":"info","ts":"2026-10-11T07:49:12.35733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 switched to configuration voters=(7499869847177975571)"} {"level":"warn","ts":"2026-10-11T07:49:12.366975Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-11T07:49:12.368497Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-11T07:49:12.370001Z","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-11T07:49:12.372218Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6814e3e3d6b4d713","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-11T07:49:12.372606Z","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-11T07:49:12.372695Z","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-11T07:49:12.372778Z","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-11T07:49:12.372747Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6814e3e3d6b4d713","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-11T07:49:12.374373Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 switched to configuration voters=(7499869847177975571)"} {"level":"info","ts":"2026-10-11T07:49:12.374638Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e5e99c9118b1492a","local-member-id":"6814e3e3d6b4d713","added-peer-id":"6814e3e3d6b4d713","added-peer-peer-urls":["https://162.253.55.193:2380"]} {"level":"info","ts":"2026-10-11T07:49:12.376057Z","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-11T07:49:12.376218Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.193:2380"} {"level":"info","ts":"2026-10-11T07:49:12.376269Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.193:2380"} {"level":"info","ts":"2026-10-11T07:49:12.377589Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6814e3e3d6b4d713","initial-advertise-peer-urls":["https://162.253.55.193:2380"],"listen-peer-urls":["https://162.253.55.193:2380"],"advertise-client-urls":["https://162.253.55.193:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.193:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-11T07:49:12.377632Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-11T07:49:12.657938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 is starting a new election at term 1"} {"level":"info","ts":"2026-10-11T07:49:12.65798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-11T07:49:12.657999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 received MsgPreVoteResp from 6814e3e3d6b4d713 at term 1"} {"level":"info","ts":"2026-10-11T07:49:12.658016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became candidate at term 2"} {"level":"info","ts":"2026-10-11T07:49:12.658046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 received MsgVoteResp from 6814e3e3d6b4d713 at term 2"} {"level":"info","ts":"2026-10-11T07:49:12.658061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became leader at term 2"} {"level":"info","ts":"2026-10-11T07:49:12.658074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6814e3e3d6b4d713 elected leader 6814e3e3d6b4d713 at term 2"} {"level":"info","ts":"2026-10-11T07:49:12.659004Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-11T07:49:12.660062Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6814e3e3d6b4d713","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.193:2379]}","request-path":"/0/members/6814e3e3d6b4d713/attributes","cluster-id":"e5e99c9118b1492a","publish-timeout":"7s"} {"level":"info","ts":"2026-10-11T07:49:12.660205Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-11T07:49:12.660278Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-11T07:49:12.660433Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-11T07:49:12.660458Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-11T07:49:12.663328Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.193:2379"} {"level":"info","ts":"2026-10-11T07:49:12.673595Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e5e99c9118b1492a","local-member-id":"6814e3e3d6b4d713","cluster-version":"3.5"} {"level":"info","ts":"2026-10-11T07:49:12.673769Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-11T07:49:12.673823Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-11T07:49:12.676597Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-11T07:49:26.502426Z","caller":"traceutil/trace.go:171","msg":"trace[1268811410] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"184.886625ms","start":"2026-10-11T07:49:26.31752Z","end":"2026-10-11T07:49:26.502407Z","steps":["trace[1268811410] 'process raft request' (duration: 184.731198ms)"],"step_count":1} {"level":"warn","ts":"2026-10-11T07:49:26.924954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.7322ms","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-11T07:49:26.925018Z","caller":"traceutil/trace.go:171","msg":"trace[255699035] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:400; }","duration":"151.829515ms","start":"2026-10-11T07:49:26.773176Z","end":"2026-10-11T07:49:26.925005Z","steps":["trace[255699035] 'range keys from in-memory index tree' (duration: 151.675867ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:49:27.053088Z","caller":"traceutil/trace.go:171","msg":"trace[2017787190] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"124.020658ms","start":"2026-10-11T07:49:26.929054Z","end":"2026-10-11T07:49:27.053074Z","steps":["trace[2017787190] 'process raft request' (duration: 123.935864ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:49:39.258779Z","caller":"traceutil/trace.go:171","msg":"trace[547342951] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"150.57194ms","start":"2026-10-11T07:49:39.10818Z","end":"2026-10-11T07:49:39.258752Z","steps":["trace[547342951] 'process raft request' (duration: 150.350279ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:50:02.598782Z","caller":"traceutil/trace.go:171","msg":"trace[676245052] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"364.758904ms","start":"2026-10-11T07:50:02.233985Z","end":"2026-10-11T07:50:02.598743Z","steps":["trace[676245052] 'process raft request' (duration: 364.258258ms)"],"step_count":1} {"level":"warn","ts":"2026-10-11T07:50:02.599473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-11T07:50:02.233966Z","time spent":"364.974814ms","remote":"127.0.0.1:41758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036297,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-11T07:50:02.830753Z","caller":"traceutil/trace.go:171","msg":"trace[248373049] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"160.34564ms","start":"2026-10-11T07:50:02.670216Z","end":"2026-10-11T07:50:02.830561Z","steps":["trace[248373049] 'process raft request' (duration: 159.1507ms)"],"step_count":1} {"level":"warn","ts":"2026-10-11T07:50:03.463916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.834746ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-11T07:50:03.464232Z","caller":"traceutil/trace.go:171","msg":"trace[1776950699] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"615.867169ms","start":"2026-10-11T07:50:02.848308Z","end":"2026-10-11T07:50:03.464175Z","steps":["trace[1776950699] 'process raft request' (duration: 108.571631ms)","trace[1776950699] 'compare' (duration: 506.652246ms)"],"step_count":2} {"level":"warn","ts":"2026-10-11T07:50:03.46451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-11T07:50:02.848293Z","time spent":"616.044878ms","remote":"127.0.0.1:41848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-11T07:50:03.464747Z","caller":"traceutil/trace.go:171","msg":"trace[526602748] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"231.515428ms","start":"2026-10-11T07:50:03.233214Z","end":"2026-10-11T07:50:03.46473Z","steps":["trace[526602748] 'process raft request' (duration: 230.981011ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:50:05.082666Z","caller":"traceutil/trace.go:171","msg":"trace[1397530742] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"106.661533ms","start":"2026-10-11T07:50:04.975981Z","end":"2026-10-11T07:50:05.082643Z","steps":["trace[1397530742] 'process raft request' (duration: 106.546327ms)"],"step_count":1} {"level":"warn","ts":"2026-10-11T07:50:19.367548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.399844ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-11T07:50:19.367937Z","caller":"traceutil/trace.go:171","msg":"trace[1246951538] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"342.833182ms","start":"2026-10-11T07:50:19.024844Z","end":"2026-10-11T07:50:19.367677Z","steps":["trace[1246951538] 'process raft request' (duration: 101.149583ms)","trace[1246951538] 'compare' (duration: 241.017105ms)"],"step_count":2} {"level":"warn","ts":"2026-10-11T07:50:19.368063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-11T07:50:19.024827Z","time spent":"343.175279ms","remote":"127.0.0.1:41944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-11T07:50:19.380691Z","caller":"traceutil/trace.go:171","msg":"trace[360267813] linearizableReadLoop","detail":"{readStateIndex:849; appliedIndex:848; }","duration":"223.085068ms","start":"2026-10-11T07:50:19.157578Z","end":"2026-10-11T07:50:19.380663Z","steps":["trace[360267813] 'read index received' (duration: 222.909649ms)","trace[360267813] 'applied index is now lower than readState.Index' (duration: 174.379µs)"],"step_count":2} {"level":"info","ts":"2026-10-11T07:50:19.380825Z","caller":"traceutil/trace.go:171","msg":"trace[1235938395] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"237.655983ms","start":"2026-10-11T07:50:19.143158Z","end":"2026-10-11T07:50:19.380814Z","steps":["trace[1235938395] 'process raft request' (duration: 237.362778ms)"],"step_count":1} {"level":"warn","ts":"2026-10-11T07:50:19.381027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.384509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-11T07:50:19.381096Z","caller":"traceutil/trace.go:171","msg":"trace[1634870540] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:816; }","duration":"167.491625ms","start":"2026-10-11T07:50:19.213588Z","end":"2026-10-11T07:50:19.38108Z","steps":["trace[1634870540] 'agreement among raft nodes before linearized reading' (duration: 167.378759ms)"],"step_count":1} {"level":"warn","ts":"2026-10-11T07:50:19.381154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.558272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-11T07:50:19.381302Z","caller":"traceutil/trace.go:171","msg":"trace[1384661404] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:816; }","duration":"223.727071ms","start":"2026-10-11T07:50:19.157525Z","end":"2026-10-11T07:50:19.381252Z","steps":["trace[1384661404] 'agreement among raft nodes before linearized reading' (duration: 223.51324ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:50:49.281948Z","caller":"traceutil/trace.go:171","msg":"trace[835128141] linearizableReadLoop","detail":"{readStateIndex:1256; appliedIndex:1255; }","duration":"192.081631ms","start":"2026-10-11T07:50:49.089845Z","end":"2026-10-11T07:50:49.281927Z","steps":["trace[835128141] 'read index received' (duration: 191.964695ms)","trace[835128141] 'applied index is now lower than readState.Index' (duration: 115.986µs)"],"step_count":2} {"level":"warn","ts":"2026-10-11T07:50:49.282131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.26653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-11T07:50:49.282177Z","caller":"traceutil/trace.go:171","msg":"trace[625198851] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1215; }","duration":"192.346935ms","start":"2026-10-11T07:50:49.08982Z","end":"2026-10-11T07:50:49.282167Z","steps":["trace[625198851] 'agreement among raft nodes before linearized reading' (duration: 192.215818ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:50:49.282109Z","caller":"traceutil/trace.go:171","msg":"trace[1266354608] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"267.81436ms","start":"2026-10-11T07:50:49.01419Z","end":"2026-10-11T07:50:49.282004Z","steps":["trace[1266354608] 'process raft request' (duration: 267.598259ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:50:49.283199Z","caller":"traceutil/trace.go:171","msg":"trace[1244311546] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"133.626846ms","start":"2026-10-11T07:50:49.149558Z","end":"2026-10-11T07:50:49.283185Z","steps":["trace[1244311546] 'process raft request' (duration: 133.257997ms)"],"step_count":1} {"level":"warn","ts":"2026-10-11T07:51:06.251564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.097625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-create-2mhmx\" ","response":"range_response_count:1 size:4197"} {"level":"info","ts":"2026-10-11T07:51:06.251656Z","caller":"traceutil/trace.go:171","msg":"trace[1046230918] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-create-2mhmx; range_end:; response_count:1; response_revision:1359; }","duration":"125.243733ms","start":"2026-10-11T07:51:06.126391Z","end":"2026-10-11T07:51:06.251635Z","steps":["trace[1046230918] 'range keys from in-memory index tree' (duration: 124.871133ms)"],"step_count":1} {"level":"warn","ts":"2026-10-11T07:51:37.598559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.432147ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-11T07:51:37.598783Z","caller":"traceutil/trace.go:171","msg":"trace[1179083275] transaction","detail":"{read_only:false; response_revision:1900; number_of_response:1; }","duration":"141.84297ms","start":"2026-10-11T07:51:37.456875Z","end":"2026-10-11T07:51:37.598718Z","steps":["trace[1179083275] 'process raft request' (duration: 24.130876ms)","trace[1179083275] 'compare' (duration: 117.315488ms)"],"step_count":2} {"level":"warn","ts":"2026-10-11T07:51:38.092375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.797502ms","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-11T07:51:38.092482Z","caller":"traceutil/trace.go:171","msg":"trace[2115025209] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1902; }","duration":"154.978521ms","start":"2026-10-11T07:51:37.937481Z","end":"2026-10-11T07:51:38.09246Z","steps":["trace[2115025209] 'range keys from in-memory index tree' (duration: 154.591115ms)"],"step_count":1} {"level":"warn","ts":"2026-10-11T07:51:38.092459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.701324ms","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-11T07:51:38.092545Z","caller":"traceutil/trace.go:171","msg":"trace[661613208] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1902; }","duration":"153.836872ms","start":"2026-10-11T07:51:37.938691Z","end":"2026-10-11T07:51:38.092528Z","steps":["trace[661613208] 'range keys from in-memory index tree' (duration: 153.487366ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:51:38.588384Z","caller":"traceutil/trace.go:171","msg":"trace[1305243818] linearizableReadLoop","detail":"{readStateIndex:1984; appliedIndex:1983; }","duration":"258.944033ms","start":"2026-10-11T07:51:38.329415Z","end":"2026-10-11T07:51:38.588359Z","steps":["trace[1305243818] 'read index received' (duration: 258.748475ms)","trace[1305243818] 'applied index is now lower than readState.Index' (duration: 194.588µs)"],"step_count":2} {"level":"warn","ts":"2026-10-11T07:51:38.588541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.133512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4f3dd3dd-8e0a-4836-bf76-5422c6729032\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-10-11T07:51:38.588588Z","caller":"traceutil/trace.go:171","msg":"trace[681575614] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4f3dd3dd-8e0a-4836-bf76-5422c6729032; range_end:; response_count:1; response_revision:1908; }","duration":"259.24997ms","start":"2026-10-11T07:51:38.329319Z","end":"2026-10-11T07:51:38.588569Z","steps":["trace[681575614] 'agreement among raft nodes before linearized reading' (duration: 259.162521ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:51:38.588781Z","caller":"traceutil/trace.go:171","msg":"trace[1803336601] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"285.16225ms","start":"2026-10-11T07:51:38.303585Z","end":"2026-10-11T07:51:38.588748Z","steps":["trace[1803336601] 'process raft request' (duration: 284.622166ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:51:50.362589Z","caller":"traceutil/trace.go:171","msg":"trace[496393519] transaction","detail":"{read_only:false; response_revision:2006; number_of_response:1; }","duration":"154.389841ms","start":"2026-10-11T07:51:50.208184Z","end":"2026-10-11T07:51:50.362574Z","steps":["trace[496393519] 'process raft request' (duration: 154.206162ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:51:50.362808Z","caller":"traceutil/trace.go:171","msg":"trace[1026414789] linearizableReadLoop","detail":"{readStateIndex:2084; appliedIndex:2083; }","duration":"149.890694ms","start":"2026-10-11T07:51:50.21264Z","end":"2026-10-11T07:51:50.36253Z","steps":["trace[1026414789] 'read index received' (duration: 149.792284ms)","trace[1026414789] 'applied index is now lower than readState.Index' (duration: 97.46µs)"],"step_count":2} {"level":"warn","ts":"2026-10-11T07:51:50.362928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.271812ms","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-10-11T07:51:50.36319Z","caller":"traceutil/trace.go:171","msg":"trace[1418716436] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2006; }","duration":"150.559491ms","start":"2026-10-11T07:51:50.212609Z","end":"2026-10-11T07:51:50.363169Z","steps":["trace[1418716436] 'agreement among raft nodes before linearized reading' (duration: 150.140383ms)"],"step_count":1} {"level":"warn","ts":"2026-10-11T07:51:50.385075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.681969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-11T07:51:50.385105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.150037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-11T07:51:50.385122Z","caller":"traceutil/trace.go:171","msg":"trace[1539564856] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2007; }","duration":"160.778779ms","start":"2026-10-11T07:51:50.224332Z","end":"2026-10-11T07:51:50.385111Z","steps":["trace[1539564856] 'agreement among raft nodes before linearized reading' (duration: 160.6779ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:51:50.385148Z","caller":"traceutil/trace.go:171","msg":"trace[687245232] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2007; }","duration":"165.235296ms","start":"2026-10-11T07:51:50.219901Z","end":"2026-10-11T07:51:50.385136Z","steps":["trace[687245232] 'agreement among raft nodes before linearized reading' (duration: 165.037937ms)"],"step_count":1} {"level":"warn","ts":"2026-10-11T07:51:50.38529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.009824ms","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-10-11T07:51:50.385411Z","caller":"traceutil/trace.go:171","msg":"trace[786296168] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2007; }","duration":"124.299263ms","start":"2026-10-11T07:51:50.261064Z","end":"2026-10-11T07:51:50.385364Z","steps":["trace[786296168] 'agreement among raft nodes before linearized reading' (duration: 123.923325ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:51:50.384958Z","caller":"traceutil/trace.go:171","msg":"trace[919530495] transaction","detail":"{read_only:false; response_revision:2007; number_of_response:1; }","duration":"157.753014ms","start":"2026-10-11T07:51:50.227188Z","end":"2026-10-11T07:51:50.384941Z","steps":["trace[919530495] 'process raft request' (duration: 157.675074ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:51:54.0131Z","caller":"traceutil/trace.go:171","msg":"trace[654956526] linearizableReadLoop","detail":"{readStateIndex:2113; appliedIndex:2112; }","duration":"175.521085ms","start":"2026-10-11T07:51:53.83756Z","end":"2026-10-11T07:51:54.013081Z","steps":["trace[654956526] 'read index received' (duration: 175.328596ms)","trace[654956526] 'applied index is now lower than readState.Index' (duration: 191.809µs)"],"step_count":2} {"level":"info","ts":"2026-10-11T07:51:54.013197Z","caller":"traceutil/trace.go:171","msg":"trace[1347526550] transaction","detail":"{read_only:false; response_revision:2034; number_of_response:1; }","duration":"242.365017ms","start":"2026-10-11T07:51:53.770823Z","end":"2026-10-11T07:51:54.013188Z","steps":["trace[1347526550] 'process raft request' (duration: 242.117548ms)"],"step_count":1} {"level":"warn","ts":"2026-10-11T07:51:54.013558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.194282ms","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-10-11T07:51:54.013774Z","caller":"traceutil/trace.go:171","msg":"trace[1399740336] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2034; }","duration":"140.456911ms","start":"2026-10-11T07:51:53.873295Z","end":"2026-10-11T07:51:54.013752Z","steps":["trace[1399740336] 'agreement among raft nodes before linearized reading' (duration: 140.107952ms)"],"step_count":1} {"level":"warn","ts":"2026-10-11T07:51:54.013587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.007703ms","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-10-11T07:51:54.014033Z","caller":"traceutil/trace.go:171","msg":"trace[1352476304] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2034; }","duration":"176.503822ms","start":"2026-10-11T07:51:53.83751Z","end":"2026-10-11T07:51:54.014014Z","steps":["trace[1352476304] 'agreement among raft nodes before linearized reading' (duration: 175.905104ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:52:16.432564Z","caller":"traceutil/trace.go:171","msg":"trace[423188607] linearizableReadLoop","detail":"{readStateIndex:2246; appliedIndex:2245; }","duration":"152.388981ms","start":"2026-10-11T07:52:16.280154Z","end":"2026-10-11T07:52:16.432543Z","steps":["trace[423188607] 'read index received' (duration: 152.15364ms)","trace[423188607] 'applied index is now lower than readState.Index' (duration: 234.451µs)"],"step_count":2} {"level":"warn","ts":"2026-10-11T07:52:16.432804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.626852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12383"} {"level":"info","ts":"2026-10-11T07:52:16.432843Z","caller":"traceutil/trace.go:171","msg":"trace[805850431] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2162; }","duration":"152.684192ms","start":"2026-10-11T07:52:16.280147Z","end":"2026-10-11T07:52:16.432832Z","steps":["trace[805850431] 'agreement among raft nodes before linearized reading' (duration: 152.495061ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:52:16.433182Z","caller":"traceutil/trace.go:171","msg":"trace[878704326] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"155.129882ms","start":"2026-10-11T07:52:16.27804Z","end":"2026-10-11T07:52:16.43317Z","steps":["trace[878704326] 'process raft request' (duration: 154.329909ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:52:16.593426Z","caller":"traceutil/trace.go:171","msg":"trace[1770045776] linearizableReadLoop","detail":"{readStateIndex:2247; appliedIndex:2246; }","duration":"144.587657ms","start":"2026-10-11T07:52:16.448816Z","end":"2026-10-11T07:52:16.593404Z","steps":["trace[1770045776] 'read index received' (duration: 52.786709ms)","trace[1770045776] 'applied index is now lower than readState.Index' (duration: 91.799758ms)"],"step_count":2} {"level":"info","ts":"2026-10-11T07:52:16.59347Z","caller":"traceutil/trace.go:171","msg":"trace[1090672010] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"149.487368ms","start":"2026-10-11T07:52:16.443934Z","end":"2026-10-11T07:52:16.593422Z","steps":["trace[1090672010] 'process raft request' (duration: 57.70696ms)","trace[1090672010] 'compare' (duration: 91.615767ms)"],"step_count":2} {"level":"warn","ts":"2026-10-11T07:52:16.593598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.760497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-11T07:52:16.593667Z","caller":"traceutil/trace.go:171","msg":"trace[1323966137] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2163; }","duration":"144.895378ms","start":"2026-10-11T07:52:16.448752Z","end":"2026-10-11T07:52:16.593648Z","steps":["trace[1323966137] 'agreement among raft nodes before linearized reading' (duration: 144.766777ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:52:17.996977Z","caller":"traceutil/trace.go:171","msg":"trace[445728411] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"148.20445ms","start":"2026-10-11T07:52:17.848735Z","end":"2026-10-11T07:52:17.99694Z","steps":["trace[445728411] 'process raft request' (duration: 147.995349ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:52:18.378793Z","caller":"traceutil/trace.go:171","msg":"trace[101111903] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"168.57565ms","start":"2026-10-11T07:52:18.210194Z","end":"2026-10-11T07:52:18.37877Z","steps":["trace[101111903] 'process raft request' (duration: 164.438799ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:52:18.383731Z","caller":"traceutil/trace.go:171","msg":"trace[233124262] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"173.016171ms","start":"2026-10-11T07:52:18.210701Z","end":"2026-10-11T07:52:18.383717Z","steps":["trace[233124262] 'process raft request' (duration: 172.949051ms)"],"step_count":1} {"level":"warn","ts":"2026-10-11T07:53:09.148987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.62604ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-11T07:53:09.149102Z","caller":"traceutil/trace.go:171","msg":"trace[1155028070] transaction","detail":"{read_only:false; response_revision:2495; number_of_response:1; }","duration":"130.303143ms","start":"2026-10-11T07:53:09.018781Z","end":"2026-10-11T07:53:09.149085Z","steps":["trace[1155028070] 'compare' (duration: 123.500547ms)"],"step_count":1} {"level":"warn","ts":"2026-10-11T07:53:50.445283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.125487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-11T07:53:50.445438Z","caller":"traceutil/trace.go:171","msg":"trace[1420825785] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:2774; }","duration":"128.311141ms","start":"2026-10-11T07:53:50.317065Z","end":"2026-10-11T07:53:50.445376Z","steps":["trace[1420825785] 'count revisions from in-memory index tree' (duration: 128.041444ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:53:50.865647Z","caller":"traceutil/trace.go:171","msg":"trace[1989661974] transaction","detail":"{read_only:false; response_revision:2776; number_of_response:1; }","duration":"132.761126ms","start":"2026-10-11T07:53:50.732861Z","end":"2026-10-11T07:53:50.865622Z","steps":["trace[1989661974] 'process raft request' (duration: 132.348126ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:53:56.342249Z","caller":"traceutil/trace.go:171","msg":"trace[379935632] linearizableReadLoop","detail":"{readStateIndex:2915; appliedIndex:2914; }","duration":"135.829921ms","start":"2026-10-11T07:53:56.206402Z","end":"2026-10-11T07:53:56.342232Z","steps":["trace[379935632] 'read index received' (duration: 135.719308ms)","trace[379935632] 'applied index is now lower than readState.Index' (duration: 109.653µs)"],"step_count":2} {"level":"warn","ts":"2026-10-11T07:53:56.342368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.955264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-11T07:53:56.342432Z","caller":"traceutil/trace.go:171","msg":"trace[1496737996] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2808; }","duration":"136.088617ms","start":"2026-10-11T07:53:56.206336Z","end":"2026-10-11T07:53:56.342424Z","steps":["trace[1496737996] 'agreement among raft nodes before linearized reading' (duration: 135.969334ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:53:56.342367Z","caller":"traceutil/trace.go:171","msg":"trace[1262405189] transaction","detail":"{read_only:false; response_revision:2808; number_of_response:1; }","duration":"205.359089ms","start":"2026-10-11T07:53:56.136974Z","end":"2026-10-11T07:53:56.342333Z","steps":["trace[1262405189] 'process raft request' (duration: 205.154334ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:58:16.465892Z","caller":"traceutil/trace.go:171","msg":"trace[451107410] transaction","detail":"{read_only:false; response_revision:4766; number_of_response:1; }","duration":"115.722445ms","start":"2026-10-11T07:58:16.350145Z","end":"2026-10-11T07:58:16.465867Z","steps":["trace[451107410] 'process raft request' (duration: 107.442867ms)"],"step_count":1} {"level":"warn","ts":"2026-10-11T07:58:16.466257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.186105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-10-11T07:58:16.466296Z","caller":"traceutil/trace.go:171","msg":"trace[893129390] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4768; }","duration":"122.244857ms","start":"2026-10-11T07:58:16.344035Z","end":"2026-10-11T07:58:16.46628Z","steps":["trace[893129390] 'agreement among raft nodes before linearized reading' (duration: 122.088481ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:58:21.572001Z","caller":"traceutil/trace.go:171","msg":"trace[1041316063] transaction","detail":"{read_only:false; response_revision:4873; number_of_response:1; }","duration":"108.157127ms","start":"2026-10-11T07:58:21.463819Z","end":"2026-10-11T07:58:21.571976Z","steps":["trace[1041316063] 'process raft request' (duration: 107.782361ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:58:21.817063Z","caller":"traceutil/trace.go:171","msg":"trace[116819648] transaction","detail":"{read_only:false; response_revision:4883; number_of_response:1; }","duration":"134.133786ms","start":"2026-10-11T07:58:21.682907Z","end":"2026-10-11T07:58:21.81704Z","steps":["trace[116819648] 'process raft request' (duration: 134.00005ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:58:21.827738Z","caller":"traceutil/trace.go:171","msg":"trace[228496053] linearizableReadLoop","detail":"{readStateIndex:5071; appliedIndex:5069; }","duration":"141.569299ms","start":"2026-10-11T07:58:21.686151Z","end":"2026-10-11T07:58:21.827721Z","steps":["trace[228496053] 'read index received' (duration: 130.744319ms)","trace[228496053] 'applied index is now lower than readState.Index' (duration: 10.82356ms)"],"step_count":2} {"level":"info","ts":"2026-10-11T07:58:21.827826Z","caller":"traceutil/trace.go:171","msg":"trace[647788230] transaction","detail":"{read_only:false; response_revision:4884; number_of_response:1; }","duration":"143.306244ms","start":"2026-10-11T07:58:21.684513Z","end":"2026-10-11T07:58:21.82782Z","steps":["trace[647788230] 'process raft request' (duration: 143.066714ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:58:21.82811Z","caller":"traceutil/trace.go:171","msg":"trace[551131566] transaction","detail":"{read_only:false; response_revision:4885; number_of_response:1; }","duration":"139.784091ms","start":"2026-10-11T07:58:21.688318Z","end":"2026-10-11T07:58:21.828102Z","steps":["trace[551131566] 'process raft request' (duration: 139.355503ms)"],"step_count":1} {"level":"warn","ts":"2026-10-11T07:58:21.828213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.046419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-11T07:58:21.828234Z","caller":"traceutil/trace.go:171","msg":"trace[2088484151] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:4885; }","duration":"142.130313ms","start":"2026-10-11T07:58:21.686096Z","end":"2026-10-11T07:58:21.828226Z","steps":["trace[2088484151] 'agreement among raft nodes before linearized reading' (duration: 142.07342ms)"],"step_count":1} {"level":"warn","ts":"2026-10-11T07:58:21.831081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.818616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-10-11T07:58:21.831109Z","caller":"traceutil/trace.go:171","msg":"trace[1711288772] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4885; }","duration":"111.877349ms","start":"2026-10-11T07:58:21.719224Z","end":"2026-10-11T07:58:21.831102Z","steps":["trace[1711288772] 'agreement among raft nodes before linearized reading' (duration: 109.084097ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:58:28.142112Z","caller":"traceutil/trace.go:171","msg":"trace[45217104] transaction","detail":"{read_only:false; response_revision:5002; number_of_response:1; }","duration":"186.302954ms","start":"2026-10-11T07:58:27.955778Z","end":"2026-10-11T07:58:28.142081Z","steps":["trace[45217104] 'process raft request' (duration: 169.378797ms)","trace[45217104] 'compare' (duration: 16.570192ms)"],"step_count":2} {"level":"info","ts":"2026-10-11T07:58:28.157532Z","caller":"traceutil/trace.go:171","msg":"trace[66848644] transaction","detail":"{read_only:false; response_revision:5003; number_of_response:1; }","duration":"130.941063ms","start":"2026-10-11T07:58:28.026553Z","end":"2026-10-11T07:58:28.157494Z","steps":["trace[66848644] 'process raft request' (duration: 130.63786ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:58:28.732685Z","caller":"traceutil/trace.go:171","msg":"trace[1986206178] transaction","detail":"{read_only:false; response_revision:5011; number_of_response:1; }","duration":"196.630435ms","start":"2026-10-11T07:58:28.536014Z","end":"2026-10-11T07:58:28.732645Z","steps":["trace[1986206178] 'process raft request' (duration: 160.634327ms)","trace[1986206178] 'compare' (duration: 35.736806ms)"],"step_count":2} {"level":"info","ts":"2026-10-11T07:58:28.732759Z","caller":"traceutil/trace.go:171","msg":"trace[1291914217] linearizableReadLoop","detail":"{readStateIndex:5201; appliedIndex:5200; }","duration":"193.710428ms","start":"2026-10-11T07:58:28.538978Z","end":"2026-10-11T07:58:28.732688Z","steps":["trace[1291914217] 'read index received' (duration: 157.662108ms)","trace[1291914217] 'applied index is now lower than readState.Index' (duration: 36.045139ms)"],"step_count":2} {"level":"warn","ts":"2026-10-11T07:58:28.733148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.120705ms","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-11T07:58:28.733195Z","caller":"traceutil/trace.go:171","msg":"trace[1412509489] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5012; }","duration":"194.265902ms","start":"2026-10-11T07:58:28.538918Z","end":"2026-10-11T07:58:28.733184Z","steps":["trace[1412509489] 'agreement among raft nodes before linearized reading' (duration: 193.919867ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:58:28.880602Z","caller":"traceutil/trace.go:171","msg":"trace[512515492] transaction","detail":"{read_only:false; response_revision:5013; number_of_response:1; }","duration":"141.87647ms","start":"2026-10-11T07:58:28.738691Z","end":"2026-10-11T07:58:28.880568Z","steps":["trace[512515492] 'process raft request' (duration: 119.920654ms)","trace[512515492] 'compare' (duration: 21.8061ms)"],"step_count":2} {"level":"warn","ts":"2026-10-11T07:58:42.114889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.78103ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-11T07:58:42.115627Z","caller":"traceutil/trace.go:171","msg":"trace[1506599444] linearizableReadLoop","detail":"{readStateIndex:5380; appliedIndex:5378; }","duration":"276.427762ms","start":"2026-10-11T07:58:41.839181Z","end":"2026-10-11T07:58:42.115608Z","steps":["trace[1506599444] 'read index received' (duration: 16.824726ms)","trace[1506599444] 'applied index is now lower than readState.Index' (duration: 259.602116ms)"],"step_count":2} {"level":"info","ts":"2026-10-11T07:58:42.115859Z","caller":"traceutil/trace.go:171","msg":"trace[333880857] transaction","detail":"{read_only:false; response_revision:5183; number_of_response:1; }","duration":"460.980021ms","start":"2026-10-11T07:58:41.654861Z","end":"2026-10-11T07:58:42.115841Z","steps":["trace[333880857] 'process raft request' (duration: 201.144535ms)","trace[333880857] 'compare' (duration: 258.628363ms)"],"step_count":2} {"level":"warn","ts":"2026-10-11T07:58:42.11606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-11T07:58:41.654843Z","time spent":"461.154059ms","remote":"127.0.0.1:41944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-11T07:58:42.116194Z","caller":"traceutil/trace.go:171","msg":"trace[1397648475] transaction","detail":"{read_only:false; response_revision:5184; number_of_response:1; }","duration":"301.545033ms","start":"2026-10-11T07:58:41.814601Z","end":"2026-10-11T07:58:42.116146Z","steps":["trace[1397648475] 'process raft request' (duration: 300.914695ms)"],"step_count":1} {"level":"warn","ts":"2026-10-11T07:58:42.116292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.105983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"warn","ts":"2026-10-11T07:58:42.116344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-11T07:58:41.814582Z","time spent":"301.686878ms","remote":"127.0.0.1:41944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-11T07:58:42.116401Z","caller":"traceutil/trace.go:171","msg":"trace[1337405699] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5184; }","duration":"277.246859ms","start":"2026-10-11T07:58:41.839124Z","end":"2026-10-11T07:58:42.116371Z","steps":["trace[1337405699] 'agreement among raft nodes before linearized reading' (duration: 276.912234ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T07:59:12.731074Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2894} {"level":"info","ts":"2026-10-11T07:59:12.845829Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2894,"took":"110.497506ms","hash":970579417,"current-db-size-bytes":52461568,"current-db-size":"52 MB","current-db-size-in-use-bytes":28590080,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-11T07:59:12.845908Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":970579417,"revision":2894,"compact-revision":-1} {"level":"info","ts":"2026-10-11T08:02:17.380734Z","caller":"traceutil/trace.go:171","msg":"trace[1154362669] transaction","detail":"{read_only:false; response_revision:6753; number_of_response:1; }","duration":"113.855273ms","start":"2026-10-11T08:02:17.266864Z","end":"2026-10-11T08:02:17.380719Z","steps":["trace[1154362669] 'process raft request' (duration: 113.561249ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T08:02:31.281369Z","caller":"traceutil/trace.go:171","msg":"trace[745988974] transaction","detail":"{read_only:false; response_revision:6827; number_of_response:1; }","duration":"144.12457ms","start":"2026-10-11T08:02:31.137208Z","end":"2026-10-11T08:02:31.281333Z","steps":["trace[745988974] 'process raft request' (duration: 143.47625ms)"],"step_count":1} {"level":"warn","ts":"2026-10-11T08:02:31.281637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.719699ms","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":"info","ts":"2026-10-11T08:02:31.28136Z","caller":"traceutil/trace.go:171","msg":"trace[1750772871] linearizableReadLoop","detail":"{readStateIndex:7077; appliedIndex:7076; }","duration":"142.502006ms","start":"2026-10-11T08:02:31.1388Z","end":"2026-10-11T08:02:31.281302Z","steps":["trace[1750772871] 'read index received' (duration: 142.10218ms)","trace[1750772871] 'applied index is now lower than readState.Index' (duration: 398.056µs)"],"step_count":2} {"level":"info","ts":"2026-10-11T08:02:31.281733Z","caller":"traceutil/trace.go:171","msg":"trace[1574063714] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:6827; }","duration":"142.955473ms","start":"2026-10-11T08:02:31.138753Z","end":"2026-10-11T08:02:31.281709Z","steps":["trace[1574063714] 'agreement among raft nodes before linearized reading' (duration: 142.676789ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T08:02:31.302383Z","caller":"traceutil/trace.go:171","msg":"trace[119916493] transaction","detail":"{read_only:false; response_revision:6828; number_of_response:1; }","duration":"141.38714ms","start":"2026-10-11T08:02:31.160963Z","end":"2026-10-11T08:02:31.30235Z","steps":["trace[119916493] 'process raft request' (duration: 141.165997ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T08:02:31.302637Z","caller":"traceutil/trace.go:171","msg":"trace[1353167683] transaction","detail":"{read_only:false; response_revision:6829; number_of_response:1; }","duration":"140.087181ms","start":"2026-10-11T08:02:31.16252Z","end":"2026-10-11T08:02:31.302607Z","steps":["trace[1353167683] 'process raft request' (duration: 139.781416ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T08:02:49.483622Z","caller":"traceutil/trace.go:171","msg":"trace[817048237] transaction","detail":"{read_only:false; response_revision:6974; number_of_response:1; }","duration":"115.444245ms","start":"2026-10-11T08:02:49.368148Z","end":"2026-10-11T08:02:49.483592Z","steps":["trace[817048237] 'process raft request' (duration: 110.86813ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T08:02:49.528046Z","caller":"traceutil/trace.go:171","msg":"trace[563832157] transaction","detail":"{read_only:false; response_revision:6975; number_of_response:1; }","duration":"141.682766ms","start":"2026-10-11T08:02:49.386346Z","end":"2026-10-11T08:02:49.528029Z","steps":["trace[563832157] 'process raft request' (duration: 141.597884ms)"],"step_count":1} {"level":"info","ts":"2026-10-11T08:04:12.739751Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5475} {"level":"info","ts":"2026-10-11T08:04:12.852912Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5475,"took":"111.864744ms","hash":3238818570,"current-db-size-bytes":52461568,"current-db-size":"52 MB","current-db-size-in-use-bytes":18972672,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-11T08:04:12.852988Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3238818570,"revision":5475,"compact-revision":2894}