{"level":"warn","ts":"2026-09-22T14:39:36.148526Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-22T14:39:36.148677Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.143: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.143:2380","--initial-cluster=instance=https://162.253.55.143:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.143:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.143:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-22T14:39:36.1494Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-22T14:39:36.149436Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.143:2380"]} {"level":"info","ts":"2026-09-22T14:39:36.149479Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-22T14:39:36.150168Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.143:2379"]} {"level":"info","ts":"2026-09-22T14:39:36.150254Z","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.143:2380"],"listen-peer-urls":["https://162.253.55.143:2380"],"advertise-client-urls":["https://162.253.55.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.143:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-22T14:39:36.155085Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.600595ms"} {"level":"info","ts":"2026-09-22T14:39:36.164712Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7bf20b54406e85d1","cluster-id":"de54e01795e71fe2"} {"level":"info","ts":"2026-09-22T14:39:36.164802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 switched to configuration voters=()"} {"level":"info","ts":"2026-09-22T14:39:36.164881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became follower at term 0"} {"level":"info","ts":"2026-09-22T14:39:36.164909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7bf20b54406e85d1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-22T14:39:36.164978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became follower at term 1"} {"level":"info","ts":"2026-09-22T14:39:36.165067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 switched to configuration voters=(8931213467515258321)"} {"level":"warn","ts":"2026-09-22T14:39:36.176621Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-22T14:39:36.178865Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-22T14:39:36.180448Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-22T14:39:36.18368Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7bf20b54406e85d1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-22T14:39:36.183914Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7bf20b54406e85d1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-22T14:39:36.183963Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-22T14:39:36.184406Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-22T14:39:36.184421Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-22T14:39:36.18499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 switched to configuration voters=(8931213467515258321)"} {"level":"info","ts":"2026-09-22T14:39:36.185605Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de54e01795e71fe2","local-member-id":"7bf20b54406e85d1","added-peer-id":"7bf20b54406e85d1","added-peer-peer-urls":["https://162.253.55.143:2380"]} {"level":"info","ts":"2026-09-22T14:39:36.188233Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-22T14:39:36.188363Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.143:2380"} {"level":"info","ts":"2026-09-22T14:39:36.188395Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.143:2380"} {"level":"info","ts":"2026-09-22T14:39:36.189231Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7bf20b54406e85d1","initial-advertise-peer-urls":["https://162.253.55.143:2380"],"listen-peer-urls":["https://162.253.55.143:2380"],"advertise-client-urls":["https://162.253.55.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-22T14:39:36.18927Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-22T14:39:36.965572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 is starting a new election at term 1"} {"level":"info","ts":"2026-09-22T14:39:36.965667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-22T14:39:36.965692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 received MsgPreVoteResp from 7bf20b54406e85d1 at term 1"} {"level":"info","ts":"2026-09-22T14:39:36.965731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became candidate at term 2"} {"level":"info","ts":"2026-09-22T14:39:36.965742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 received MsgVoteResp from 7bf20b54406e85d1 at term 2"} {"level":"info","ts":"2026-09-22T14:39:36.965759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became leader at term 2"} {"level":"info","ts":"2026-09-22T14:39:36.965773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7bf20b54406e85d1 elected leader 7bf20b54406e85d1 at term 2"} {"level":"info","ts":"2026-09-22T14:39:36.967205Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T14:39:36.96822Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7bf20b54406e85d1","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.143:2379]}","request-path":"/0/members/7bf20b54406e85d1/attributes","cluster-id":"de54e01795e71fe2","publish-timeout":"7s"} {"level":"info","ts":"2026-09-22T14:39:36.968276Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T14:39:36.968926Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T14:39:36.969045Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"de54e01795e71fe2","local-member-id":"7bf20b54406e85d1","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T14:39:36.969211Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T14:39:36.969273Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T14:39:36.969752Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-22T14:39:36.969811Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-22T14:39:36.972435Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.143:2379"} {"level":"info","ts":"2026-09-22T14:39:36.972938Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-09-22T14:39:40.644064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.572189ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-22T14:39:40.644505Z","caller":"traceutil/trace.go:171","msg":"trace[356531510] transaction","detail":"{read_only:false; response_revision:141; number_of_response:1; }","duration":"492.825136ms","start":"2026-09-22T14:39:40.151636Z","end":"2026-09-22T14:39:40.644461Z","steps":["trace[356531510] 'process raft request' (duration: 194.167001ms)","trace[356531510] 'compare' (duration: 297.442595ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T14:39:40.644774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:39:40.151616Z","time spent":"493.050604ms","remote":"127.0.0.1:53236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":730,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T14:39:41.036754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.398916ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-22T14:39:41.0369Z","caller":"traceutil/trace.go:171","msg":"trace[1677104472] transaction","detail":"{read_only:false; response_revision:142; number_of_response:1; }","duration":"387.081531ms","start":"2026-09-22T14:39:40.649791Z","end":"2026-09-22T14:39:41.036873Z","steps":["trace[1677104472] 'process raft request' (duration: 162.478148ms)","trace[1677104472] 'compare' (duration: 224.238431ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T14:39:41.036965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:39:40.649766Z","time spent":"387.176304ms","remote":"127.0.0.1:53236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":659,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-22T14:40:17.555087Z","caller":"traceutil/trace.go:171","msg":"trace[1540243857] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"156.763464ms","start":"2026-09-22T14:40:17.398291Z","end":"2026-09-22T14:40:17.555055Z","steps":["trace[1540243857] 'process raft request' (duration: 156.51945ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:40:17.563476Z","caller":"traceutil/trace.go:171","msg":"trace[521693422] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"139.909139ms","start":"2026-09-22T14:40:17.423524Z","end":"2026-09-22T14:40:17.563433Z","steps":["trace[521693422] 'process raft request' (duration: 139.25048ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:40:17.563559Z","caller":"traceutil/trace.go:171","msg":"trace[535555871] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"146.284619ms","start":"2026-09-22T14:40:17.417242Z","end":"2026-09-22T14:40:17.563527Z","steps":["trace[535555871] 'process raft request' (duration: 145.324375ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:40:17.563557Z","caller":"traceutil/trace.go:171","msg":"trace[1864033800] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"131.574055ms","start":"2026-09-22T14:40:17.431936Z","end":"2026-09-22T14:40:17.56351Z","steps":["trace[1864033800] 'process raft request' (duration: 130.888375ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:40:17.563792Z","caller":"traceutil/trace.go:171","msg":"trace[749426600] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"120.118945ms","start":"2026-09-22T14:40:17.443643Z","end":"2026-09-22T14:40:17.563762Z","steps":["trace[749426600] 'process raft request' (duration: 119.390546ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:40:17.563925Z","caller":"traceutil/trace.go:171","msg":"trace[1722930361] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"118.774556ms","start":"2026-09-22T14:40:17.44514Z","end":"2026-09-22T14:40:17.563915Z","steps":["trace[1722930361] 'process raft request' (duration: 117.968896ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:40:17.563991Z","caller":"traceutil/trace.go:171","msg":"trace[1516669175] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"118.664234ms","start":"2026-09-22T14:40:17.445318Z","end":"2026-09-22T14:40:17.563982Z","steps":["trace[1516669175] 'process raft request' (duration: 117.851524ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:40:17.564014Z","caller":"traceutil/trace.go:171","msg":"trace[1192174962] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"131.379602ms","start":"2026-09-22T14:40:17.432625Z","end":"2026-09-22T14:40:17.564005Z","steps":["trace[1192174962] 'process raft request' (duration: 130.278817ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:40:17.564046Z","caller":"traceutil/trace.go:171","msg":"trace[182717022] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"140.599919ms","start":"2026-09-22T14:40:17.423425Z","end":"2026-09-22T14:40:17.564025Z","steps":["trace[182717022] 'process raft request' (duration: 139.288401ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:40:17.564132Z","caller":"traceutil/trace.go:171","msg":"trace[1744752013] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"123.614383ms","start":"2026-09-22T14:40:17.440504Z","end":"2026-09-22T14:40:17.564118Z","steps":["trace[1744752013] 'process raft request' (duration: 122.464738ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:40:17.984342Z","caller":"traceutil/trace.go:171","msg":"trace[608635177] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"124.195761ms","start":"2026-09-22T14:40:17.860119Z","end":"2026-09-22T14:40:17.984315Z","steps":["trace[608635177] 'process raft request' (duration: 123.30479ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:40:17.991652Z","caller":"traceutil/trace.go:171","msg":"trace[931438363] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"116.13993ms","start":"2026-09-22T14:40:17.875418Z","end":"2026-09-22T14:40:17.991558Z","steps":["trace[931438363] 'process raft request' (duration: 115.204907ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:40:17.995883Z","caller":"traceutil/trace.go:171","msg":"trace[800465791] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"106.099211ms","start":"2026-09-22T14:40:17.889721Z","end":"2026-09-22T14:40:17.99582Z","steps":["trace[800465791] 'process raft request' (duration: 101.757041ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:40:23.588928Z","caller":"traceutil/trace.go:171","msg":"trace[1859679429] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"162.209526ms","start":"2026-09-22T14:40:23.426656Z","end":"2026-09-22T14:40:23.588865Z","steps":["trace[1859679429] 'process raft request' (duration: 161.931512ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:40:23.931791Z","caller":"traceutil/trace.go:171","msg":"trace[658080476] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"188.424289ms","start":"2026-09-22T14:40:23.743325Z","end":"2026-09-22T14:40:23.93175Z","steps":["trace[658080476] 'process raft request' (duration: 187.578686ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:40:24.632436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.652787ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-22T14:40:24.632852Z","caller":"traceutil/trace.go:171","msg":"trace[693043046] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"342.607584ms","start":"2026-09-22T14:40:24.290223Z","end":"2026-09-22T14:40:24.632831Z","steps":["trace[693043046] 'process raft request' (duration: 342.492822ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:40:24.633115Z","caller":"traceutil/trace.go:171","msg":"trace[99098876] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:626; }","duration":"530.372199ms","start":"2026-09-22T14:40:24.102715Z","end":"2026-09-22T14:40:24.633087Z","steps":["trace[99098876] 'read index received' (duration: 240.185024ms)","trace[99098876] 'applied index is now lower than readState.Index' (duration: 290.185385ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T14:40:24.633182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:40:24.290189Z","time spent":"342.708926ms","remote":"127.0.0.1:53114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T14:40:24.633552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.740775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-22T14:40:24.632769Z","caller":"traceutil/trace.go:171","msg":"trace[1267770076] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"627.504606ms","start":"2026-09-22T14:40:24.005198Z","end":"2026-09-22T14:40:24.632702Z","steps":["trace[1267770076] 'process raft request' (duration: 337.495914ms)","trace[1267770076] 'compare' (duration: 289.067698ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T14:40:24.633698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.025276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-22T14:40:24.633822Z","caller":"traceutil/trace.go:171","msg":"trace[893245868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:604; }","duration":"525.202549ms","start":"2026-09-22T14:40:24.108582Z","end":"2026-09-22T14:40:24.633784Z","steps":["trace[893245868] 'agreement among raft nodes before linearized reading' (duration: 524.970855ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:40:24.633877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:40:24.10855Z","time spent":"525.31708ms","remote":"127.0.0.1:53114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-22T14:40:24.63374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:40:24.005169Z","time spent":"628.486962ms","remote":"127.0.0.1:53392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-22T14:40:24.633607Z","caller":"traceutil/trace.go:171","msg":"trace[500245421] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:604; }","duration":"530.923408ms","start":"2026-09-22T14:40:24.102666Z","end":"2026-09-22T14:40:24.63359Z","steps":["trace[500245421] 'agreement among raft nodes before linearized reading' (duration: 530.570133ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:40:24.63424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:40:24.102653Z","time spent":"531.523188ms","remote":"127.0.0.1:53114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-22T14:41:21.123167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.593771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-09-22T14:41:21.123217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.840837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-22T14:41:21.12326Z","caller":"traceutil/trace.go:171","msg":"trace[653399737] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1211; }","duration":"121.744144ms","start":"2026-09-22T14:41:21.001496Z","end":"2026-09-22T14:41:21.123241Z","steps":["trace[653399737] 'range keys from in-memory index tree' (duration: 121.363034ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:41:21.123296Z","caller":"traceutil/trace.go:171","msg":"trace[1607060094] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1211; }","duration":"121.975819ms","start":"2026-09-22T14:41:21.001301Z","end":"2026-09-22T14:41:21.123277Z","steps":["trace[1607060094] 'range keys from in-memory index tree' (duration: 121.664422ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:41:21.123288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.801935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-22T14:41:21.123405Z","caller":"traceutil/trace.go:171","msg":"trace[171134830] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1211; }","duration":"121.953729ms","start":"2026-09-22T14:41:21.001406Z","end":"2026-09-22T14:41:21.12336Z","steps":["trace[171134830] 'range keys from in-memory index tree' (duration: 121.638491ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:42:12.293954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.816966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6a70ff14-4b2e-4edf-bf05-6401cc5e2fcb\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-22T14:42:12.294055Z","caller":"traceutil/trace.go:171","msg":"trace[124339565] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6a70ff14-4b2e-4edf-bf05-6401cc5e2fcb; range_end:; response_count:1; response_revision:1906; }","duration":"124.006222ms","start":"2026-09-22T14:42:12.170026Z","end":"2026-09-22T14:42:12.294032Z","steps":["trace[124339565] 'range keys from in-memory index tree' (duration: 123.507748ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:42:13.164735Z","caller":"traceutil/trace.go:171","msg":"trace[668158081] transaction","detail":"{read_only:false; response_revision:1909; number_of_response:1; }","duration":"392.979099ms","start":"2026-09-22T14:42:12.771718Z","end":"2026-09-22T14:42:13.164697Z","steps":["trace[668158081] 'process raft request' (duration: 392.802194ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:42:13.164902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:42:12.771696Z","time spent":"393.112442ms","remote":"127.0.0.1:53114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T14:42:13.170121Z","caller":"traceutil/trace.go:171","msg":"trace[1925743471] linearizableReadLoop","detail":"{readStateIndex:1987; appliedIndex:1986; }","duration":"277.686521ms","start":"2026-09-22T14:42:12.892396Z","end":"2026-09-22T14:42:13.170082Z","steps":["trace[1925743471] 'read index received' (duration: 272.282779ms)","trace[1925743471] 'applied index is now lower than readState.Index' (duration: 5.402042ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T14:42:13.170292Z","caller":"traceutil/trace.go:171","msg":"trace[201032012] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"358.479562ms","start":"2026-09-22T14:42:12.811799Z","end":"2026-09-22T14:42:13.170279Z","steps":["trace[201032012] 'process raft request' (duration: 358.079541ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:42:13.170592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.158514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-22T14:42:13.170655Z","caller":"traceutil/trace.go:171","msg":"trace[2046206682] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1910; }","duration":"278.293109ms","start":"2026-09-22T14:42:12.892346Z","end":"2026-09-22T14:42:13.170639Z","steps":["trace[2046206682] 'agreement among raft nodes before linearized reading' (duration: 278.153075ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:42:13.170644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.14161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6a70ff14-4b2e-4edf-bf05-6401cc5e2fcb\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-22T14:42:13.170757Z","caller":"traceutil/trace.go:171","msg":"trace[12118148] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6a70ff14-4b2e-4edf-bf05-6401cc5e2fcb; range_end:; response_count:1; response_revision:1910; }","duration":"130.362836ms","start":"2026-09-22T14:42:13.040367Z","end":"2026-09-22T14:42:13.17073Z","steps":["trace[12118148] 'agreement among raft nodes before linearized reading' (duration: 130.047367ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:42:13.171057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:42:12.811774Z","time spent":"358.561275ms","remote":"127.0.0.1:53114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T14:42:25.619087Z","caller":"traceutil/trace.go:171","msg":"trace[707868683] linearizableReadLoop","detail":"{readStateIndex:2095; appliedIndex:2093; }","duration":"127.01009ms","start":"2026-09-22T14:42:25.492037Z","end":"2026-09-22T14:42:25.619047Z","steps":["trace[707868683] 'read index received' (duration: 8.179954ms)","trace[707868683] 'applied index is now lower than readState.Index' (duration: 118.827796ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T14:42:25.619141Z","caller":"traceutil/trace.go:171","msg":"trace[1382966105] transaction","detail":"{read_only:false; response_revision:2015; number_of_response:1; }","duration":"133.905327ms","start":"2026-09-22T14:42:25.485203Z","end":"2026-09-22T14:42:25.619108Z","steps":["trace[1382966105] 'process raft request' (duration: 123.155281ms)","trace[1382966105] 'compare' (duration: 10.432467ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T14:42:25.619512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.445454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11978"} {"level":"warn","ts":"2026-09-22T14:42:25.619637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.870646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-22T14:42:25.619696Z","caller":"traceutil/trace.go:171","msg":"trace[1230471595] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2015; }","duration":"127.021131ms","start":"2026-09-22T14:42:25.492659Z","end":"2026-09-22T14:42:25.619681Z","steps":["trace[1230471595] 'agreement among raft nodes before linearized reading' (duration: 126.710552ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:42:25.619618Z","caller":"traceutil/trace.go:171","msg":"trace[1933453516] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2015; }","duration":"127.597997ms","start":"2026-09-22T14:42:25.491996Z","end":"2026-09-22T14:42:25.619594Z","steps":["trace[1933453516] 'agreement among raft nodes before linearized reading' (duration: 127.284768ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:42:28.971957Z","caller":"traceutil/trace.go:171","msg":"trace[394553380] transaction","detail":"{read_only:false; response_revision:2044; number_of_response:1; }","duration":"181.368049ms","start":"2026-09-22T14:42:28.79056Z","end":"2026-09-22T14:42:28.971928Z","steps":["trace[394553380] 'process raft request' (duration: 181.169014ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:42:51.911833Z","caller":"traceutil/trace.go:171","msg":"trace[1640523343] linearizableReadLoop","detail":"{readStateIndex:2259; appliedIndex:2258; }","duration":"100.633044ms","start":"2026-09-22T14:42:51.811173Z","end":"2026-09-22T14:42:51.911806Z","steps":["trace[1640523343] 'read index received' (duration: 100.324885ms)","trace[1640523343] 'applied index is now lower than readState.Index' (duration: 306.469µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T14:42:51.911922Z","caller":"traceutil/trace.go:171","msg":"trace[245881450] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"107.761922ms","start":"2026-09-22T14:42:51.804113Z","end":"2026-09-22T14:42:51.911875Z","steps":["trace[245881450] 'process raft request' (duration: 107.480934ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:42:51.912388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.193642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-22T14:42:51.912455Z","caller":"traceutil/trace.go:171","msg":"trace[1016041843] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2172; }","duration":"101.329675ms","start":"2026-09-22T14:42:51.811107Z","end":"2026-09-22T14:42:51.912437Z","steps":["trace[1016041843] 'agreement among raft nodes before linearized reading' (duration: 101.105958ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:42:52.070678Z","caller":"traceutil/trace.go:171","msg":"trace[390065411] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"154.304147ms","start":"2026-09-22T14:42:51.916328Z","end":"2026-09-22T14:42:52.070632Z","steps":["trace[390065411] 'process raft request' (duration: 154.018648ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:42:52.070988Z","caller":"traceutil/trace.go:171","msg":"trace[1091867142] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"154.365548ms","start":"2026-09-22T14:42:51.916594Z","end":"2026-09-22T14:42:52.07096Z","steps":["trace[1091867142] 'process raft request' (duration: 153.982577ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:42:52.299584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.833791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T14:42:52.299666Z","caller":"traceutil/trace.go:171","msg":"trace[76136027] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:2175; }","duration":"102.966825ms","start":"2026-09-22T14:42:52.196681Z","end":"2026-09-22T14:42:52.299648Z","steps":["trace[76136027] 'count revisions from in-memory index tree' (duration: 102.706277ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:42:53.144387Z","caller":"traceutil/trace.go:171","msg":"trace[1397171791] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"149.247764ms","start":"2026-09-22T14:42:52.995112Z","end":"2026-09-22T14:42:53.14436Z","steps":["trace[1397171791] 'process raft request' (duration: 148.77796ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:42:53.465115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.11143ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T14:42:53.465261Z","caller":"traceutil/trace.go:171","msg":"trace[1304585480] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"316.70399ms","start":"2026-09-22T14:42:53.148529Z","end":"2026-09-22T14:42:53.465233Z","steps":["trace[1304585480] 'process raft request' (duration: 166.671394ms)","trace[1304585480] 'compare' (duration: 148.860673ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T14:42:53.465365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:42:53.148499Z","time spent":"316.822974ms","remote":"127.0.0.1:53114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T14:42:53.518156Z","caller":"traceutil/trace.go:171","msg":"trace[1994153693] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"141.346922ms","start":"2026-09-22T14:42:53.376778Z","end":"2026-09-22T14:42:53.518125Z","steps":["trace[1994153693] 'process raft request' (duration: 141.179377ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:42:53.528541Z","caller":"traceutil/trace.go:171","msg":"trace[177742920] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"119.909954ms","start":"2026-09-22T14:42:53.408578Z","end":"2026-09-22T14:42:53.528488Z","steps":["trace[177742920] 'process raft request' (duration: 119.79732ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:42:53.750851Z","caller":"traceutil/trace.go:171","msg":"trace[524650315] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"134.676437ms","start":"2026-09-22T14:42:53.613799Z","end":"2026-09-22T14:42:53.748475Z","steps":["trace[524650315] 'process raft request' (duration: 125.569951ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:44:01.062507Z","caller":"traceutil/trace.go:171","msg":"trace[1464447098] transaction","detail":"{read_only:false; response_revision:2645; number_of_response:1; }","duration":"135.791559ms","start":"2026-09-22T14:44:00.926681Z","end":"2026-09-22T14:44:01.062473Z","steps":["trace[1464447098] 'process raft request' (duration: 135.610023ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:44:19.741716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.956963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-22T14:44:19.74168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.611295ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T14:44:19.741803Z","caller":"traceutil/trace.go:171","msg":"trace[1453848381] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2749; }","duration":"134.106996ms","start":"2026-09-22T14:44:19.607677Z","end":"2026-09-22T14:44:19.741784Z","steps":["trace[1453848381] 'range keys from in-memory index tree' (duration: 133.832742ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:44:19.741821Z","caller":"traceutil/trace.go:171","msg":"trace[1898421243] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2749; }","duration":"100.771658ms","start":"2026-09-22T14:44:19.641024Z","end":"2026-09-22T14:44:19.741796Z","steps":["trace[1898421243] 'range keys from in-memory index tree' (duration: 100.592245ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:44:35.371625Z","caller":"traceutil/trace.go:171","msg":"trace[1647533591] transaction","detail":"{read_only:false; response_revision:2832; number_of_response:1; }","duration":"163.261957ms","start":"2026-09-22T14:44:35.208326Z","end":"2026-09-22T14:44:35.371588Z","steps":["trace[1647533591] 'process raft request' (duration: 163.022862ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:44:35.920002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.914906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T14:44:35.920102Z","caller":"traceutil/trace.go:171","msg":"trace[1465378375] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:2833; }","duration":"117.1006ms","start":"2026-09-22T14:44:35.80298Z","end":"2026-09-22T14:44:35.920081Z","steps":["trace[1465378375] 'count revisions from in-memory index tree' (duration: 116.813815ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:49:18.117229Z","caller":"traceutil/trace.go:171","msg":"trace[1375962872] transaction","detail":"{read_only:false; response_revision:5005; number_of_response:1; }","duration":"126.254428ms","start":"2026-09-22T14:49:17.990946Z","end":"2026-09-22T14:49:18.1172Z","steps":["trace[1375962872] 'process raft request' (duration: 122.323366ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:49:24.38418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.08002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-22T14:49:24.384283Z","caller":"traceutil/trace.go:171","msg":"trace[660351891] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5107; }","duration":"211.221634ms","start":"2026-09-22T14:49:24.173037Z","end":"2026-09-22T14:49:24.384259Z","steps":["trace[660351891] 'range keys from in-memory index tree' (duration: 210.919747ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:49:24.384451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.740587ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T14:49:24.384783Z","caller":"traceutil/trace.go:171","msg":"trace[69098104] transaction","detail":"{read_only:false; response_revision:5109; number_of_response:1; }","duration":"211.604876ms","start":"2026-09-22T14:49:24.173119Z","end":"2026-09-22T14:49:24.384724Z","steps":["trace[69098104] 'process raft request' (duration: 211.475162ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:49:24.385018Z","caller":"traceutil/trace.go:171","msg":"trace[1943277283] transaction","detail":"{read_only:false; response_revision:5110; number_of_response:1; }","duration":"211.826432ms","start":"2026-09-22T14:49:24.173174Z","end":"2026-09-22T14:49:24.385001Z","steps":["trace[1943277283] 'process raft request' (duration: 211.506432ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:49:24.385001Z","caller":"traceutil/trace.go:171","msg":"trace[1651434569] transaction","detail":"{read_only:false; response_revision:5108; number_of_response:1; }","duration":"211.876343ms","start":"2026-09-22T14:49:24.173067Z","end":"2026-09-22T14:49:24.384943Z","steps":["trace[1651434569] 'process raft request' (duration: 16.514118ms)","trace[1651434569] 'compare' (duration: 194.377067ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T14:49:24.615859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.437152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-08ec39a0-fa1c-4e01-b9df-2c5be745ff5e\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-09-22T14:49:24.615988Z","caller":"traceutil/trace.go:171","msg":"trace[1675431123] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-08ec39a0-fa1c-4e01-b9df-2c5be745ff5e; range_end:; response_count:1; response_revision:5111; }","duration":"112.647657ms","start":"2026-09-22T14:49:24.503313Z","end":"2026-09-22T14:49:24.61596Z","steps":["trace[1675431123] 'range keys from in-memory index tree' (duration: 111.276398ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:49:26.70902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.765592ms","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-09-22T14:49:26.709114Z","caller":"traceutil/trace.go:171","msg":"trace[1719236231] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5140; }","duration":"124.914727ms","start":"2026-09-22T14:49:26.584177Z","end":"2026-09-22T14:49:26.709091Z","steps":["trace[1719236231] 'range keys from in-memory index tree' (duration: 124.644069ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:49:26.709301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.347644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T14:49:26.709397Z","caller":"traceutil/trace.go:171","msg":"trace[236020886] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5140; }","duration":"104.490378ms","start":"2026-09-22T14:49:26.604883Z","end":"2026-09-22T14:49:26.709374Z","steps":["trace[236020886] 'range keys from in-memory index tree' (duration: 104.287372ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:49:37.010922Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2843} {"level":"info","ts":"2026-09-22T14:49:37.099119Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2843,"took":"86.198496ms","hash":1447748794,"current-db-size-bytes":52609024,"current-db-size":"53 MB","current-db-size-in-use-bytes":27422720,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-22T14:49:37.099256Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1447748794,"revision":2843,"compact-revision":-1} {"level":"warn","ts":"2026-09-22T14:49:37.768002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.32398ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T14:49:37.768412Z","caller":"traceutil/trace.go:171","msg":"trace[1051017633] transaction","detail":"{read_only:false; response_revision:5271; number_of_response:1; }","duration":"410.093898ms","start":"2026-09-22T14:49:37.358293Z","end":"2026-09-22T14:49:37.768387Z","steps":["trace[1051017633] 'process raft request' (duration: 173.261773ms)","trace[1051017633] 'compare' (duration: 235.817846ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T14:49:37.768561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:49:37.358259Z","time spent":"410.259673ms","remote":"127.0.0.1:53114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T14:49:37.768776Z","caller":"traceutil/trace.go:171","msg":"trace[2000823933] linearizableReadLoop","detail":"{readStateIndex:5476; appliedIndex:5474; }","duration":"267.760246ms","start":"2026-09-22T14:49:37.500931Z","end":"2026-09-22T14:49:37.768691Z","steps":["trace[2000823933] 'read index received' (duration: 30.737946ms)","trace[2000823933] 'applied index is now lower than readState.Index' (duration: 237.01816ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T14:49:37.768811Z","caller":"traceutil/trace.go:171","msg":"trace[1793929164] transaction","detail":"{read_only:false; response_revision:5272; number_of_response:1; }","duration":"405.201388ms","start":"2026-09-22T14:49:37.363565Z","end":"2026-09-22T14:49:37.768767Z","steps":["trace[1793929164] 'process raft request' (duration: 404.732286ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:49:37.769064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:49:37.363539Z","time spent":"405.370383ms","remote":"127.0.0.1:53114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T14:49:37.769069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.095634ms","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-09-22T14:49:37.769132Z","caller":"traceutil/trace.go:171","msg":"trace[437592143] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:5272; }","duration":"268.257289ms","start":"2026-09-22T14:49:37.500853Z","end":"2026-09-22T14:49:37.76911Z","steps":["trace[437592143] 'agreement among raft nodes before linearized reading' (duration: 268.077984ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:49:37.92813Z","caller":"traceutil/trace.go:171","msg":"trace[549812206] linearizableReadLoop","detail":"{readStateIndex:5477; appliedIndex:5476; }","duration":"159.209895ms","start":"2026-09-22T14:49:37.768884Z","end":"2026-09-22T14:49:37.928093Z","steps":["trace[549812206] 'read index received' (duration: 140.138961ms)","trace[549812206] 'applied index is now lower than readState.Index' (duration: 19.069104ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T14:49:37.928303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.697686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"warn","ts":"2026-09-22T14:49:37.928318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.825896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T14:49:37.928405Z","caller":"traceutil/trace.go:171","msg":"trace[506967543] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5273; }","duration":"160.85252ms","start":"2026-09-22T14:49:37.767524Z","end":"2026-09-22T14:49:37.928377Z","steps":["trace[506967543] 'agreement among raft nodes before linearized reading' (duration: 160.584873ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:49:37.928411Z","caller":"traceutil/trace.go:171","msg":"trace[2044138731] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5273; }","duration":"321.952707ms","start":"2026-09-22T14:49:37.606435Z","end":"2026-09-22T14:49:37.928388Z","steps":["trace[2044138731] 'agreement among raft nodes before linearized reading' (duration: 321.800274ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:49:37.928456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:49:37.606424Z","time spent":"322.02106ms","remote":"127.0.0.1:52844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-22T14:49:37.928895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.811045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-22T14:49:37.928936Z","caller":"traceutil/trace.go:171","msg":"trace[551809755] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5273; }","duration":"130.902457ms","start":"2026-09-22T14:49:37.798023Z","end":"2026-09-22T14:49:37.928926Z","steps":["trace[551809755] 'agreement among raft nodes before linearized reading' (duration: 130.766623ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:49:37.928142Z","caller":"traceutil/trace.go:171","msg":"trace[501586287] transaction","detail":"{read_only:false; response_revision:5273; number_of_response:1; }","duration":"372.96217ms","start":"2026-09-22T14:49:37.555145Z","end":"2026-09-22T14:49:37.928107Z","steps":["trace[501586287] 'process raft request' (duration: 353.808584ms)","trace[501586287] 'compare' (duration: 18.862068ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T14:49:37.929452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.373268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T14:49:37.929514Z","caller":"traceutil/trace.go:171","msg":"trace[1471363829] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:5273; }","duration":"160.529771ms","start":"2026-09-22T14:49:37.768967Z","end":"2026-09-22T14:49:37.929497Z","steps":["trace[1471363829] 'agreement among raft nodes before linearized reading' (duration: 159.335998ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:49:37.929456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:49:37.555114Z","time spent":"374.201215ms","remote":"127.0.0.1:53114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T14:53:46.229701Z","caller":"traceutil/trace.go:171","msg":"trace[163608201] transaction","detail":"{read_only:false; response_revision:7086; number_of_response:1; }","duration":"100.274053ms","start":"2026-09-22T14:53:46.129381Z","end":"2026-09-22T14:53:46.229655Z","steps":["trace[163608201] 'process raft request' (duration: 100.06983ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:54:37.019201Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5267} {"level":"info","ts":"2026-09-22T14:54:37.1365Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5267,"took":"115.343166ms","hash":3911782811,"current-db-size-bytes":52609024,"current-db-size":"53 MB","current-db-size-in-use-bytes":19099648,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-22T14:54:37.136575Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3911782811,"revision":5267,"compact-revision":2843} {"level":"info","ts":"2026-09-22T14:59:37.026439Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7372} {"level":"info","ts":"2026-09-22T14:59:37.094734Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7372,"took":"65.826733ms","hash":1272009276,"current-db-size-bytes":52609024,"current-db-size":"53 MB","current-db-size-in-use-bytes":15663104,"current-db-size-in-use":"16 MB"} {"level":"info","ts":"2026-09-22T14:59:37.094806Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1272009276,"revision":7372,"compact-revision":5267}