{"level":"warn","ts":"2026-09-01T18:26:45.983725Z","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-01T18:26:45.983809Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.27: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.27:2380","--initial-cluster=instance=https://162.253.55.27:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.27:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.27: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-01T18:26:45.98387Z","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-01T18:26:45.98388Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.27:2380"]} {"level":"info","ts":"2026-09-01T18:26:45.983899Z","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-01T18:26:45.984545Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.27:2379"]} {"level":"info","ts":"2026-09-01T18:26:45.984617Z","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.27:2380"],"listen-peer-urls":["https://162.253.55.27:2380"],"advertise-client-urls":["https://162.253.55.27:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.27:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.27: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-01T18:26:45.997018Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"12.196886ms"} {"level":"info","ts":"2026-09-01T18:26:46.004829Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d9b565cb482924cf","cluster-id":"5bc3f8d4cf836b6c"} {"level":"info","ts":"2026-09-01T18:26:46.0049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf switched to configuration voters=()"} {"level":"info","ts":"2026-09-01T18:26:46.004916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf became follower at term 0"} {"level":"info","ts":"2026-09-01T18:26:46.004928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d9b565cb482924cf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-01T18:26:46.004936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf became follower at term 1"} {"level":"info","ts":"2026-09-01T18:26:46.004967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf switched to configuration voters=(15687556800778413263)"} {"level":"warn","ts":"2026-09-01T18:26:46.017992Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-01T18:26:46.019803Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-01T18:26:46.022965Z","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-01T18:26:46.025176Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d9b565cb482924cf","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-01T18:26:46.026388Z","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-01T18:26:46.026453Z","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-01T18:26:46.026349Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d9b565cb482924cf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-01T18:26:46.026462Z","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-01T18:26:46.037923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf switched to configuration voters=(15687556800778413263)"} {"level":"info","ts":"2026-09-01T18:26:46.038257Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5bc3f8d4cf836b6c","local-member-id":"d9b565cb482924cf","added-peer-id":"d9b565cb482924cf","added-peer-peer-urls":["https://162.253.55.27:2380"]} {"level":"info","ts":"2026-09-01T18:26:46.038978Z","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-01T18:26:46.039108Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.27:2380"} {"level":"info","ts":"2026-09-01T18:26:46.039127Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.27:2380"} {"level":"info","ts":"2026-09-01T18:26:46.03931Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d9b565cb482924cf","initial-advertise-peer-urls":["https://162.253.55.27:2380"],"listen-peer-urls":["https://162.253.55.27:2380"],"advertise-client-urls":["https://162.253.55.27:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.27:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-01T18:26:46.039359Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-01T18:26:46.405468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf is starting a new election at term 1"} {"level":"info","ts":"2026-09-01T18:26:46.405524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf became pre-candidate at term 1"} {"level":"info","ts":"2026-09-01T18:26:46.405548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf received MsgPreVoteResp from d9b565cb482924cf at term 1"} {"level":"info","ts":"2026-09-01T18:26:46.40556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf became candidate at term 2"} {"level":"info","ts":"2026-09-01T18:26:46.405565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf received MsgVoteResp from d9b565cb482924cf at term 2"} {"level":"info","ts":"2026-09-01T18:26:46.405573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d9b565cb482924cf became leader at term 2"} {"level":"info","ts":"2026-09-01T18:26:46.405582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d9b565cb482924cf elected leader d9b565cb482924cf at term 2"} {"level":"info","ts":"2026-09-01T18:26:46.40642Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T18:26:46.409886Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5bc3f8d4cf836b6c","local-member-id":"d9b565cb482924cf","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T18:26:46.409977Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T18:26:46.410006Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T18:26:46.410022Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T18:26:46.410002Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d9b565cb482924cf","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.27:2379]}","request-path":"/0/members/d9b565cb482924cf/attributes","cluster-id":"5bc3f8d4cf836b6c","publish-timeout":"7s"} {"level":"info","ts":"2026-09-01T18:26:46.410287Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T18:26:46.410556Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-01T18:26:46.410619Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-01T18:26:46.412754Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-01T18:26:46.412822Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.27:2379"} {"level":"info","ts":"2026-09-01T18:26:50.799289Z","caller":"traceutil/trace.go:171","msg":"trace[2074068326] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"150.548279ms","start":"2026-09-01T18:26:50.648693Z","end":"2026-09-01T18:26:50.799241Z","steps":["trace[2074068326] 'process raft request' (duration: 150.322249ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:26:55.788393Z","caller":"traceutil/trace.go:171","msg":"trace[1398167294] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"116.199246ms","start":"2026-09-01T18:26:55.672167Z","end":"2026-09-01T18:26:55.788366Z","steps":["trace[1398167294] 'process raft request' (duration: 65.275757ms)","trace[1398167294] 'compare' (duration: 50.811394ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:26:56.49251Z","caller":"traceutil/trace.go:171","msg":"trace[743961684] linearizableReadLoop","detail":"{readStateIndex:398; appliedIndex:397; }","duration":"282.680345ms","start":"2026-09-01T18:26:56.209801Z","end":"2026-09-01T18:26:56.492481Z","steps":["trace[743961684] 'read index received' (duration: 282.431345ms)","trace[743961684] 'applied index is now lower than readState.Index' (duration: 247.94µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:26:56.492538Z","caller":"traceutil/trace.go:171","msg":"trace[1320025353] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"610.502408ms","start":"2026-09-01T18:26:55.882015Z","end":"2026-09-01T18:26:56.492517Z","steps":["trace[1320025353] 'process raft request' (duration: 610.287349ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:26:56.492784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.523545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-09-01T18:26:56.492865Z","caller":"traceutil/trace.go:171","msg":"trace[554638573] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:383; }","duration":"247.678572ms","start":"2026-09-01T18:26:56.24517Z","end":"2026-09-01T18:26:56.492848Z","steps":["trace[554638573] 'agreement among raft nodes before linearized reading' (duration: 247.466974ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:26:56.492848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.421129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-09-01T18:26:56.492895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.082081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-09-01T18:26:56.492955Z","caller":"traceutil/trace.go:171","msg":"trace[1135073370] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:383; }","duration":"283.178055ms","start":"2026-09-01T18:26:56.209752Z","end":"2026-09-01T18:26:56.49293Z","steps":["trace[1135073370] 'agreement among raft nodes before linearized reading' (duration: 282.831341ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:26:56.492955Z","caller":"traceutil/trace.go:171","msg":"trace[161502279] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:383; }","duration":"210.559304ms","start":"2026-09-01T18:26:56.282355Z","end":"2026-09-01T18:26:56.492914Z","steps":["trace[161502279] 'agreement among raft nodes before linearized reading' (duration: 210.350845ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:26:56.493274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:26:55.882Z","time spent":"610.668565ms","remote":"127.0.0.1:33664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4307,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T18:27:24.426542Z","caller":"traceutil/trace.go:171","msg":"trace[117025485] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"118.611983ms","start":"2026-09-01T18:27:24.307774Z","end":"2026-09-01T18:27:24.426386Z","steps":["trace[117025485] 'process raft request' (duration: 118.449628ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:27:24.624093Z","caller":"traceutil/trace.go:171","msg":"trace[2000230893] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"310.482581ms","start":"2026-09-01T18:27:24.31357Z","end":"2026-09-01T18:27:24.624052Z","steps":["trace[2000230893] 'process raft request' (duration: 272.368364ms)","trace[2000230893] 'compare' (duration: 37.624412ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T18:27:24.62428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:27:24.313542Z","time spent":"310.653477ms","remote":"127.0.0.1:33490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-01T18:27:24.624265Z","caller":"traceutil/trace.go:171","msg":"trace[1703802837] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"221.914571ms","start":"2026-09-01T18:27:24.402321Z","end":"2026-09-01T18:27:24.624235Z","steps":["trace[1703802837] 'process raft request' (duration: 221.863119ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:27:24.624558Z","caller":"traceutil/trace.go:171","msg":"trace[1597960990] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"278.472658ms","start":"2026-09-01T18:27:24.34607Z","end":"2026-09-01T18:27:24.624543Z","steps":["trace[1597960990] 'process raft request' (duration: 277.900681ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:27:24.624579Z","caller":"traceutil/trace.go:171","msg":"trace[1047366572] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"278.570792ms","start":"2026-09-01T18:27:24.345984Z","end":"2026-09-01T18:27:24.624555Z","steps":["trace[1047366572] 'process raft request' (duration: 277.949623ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:27:24.624691Z","caller":"traceutil/trace.go:171","msg":"trace[1174119562] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"276.128217ms","start":"2026-09-01T18:27:24.348546Z","end":"2026-09-01T18:27:24.624674Z","steps":["trace[1174119562] 'process raft request' (duration: 275.467207ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:27:24.624672Z","caller":"traceutil/trace.go:171","msg":"trace[1381087751] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"286.972357ms","start":"2026-09-01T18:27:24.337654Z","end":"2026-09-01T18:27:24.624626Z","steps":["trace[1381087751] 'process raft request' (duration: 286.191103ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:27:24.624802Z","caller":"traceutil/trace.go:171","msg":"trace[1062693875] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"265.196145ms","start":"2026-09-01T18:27:24.359546Z","end":"2026-09-01T18:27:24.624742Z","steps":["trace[1062693875] 'process raft request' (duration: 264.507174ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:27:24.624866Z","caller":"traceutil/trace.go:171","msg":"trace[1288226487] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"265.061042ms","start":"2026-09-01T18:27:24.35979Z","end":"2026-09-01T18:27:24.624852Z","steps":["trace[1288226487] 'process raft request' (duration: 264.311729ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:27:24.624845Z","caller":"traceutil/trace.go:171","msg":"trace[1166787313] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"294.547157ms","start":"2026-09-01T18:27:24.330251Z","end":"2026-09-01T18:27:24.624798Z","steps":["trace[1166787313] 'process raft request' (duration: 293.471784ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:27:24.624989Z","caller":"traceutil/trace.go:171","msg":"trace[1599497138] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"283.110519ms","start":"2026-09-01T18:27:24.341861Z","end":"2026-09-01T18:27:24.624971Z","steps":["trace[1599497138] 'process raft request' (duration: 282.031677ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:27:24.657559Z","caller":"traceutil/trace.go:171","msg":"trace[417073876] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"222.279651ms","start":"2026-09-01T18:27:24.43523Z","end":"2026-09-01T18:27:24.657509Z","steps":["trace[417073876] 'process raft request' (duration: 221.502928ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:27:24.657578Z","caller":"traceutil/trace.go:171","msg":"trace[1095118576] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"226.337065ms","start":"2026-09-01T18:27:24.431195Z","end":"2026-09-01T18:27:24.657532Z","steps":["trace[1095118576] 'process raft request' (duration: 225.378786ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:27:24.658007Z","caller":"traceutil/trace.go:171","msg":"trace[1754826985] transaction","detail":"{read_only:false; number_of_response:1; response_revision:539; }","duration":"222.610232ms","start":"2026-09-01T18:27:24.435378Z","end":"2026-09-01T18:27:24.657989Z","steps":["trace[1754826985] 'process raft request' (duration: 221.456127ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:27:25.003517Z","caller":"traceutil/trace.go:171","msg":"trace[1618547670] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"370.318088ms","start":"2026-09-01T18:27:24.633101Z","end":"2026-09-01T18:27:25.003419Z","steps":["trace[1618547670] 'process raft request' (duration: 359.49008ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:27:25.003813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:27:24.633074Z","time spent":"370.627448ms","remote":"127.0.0.1:33998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-01T18:27:25.003878Z","caller":"traceutil/trace.go:171","msg":"trace[1045106976] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"350.325131ms","start":"2026-09-01T18:27:24.653526Z","end":"2026-09-01T18:27:25.003851Z","steps":["trace[1045106976] 'process raft request' (duration: 350.192307ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:27:25.003884Z","caller":"traceutil/trace.go:171","msg":"trace[913758257] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"353.630201ms","start":"2026-09-01T18:27:24.650208Z","end":"2026-09-01T18:27:25.003838Z","steps":["trace[913758257] 'process raft request' (duration: 353.429505ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:27:25.003999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:27:24.653506Z","time spent":"350.436404ms","remote":"127.0.0.1:33998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-01T18:27:25.004039Z","caller":"traceutil/trace.go:171","msg":"trace[1875484510] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"358.510869ms","start":"2026-09-01T18:27:24.645506Z","end":"2026-09-01T18:27:25.004017Z","steps":["trace[1875484510] 'process raft request' (duration: 357.813068ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:27:25.004133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:27:24.645393Z","time spent":"358.698094ms","remote":"127.0.0.1:33998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-01T18:27:25.004328Z","caller":"traceutil/trace.go:171","msg":"trace[407820287] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"345.37237ms","start":"2026-09-01T18:27:24.658929Z","end":"2026-09-01T18:27:25.004302Z","steps":["trace[407820287] 'process raft request' (duration: 344.836744ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:27:25.004337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:27:24.650178Z","time spent":"353.847807ms","remote":"127.0.0.1:33490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T18:27:25.004414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:27:24.658912Z","time spent":"345.455823ms","remote":"127.0.0.1:33490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T18:27:25.004695Z","caller":"traceutil/trace.go:171","msg":"trace[606318670] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"360.198701ms","start":"2026-09-01T18:27:24.644464Z","end":"2026-09-01T18:27:25.004662Z","steps":["trace[606318670] 'process raft request' (duration: 358.779858ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:27:25.004843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:27:24.644416Z","time spent":"360.381216ms","remote":"127.0.0.1:33998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-01T18:27:25.004982Z","caller":"traceutil/trace.go:171","msg":"trace[921786582] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:563; }","duration":"315.357208ms","start":"2026-09-01T18:27:24.689611Z","end":"2026-09-01T18:27:25.004968Z","steps":["trace[921786582] 'read index received' (duration: 303.007944ms)","trace[921786582] 'applied index is now lower than readState.Index' (duration: 12.348374ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:27:25.004876Z","caller":"traceutil/trace.go:171","msg":"trace[713627248] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"341.77291ms","start":"2026-09-01T18:27:24.663085Z","end":"2026-09-01T18:27:25.004858Z","steps":["trace[713627248] 'process raft request' (duration: 341.158142ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:27:25.005079Z","caller":"traceutil/trace.go:171","msg":"trace[1578727713] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"332.706775ms","start":"2026-09-01T18:27:24.672358Z","end":"2026-09-01T18:27:25.005064Z","steps":["trace[1578727713] 'process raft request' (duration: 332.465967ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:27:25.005164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:27:24.672345Z","time spent":"332.772967ms","remote":"127.0.0.1:33490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T18:27:25.00493Z","caller":"traceutil/trace.go:171","msg":"trace[1503891760] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"336.344425ms","start":"2026-09-01T18:27:24.668574Z","end":"2026-09-01T18:27:25.004919Z","steps":["trace[1503891760] 'process raft request' (duration: 336.17617ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:27:25.00521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:27:24.66306Z","time spent":"342.032059ms","remote":"127.0.0.1:33490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T18:27:25.005287Z","caller":"traceutil/trace.go:171","msg":"trace[1433143544] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"266.025879ms","start":"2026-09-01T18:27:24.739255Z","end":"2026-09-01T18:27:25.005281Z","steps":["trace[1433143544] 'process raft request' (duration: 265.677969ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:27:25.00527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:27:24.66854Z","time spent":"336.675335ms","remote":"127.0.0.1:33490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T18:27:25.005261Z","caller":"traceutil/trace.go:171","msg":"trace[1994528504] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"324.592458ms","start":"2026-09-01T18:27:24.680658Z","end":"2026-09-01T18:27:25.00525Z","steps":["trace[1994528504] 'process raft request' (duration: 324.213757ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:27:25.005497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:27:24.680632Z","time spent":"324.804385ms","remote":"127.0.0.1:33490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T18:27:25.005559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.957586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-01T18:27:25.005594Z","caller":"traceutil/trace.go:171","msg":"trace[1460127775] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:551; }","duration":"316.035818ms","start":"2026-09-01T18:27:24.689549Z","end":"2026-09-01T18:27:25.005584Z","steps":["trace[1460127775] 'agreement among raft nodes before linearized reading' (duration: 315.965046ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:27:25.005629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:27:24.689527Z","time spent":"316.095011ms","remote":"127.0.0.1:33742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-01T18:27:25.005669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.929575ms","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-01T18:27:25.005719Z","caller":"traceutil/trace.go:171","msg":"trace[1916212687] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:551; }","duration":"315.008317ms","start":"2026-09-01T18:27:24.69069Z","end":"2026-09-01T18:27:25.005699Z","steps":["trace[1916212687] 'agreement among raft nodes before linearized reading' (duration: 314.919154ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:27:25.005771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:27:24.690664Z","time spent":"315.09991ms","remote":"127.0.0.1:33742","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-01T18:27:25.005899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.702394ms","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-01T18:27:25.005938Z","caller":"traceutil/trace.go:171","msg":"trace[22572823] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:551; }","duration":"301.770866ms","start":"2026-09-01T18:27:24.704156Z","end":"2026-09-01T18:27:25.005927Z","steps":["trace[22572823] 'agreement among raft nodes before linearized reading' (duration: 301.702544ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:27:25.005965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:27:24.704135Z","time spent":"301.823657ms","remote":"127.0.0.1:33742","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":"info","ts":"2026-09-01T18:27:31.463992Z","caller":"traceutil/trace.go:171","msg":"trace[568607732] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"184.272409ms","start":"2026-09-01T18:27:31.279689Z","end":"2026-09-01T18:27:31.463962Z","steps":["trace[568607732] 'process raft request' (duration: 151.995326ms)","trace[568607732] 'compare' (duration: 32.130149ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T18:27:32.060905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.718872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rbzvv\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-01T18:27:32.06099Z","caller":"traceutil/trace.go:171","msg":"trace[157766093] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rbzvv; range_end:; response_count:1; response_revision:638; }","duration":"453.817164ms","start":"2026-09-01T18:27:31.607153Z","end":"2026-09-01T18:27:32.060971Z","steps":["trace[157766093] 'range keys from in-memory index tree' (duration: 453.591458ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:27:32.061048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:27:31.607088Z","time spent":"453.941968ms","remote":"127.0.0.1:33664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-rbzvv\" "} {"level":"info","ts":"2026-09-01T18:27:32.066049Z","caller":"traceutil/trace.go:171","msg":"trace[469489828] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"193.87569ms","start":"2026-09-01T18:27:31.872155Z","end":"2026-09-01T18:27:32.066031Z","steps":["trace[469489828] 'process raft request' (duration: 193.476179ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:28:39.136844Z","caller":"traceutil/trace.go:171","msg":"trace[1135580465] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"168.658784ms","start":"2026-09-01T18:28:38.968153Z","end":"2026-09-01T18:28:39.136812Z","steps":["trace[1135580465] 'process raft request' (duration: 168.474381ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:29:17.12489Z","caller":"traceutil/trace.go:171","msg":"trace[681963515] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"215.166713ms","start":"2026-09-01T18:29:16.90965Z","end":"2026-09-01T18:29:17.124817Z","steps":["trace[681963515] 'process raft request' (duration: 213.690889ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:29:17.130487Z","caller":"traceutil/trace.go:171","msg":"trace[484345479] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"127.306335ms","start":"2026-09-01T18:29:17.003155Z","end":"2026-09-01T18:29:17.130461Z","steps":["trace[484345479] 'process raft request' (duration: 126.963919ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:29:25.796806Z","caller":"traceutil/trace.go:171","msg":"trace[1995310931] transaction","detail":"{read_only:false; response_revision:2001; number_of_response:1; }","duration":"257.180162ms","start":"2026-09-01T18:29:25.539562Z","end":"2026-09-01T18:29:25.796742Z","steps":["trace[1995310931] 'process raft request' (duration: 257.02333ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:29:26.108207Z","caller":"traceutil/trace.go:171","msg":"trace[520483965] linearizableReadLoop","detail":"{readStateIndex:2074; appliedIndex:2072; }","duration":"169.7645ms","start":"2026-09-01T18:29:25.938401Z","end":"2026-09-01T18:29:26.108165Z","steps":["trace[520483965] 'read index received' (duration: 21.830476ms)","trace[520483965] 'applied index is now lower than readState.Index' (duration: 147.932804ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:29:26.108271Z","caller":"traceutil/trace.go:171","msg":"trace[2134389532] transaction","detail":"{read_only:false; response_revision:2006; number_of_response:1; }","duration":"173.170284ms","start":"2026-09-01T18:29:25.935045Z","end":"2026-09-01T18:29:26.108215Z","steps":["trace[2134389532] 'process raft request' (duration: 155.437283ms)","trace[2134389532] 'compare' (duration: 17.504528ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T18:29:26.108393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.976713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T18:29:26.108913Z","caller":"traceutil/trace.go:171","msg":"trace[1257136564] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2006; }","duration":"170.544693ms","start":"2026-09-01T18:29:25.938337Z","end":"2026-09-01T18:29:26.108882Z","steps":["trace[1257136564] 'agreement among raft nodes before linearized reading' (duration: 169.964494ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:29:28.59331Z","caller":"traceutil/trace.go:171","msg":"trace[1924420169] transaction","detail":"{read_only:false; response_revision:2036; number_of_response:1; }","duration":"247.428018ms","start":"2026-09-01T18:29:28.345852Z","end":"2026-09-01T18:29:28.59328Z","steps":["trace[1924420169] 'process raft request' (duration: 247.212475ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:29:28.622126Z","caller":"traceutil/trace.go:171","msg":"trace[1970108955] transaction","detail":"{read_only:false; response_revision:2037; number_of_response:1; }","duration":"162.643062ms","start":"2026-09-01T18:29:28.45944Z","end":"2026-09-01T18:29:28.622083Z","steps":["trace[1970108955] 'process raft request' (duration: 162.442849ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:29:52.285426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.785741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-09-01T18:29:52.285536Z","caller":"traceutil/trace.go:171","msg":"trace[1093216798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2194; }","duration":"176.981474ms","start":"2026-09-01T18:29:52.10853Z","end":"2026-09-01T18:29:52.285512Z","steps":["trace[1093216798] 'range keys from in-memory index tree' (duration: 176.587198ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:29:52.285614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.3582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-09-01T18:29:52.285674Z","caller":"traceutil/trace.go:171","msg":"trace[95300227] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2194; }","duration":"191.457811ms","start":"2026-09-01T18:29:52.0942Z","end":"2026-09-01T18:29:52.285657Z","steps":["trace[95300227] 'range keys from in-memory index tree' (duration: 191.203287ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:29:52.659381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.597773ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T18:29:52.659524Z","caller":"traceutil/trace.go:171","msg":"trace[1057802282] linearizableReadLoop","detail":"{readStateIndex:2277; appliedIndex:2274; }","duration":"341.811365ms","start":"2026-09-01T18:29:52.317692Z","end":"2026-09-01T18:29:52.659504Z","steps":["trace[1057802282] 'read index received' (duration: 30.392366ms)","trace[1057802282] 'applied index is now lower than readState.Index' (duration: 311.417089ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:29:52.659614Z","caller":"traceutil/trace.go:171","msg":"trace[2004601251] transaction","detail":"{read_only:false; response_revision:2199; number_of_response:1; }","duration":"351.803046ms","start":"2026-09-01T18:29:52.307799Z","end":"2026-09-01T18:29:52.659602Z","steps":["trace[2004601251] 'process raft request' (duration: 185.697855ms)","trace[2004601251] 'compare' (duration: 165.283279ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T18:29:52.659669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:29:52.307779Z","time spent":"351.858716ms","remote":"127.0.0.1:33558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":629,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T18:29:52.659988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.299624ms","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-01T18:29:52.660028Z","caller":"traceutil/trace.go:171","msg":"trace[1085328271] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2199; }","duration":"342.372074ms","start":"2026-09-01T18:29:52.317646Z","end":"2026-09-01T18:29:52.660018Z","steps":["trace[1085328271] 'agreement among raft nodes before linearized reading' (duration: 342.211632ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:29:52.660058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:29:52.317622Z","time spent":"342.428556ms","remote":"127.0.0.1:33742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-01T18:29:52.660273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.637404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18d145e64fa85590\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-09-01T18:29:52.660312Z","caller":"traceutil/trace.go:171","msg":"trace[1296190181] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18d145e64fa85590; range_end:; response_count:1; response_revision:2199; }","duration":"129.719385ms","start":"2026-09-01T18:29:52.530582Z","end":"2026-09-01T18:29:52.660301Z","steps":["trace[1296190181] 'agreement among raft nodes before linearized reading' (duration: 129.625084ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:29:52.660567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.617313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T18:29:52.660608Z","caller":"traceutil/trace.go:171","msg":"trace[956101466] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:2199; }","duration":"129.677355ms","start":"2026-09-01T18:29:52.53092Z","end":"2026-09-01T18:29:52.660597Z","steps":["trace[956101466] 'agreement among raft nodes before linearized reading' (duration: 129.616324ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:29:52.778086Z","caller":"traceutil/trace.go:171","msg":"trace[2133747328] transaction","detail":"{read_only:false; response_revision:2200; number_of_response:1; }","duration":"110.994554ms","start":"2026-09-01T18:29:52.667069Z","end":"2026-09-01T18:29:52.778064Z","steps":["trace[2133747328] 'process raft request' (duration: 110.885303ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:29:52.77811Z","caller":"traceutil/trace.go:171","msg":"trace[266442374] linearizableReadLoop","detail":"{readStateIndex:2278; appliedIndex:2277; }","duration":"111.844167ms","start":"2026-09-01T18:29:52.666235Z","end":"2026-09-01T18:29:52.778079Z","steps":["trace[266442374] 'read index received' (duration: 110.479836ms)","trace[266442374] 'applied index is now lower than readState.Index' (duration: 1.360951ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T18:29:52.778577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.310405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:551"} {"level":"info","ts":"2026-09-01T18:29:52.778656Z","caller":"traceutil/trace.go:171","msg":"trace[623510220] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2200; }","duration":"112.439466ms","start":"2026-09-01T18:29:52.666195Z","end":"2026-09-01T18:29:52.778634Z","steps":["trace[623510220] 'agreement among raft nodes before linearized reading' (duration: 111.974689ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:29:53.030802Z","caller":"traceutil/trace.go:171","msg":"trace[1884140864] transaction","detail":"{read_only:false; response_revision:2202; number_of_response:1; }","duration":"247.209626ms","start":"2026-09-01T18:29:52.783552Z","end":"2026-09-01T18:29:53.030761Z","steps":["trace[1884140864] 'process raft request' (duration: 192.368484ms)","trace[1884140864] 'compare' (duration: 54.68196ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:29:53.034305Z","caller":"traceutil/trace.go:171","msg":"trace[345126089] linearizableReadLoop","detail":"{readStateIndex:2282; appliedIndex:2280; }","duration":"195.912348ms","start":"2026-09-01T18:29:52.838351Z","end":"2026-09-01T18:29:53.034264Z","steps":["trace[345126089] 'read index received' (duration: 137.635484ms)","trace[345126089] 'applied index is now lower than readState.Index' (duration: 58.275784ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:29:53.034343Z","caller":"traceutil/trace.go:171","msg":"trace[983138363] transaction","detail":"{read_only:false; response_revision:2203; number_of_response:1; }","duration":"209.550992ms","start":"2026-09-01T18:29:52.824772Z","end":"2026-09-01T18:29:53.034323Z","steps":["trace[983138363] 'process raft request' (duration: 209.384689ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:29:53.034635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.503146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"} {"level":"info","ts":"2026-09-01T18:29:53.034684Z","caller":"traceutil/trace.go:171","msg":"trace[841577883] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2203; }","duration":"178.620638ms","start":"2026-09-01T18:29:52.856047Z","end":"2026-09-01T18:29:53.034668Z","steps":["trace[841577883] 'agreement among raft nodes before linearized reading' (duration: 178.348404ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:29:53.034905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.251793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:524"} {"level":"info","ts":"2026-09-01T18:29:53.035005Z","caller":"traceutil/trace.go:171","msg":"trace[1911409520] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:2203; }","duration":"196.671548ms","start":"2026-09-01T18:29:52.838312Z","end":"2026-09-01T18:29:53.034983Z","steps":["trace[1911409520] 'agreement among raft nodes before linearized reading' (duration: 196.07149ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:31:25.684827Z","caller":"traceutil/trace.go:171","msg":"trace[320944882] transaction","detail":"{read_only:false; response_revision:2935; number_of_response:1; }","duration":"135.630975ms","start":"2026-09-01T18:31:25.549033Z","end":"2026-09-01T18:31:25.684664Z","steps":["trace[320944882] 'process raft request' (duration: 135.458321ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:34:02.332027Z","caller":"traceutil/trace.go:171","msg":"trace[301183489] linearizableReadLoop","detail":"{readStateIndex:4914; appliedIndex:4913; }","duration":"106.57096ms","start":"2026-09-01T18:34:02.225433Z","end":"2026-09-01T18:34:02.332004Z","steps":["trace[301183489] 'read index received' (duration: 106.417508ms)","trace[301183489] 'applied index is now lower than readState.Index' (duration: 152.332µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:34:02.332157Z","caller":"traceutil/trace.go:171","msg":"trace[402092507] transaction","detail":"{read_only:false; response_revision:4704; number_of_response:1; }","duration":"152.226543ms","start":"2026-09-01T18:34:02.179898Z","end":"2026-09-01T18:34:02.332125Z","steps":["trace[402092507] 'process raft request' (duration: 151.971458ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:34:02.33228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.787344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11499"} {"level":"info","ts":"2026-09-01T18:34:02.332391Z","caller":"traceutil/trace.go:171","msg":"trace[1667750808] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4704; }","duration":"107.008088ms","start":"2026-09-01T18:34:02.22537Z","end":"2026-09-01T18:34:02.332378Z","steps":["trace[1667750808] 'agreement among raft nodes before linearized reading' (duration: 106.723973ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:34:02.56355Z","caller":"traceutil/trace.go:171","msg":"trace[722658210] transaction","detail":"{read_only:false; response_revision:4705; number_of_response:1; }","duration":"190.326006ms","start":"2026-09-01T18:34:02.373187Z","end":"2026-09-01T18:34:02.563513Z","steps":["trace[722658210] 'process raft request' (duration: 188.37002ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:34:02.578734Z","caller":"traceutil/trace.go:171","msg":"trace[2068526148] transaction","detail":"{read_only:false; response_revision:4706; number_of_response:1; }","duration":"182.520423ms","start":"2026-09-01T18:34:02.396167Z","end":"2026-09-01T18:34:02.578687Z","steps":["trace[2068526148] 'process raft request' (duration: 182.179437ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:34:02.946528Z","caller":"traceutil/trace.go:171","msg":"trace[982261317] linearizableReadLoop","detail":"{readStateIndex:4926; appliedIndex:4922; }","duration":"182.710377ms","start":"2026-09-01T18:34:02.763801Z","end":"2026-09-01T18:34:02.946512Z","steps":["trace[982261317] 'read index received' (duration: 42.720168ms)","trace[982261317] 'applied index is now lower than readState.Index' (duration: 139.988539ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:34:02.946602Z","caller":"traceutil/trace.go:171","msg":"trace[597008914] transaction","detail":"{read_only:false; response_revision:4715; number_of_response:1; }","duration":"201.194224ms","start":"2026-09-01T18:34:02.745381Z","end":"2026-09-01T18:34:02.946575Z","steps":["trace[597008914] 'process raft request' (duration: 200.702025ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:34:02.946701Z","caller":"traceutil/trace.go:171","msg":"trace[1679239504] transaction","detail":"{read_only:false; response_revision:4712; number_of_response:1; }","duration":"203.849623ms","start":"2026-09-01T18:34:02.742808Z","end":"2026-09-01T18:34:02.946658Z","steps":["trace[1679239504] 'process raft request' (duration: 157.155982ms)","trace[1679239504] 'compare' (duration: 45.855765ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:34:02.946748Z","caller":"traceutil/trace.go:171","msg":"trace[46921131] transaction","detail":"{read_only:false; response_revision:4713; number_of_response:1; }","duration":"203.898723ms","start":"2026-09-01T18:34:02.742836Z","end":"2026-09-01T18:34:02.946735Z","steps":["trace[46921131] 'process raft request' (duration: 203.150929ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:34:02.946801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.457793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-01T18:34:02.94689Z","caller":"traceutil/trace.go:171","msg":"trace[90019978] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:4716; }","duration":"115.608916ms","start":"2026-09-01T18:34:02.831263Z","end":"2026-09-01T18:34:02.946872Z","steps":["trace[90019978] 'agreement among raft nodes before linearized reading' (duration: 115.470503ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:34:02.947096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.284217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11499"} {"level":"info","ts":"2026-09-01T18:34:02.94714Z","caller":"traceutil/trace.go:171","msg":"trace[167738225] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4716; }","duration":"183.366049ms","start":"2026-09-01T18:34:02.763764Z","end":"2026-09-01T18:34:02.94713Z","steps":["trace[167738225] 'agreement among raft nodes before linearized reading' (duration: 183.226977ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:34:02.947526Z","caller":"traceutil/trace.go:171","msg":"trace[1398663637] transaction","detail":"{read_only:false; response_revision:4714; number_of_response:1; }","duration":"203.449875ms","start":"2026-09-01T18:34:02.742961Z","end":"2026-09-01T18:34:02.946411Z","steps":["trace[1398663637] 'process raft request' (duration: 203.086588ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:34:39.357768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.52424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T18:34:39.357991Z","caller":"traceutil/trace.go:171","msg":"trace[361384383] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:5039; }","duration":"155.772734ms","start":"2026-09-01T18:34:39.202178Z","end":"2026-09-01T18:34:39.357951Z","steps":["trace[361384383] 'count revisions from in-memory index tree' (duration: 155.371347ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:35:12.210006Z","caller":"traceutil/trace.go:171","msg":"trace[1867891780] linearizableReadLoop","detail":"{readStateIndex:5568; appliedIndex:5567; }","duration":"130.035771ms","start":"2026-09-01T18:35:12.079953Z","end":"2026-09-01T18:35:12.209989Z","steps":["trace[1867891780] 'read index received' (duration: 129.888368ms)","trace[1867891780] 'applied index is now lower than readState.Index' (duration: 146.823µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:35:12.210207Z","caller":"traceutil/trace.go:171","msg":"trace[531371806] transaction","detail":"{read_only:false; response_revision:5325; number_of_response:1; }","duration":"143.247795ms","start":"2026-09-01T18:35:12.06695Z","end":"2026-09-01T18:35:12.210197Z","steps":["trace[531371806] 'process raft request' (duration: 142.93524ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:35:12.210439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.472898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-01T18:35:12.210467Z","caller":"traceutil/trace.go:171","msg":"trace[450593307] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5325; }","duration":"130.533629ms","start":"2026-09-01T18:35:12.079926Z","end":"2026-09-01T18:35:12.210459Z","steps":["trace[450593307] 'agreement among raft nodes before linearized reading' (duration: 130.416827ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:35:12.210699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.185907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-01T18:35:12.210722Z","caller":"traceutil/trace.go:171","msg":"trace[520026834] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5325; }","duration":"122.228498ms","start":"2026-09-01T18:35:12.088488Z","end":"2026-09-01T18:35:12.210716Z","steps":["trace[520026834] 'agreement among raft nodes before linearized reading' (duration: 122.154377ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:35:12.210824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.265009ms","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-01T18:35:12.210875Z","caller":"traceutil/trace.go:171","msg":"trace[1549250387] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5325; }","duration":"122.33576ms","start":"2026-09-01T18:35:12.088526Z","end":"2026-09-01T18:35:12.210862Z","steps":["trace[1549250387] 'agreement among raft nodes before linearized reading' (duration: 122.218588ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:36:46.435703Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3073} {"level":"info","ts":"2026-09-01T18:36:46.528614Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3073,"took":"91.276273ms","hash":3333747014,"current-db-size-bytes":56524800,"current-db-size":"56 MB","current-db-size-in-use-bytes":30941184,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-01T18:36:46.528686Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3333747014,"revision":3073,"compact-revision":-1} {"level":"info","ts":"2026-09-01T18:38:35.841563Z","caller":"traceutil/trace.go:171","msg":"trace[295682912] transaction","detail":"{read_only:false; response_revision:7102; number_of_response:1; }","duration":"108.901307ms","start":"2026-09-01T18:38:35.732604Z","end":"2026-09-01T18:38:35.841505Z","steps":["trace[295682912] 'process raft request' (duration: 87.512502ms)","trace[295682912] 'compare' (duration: 21.238043ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:41:46.443858Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6200} {"level":"info","ts":"2026-09-01T18:41:46.549264Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6200,"took":"103.518597ms","hash":1195269013,"current-db-size-bytes":56524800,"current-db-size":"56 MB","current-db-size-in-use-bytes":18808832,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-01T18:41:46.549444Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1195269013,"revision":6200,"compact-revision":3073}