{"level":"warn","ts":"2026-09-02T16:19:16.669183Z","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-02T16:19:16.669283Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.57: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.57:2380","--initial-cluster=instance=https://162.253.55.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.57: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-02T16:19:16.669356Z","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-02T16:19:16.66937Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.57:2380"]} {"level":"info","ts":"2026-09-02T16:19:16.669394Z","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-02T16:19:16.669938Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.57:2379"]} {"level":"info","ts":"2026-09-02T16:19:16.670011Z","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.57:2380"],"listen-peer-urls":["https://162.253.55.57:2380"],"advertise-client-urls":["https://162.253.55.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.57: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-02T16:19:16.675013Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.77772ms"} {"level":"info","ts":"2026-09-02T16:19:16.686811Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"db28a37eabf8270","cluster-id":"33328f64ab44b15e"} {"level":"info","ts":"2026-09-02T16:19:16.686902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 switched to configuration voters=()"} {"level":"info","ts":"2026-09-02T16:19:16.686923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became follower at term 0"} {"level":"info","ts":"2026-09-02T16:19:16.686931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft db28a37eabf8270 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-02T16:19:16.68695Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became follower at term 1"} {"level":"info","ts":"2026-09-02T16:19:16.686983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 switched to configuration voters=(987003241113813616)"} {"level":"warn","ts":"2026-09-02T16:19:16.695887Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-02T16:19:16.697365Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-02T16:19:16.69848Z","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-02T16:19:16.7009Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"db28a37eabf8270","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-02T16:19:16.702076Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"db28a37eabf8270","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-02T16:19:16.70228Z","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-02T16:19:16.702357Z","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-02T16:19:16.702376Z","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-02T16:19:16.702585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 switched to configuration voters=(987003241113813616)"} {"level":"info","ts":"2026-09-02T16:19:16.702721Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"33328f64ab44b15e","local-member-id":"db28a37eabf8270","added-peer-id":"db28a37eabf8270","added-peer-peer-urls":["https://162.253.55.57:2380"]} {"level":"info","ts":"2026-09-02T16:19:16.708558Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.57:2380"} {"level":"info","ts":"2026-09-02T16:19:16.708465Z","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-02T16:19:16.708584Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.57:2380"} {"level":"info","ts":"2026-09-02T16:19:16.70894Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-02T16:19:16.708919Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"db28a37eabf8270","initial-advertise-peer-urls":["https://162.253.55.57:2380"],"listen-peer-urls":["https://162.253.55.57:2380"],"advertise-client-urls":["https://162.253.55.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-02T16:19:17.288063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 is starting a new election at term 1"} {"level":"info","ts":"2026-09-02T16:19:17.288195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-02T16:19:17.288333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 received MsgPreVoteResp from db28a37eabf8270 at term 1"} {"level":"info","ts":"2026-09-02T16:19:17.288416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became candidate at term 2"} {"level":"info","ts":"2026-09-02T16:19:17.288513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 received MsgVoteResp from db28a37eabf8270 at term 2"} {"level":"info","ts":"2026-09-02T16:19:17.288553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became leader at term 2"} {"level":"info","ts":"2026-09-02T16:19:17.288596Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: db28a37eabf8270 elected leader db28a37eabf8270 at term 2"} {"level":"info","ts":"2026-09-02T16:19:17.289757Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"db28a37eabf8270","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.57:2379]}","request-path":"/0/members/db28a37eabf8270/attributes","cluster-id":"33328f64ab44b15e","publish-timeout":"7s"} {"level":"info","ts":"2026-09-02T16:19:17.289902Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-02T16:19:17.289995Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-02T16:19:17.290107Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T16:19:17.290589Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-02T16:19:17.29065Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-02T16:19:17.29122Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"33328f64ab44b15e","local-member-id":"db28a37eabf8270","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T16:19:17.291427Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T16:19:17.291512Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T16:19:17.292274Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.57:2379"} {"level":"info","ts":"2026-09-02T16:19:17.295389Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-02T16:19:18.962748Z","caller":"traceutil/trace.go:171","msg":"trace[1504945822] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"101.046106ms","start":"2026-09-02T16:19:18.861666Z","end":"2026-09-02T16:19:18.962712Z","steps":["trace[1504945822] 'process raft request' (duration: 70.53809ms)","trace[1504945822] 'compare' (duration: 30.210228ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:19:47.250891Z","caller":"traceutil/trace.go:171","msg":"trace[1448509626] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"175.794399ms","start":"2026-09-02T16:19:47.075064Z","end":"2026-09-02T16:19:47.250858Z","steps":["trace[1448509626] 'process raft request' (duration: 96.63719ms)","trace[1448509626] 'compare' (duration: 78.989455ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:20:04.106901Z","caller":"traceutil/trace.go:171","msg":"trace[1829395991] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"134.012632ms","start":"2026-09-02T16:20:03.972863Z","end":"2026-09-02T16:20:04.106875Z","steps":["trace[1829395991] 'process raft request' (duration: 128.348944ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:20:04.107351Z","caller":"traceutil/trace.go:171","msg":"trace[1311537932] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"130.684317ms","start":"2026-09-02T16:20:03.97665Z","end":"2026-09-02T16:20:04.107335Z","steps":["trace[1311537932] 'process raft request' (duration: 130.522643ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:20:04.107367Z","caller":"traceutil/trace.go:171","msg":"trace[712231949] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"131.910005ms","start":"2026-09-02T16:20:03.975443Z","end":"2026-09-02T16:20:04.107353Z","steps":["trace[712231949] 'process raft request' (duration: 131.27217ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:20:09.826234Z","caller":"traceutil/trace.go:171","msg":"trace[995645276] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:674; }","duration":"169.011882ms","start":"2026-09-02T16:20:09.657201Z","end":"2026-09-02T16:20:09.826213Z","steps":["trace[995645276] 'read index received' (duration: 168.255315ms)","trace[995645276] 'applied index is now lower than readState.Index' (duration: 755.797µs)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:20:09.826613Z","caller":"traceutil/trace.go:171","msg":"trace[1651377833] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"254.471839ms","start":"2026-09-02T16:20:09.572115Z","end":"2026-09-02T16:20:09.826587Z","steps":["trace[1651377833] 'process raft request' (duration: 253.585379ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:20:09.827001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.775258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-x5dqf\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-02T16:20:09.827431Z","caller":"traceutil/trace.go:171","msg":"trace[1280376362] range","detail":"{range_begin:/registry/pods/kube-system/cilium-x5dqf; range_end:; response_count:1; response_revision:649; }","duration":"170.250049ms","start":"2026-09-02T16:20:09.657164Z","end":"2026-09-02T16:20:09.827414Z","steps":["trace[1280376362] 'agreement among raft nodes before linearized reading' (duration: 169.284598ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:20:10.016423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.454997ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-02T16:20:10.016519Z","caller":"traceutil/trace.go:171","msg":"trace[1737890146] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"182.906359ms","start":"2026-09-02T16:20:09.833595Z","end":"2026-09-02T16:20:10.016501Z","steps":["trace[1737890146] 'compare' (duration: 172.360836ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:20:10.02083Z","caller":"traceutil/trace.go:171","msg":"trace[494576120] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"167.487986ms","start":"2026-09-02T16:20:09.853321Z","end":"2026-09-02T16:20:10.020809Z","steps":["trace[494576120] 'process raft request' (duration: 167.265981ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:20:10.02707Z","caller":"traceutil/trace.go:171","msg":"trace[276656811] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"126.618995ms","start":"2026-09-02T16:20:09.900425Z","end":"2026-09-02T16:20:10.027044Z","steps":["trace[276656811] 'process raft request' (duration: 126.471302ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:20:10.653574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.504263ms","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-02T16:20:10.653736Z","caller":"traceutil/trace.go:171","msg":"trace[1147712582] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:653; }","duration":"498.693167ms","start":"2026-09-02T16:20:10.15502Z","end":"2026-09-02T16:20:10.653714Z","steps":["trace[1147712582] 'range keys from in-memory index tree' (duration: 498.477272ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:20:10.659371Z","caller":"traceutil/trace.go:171","msg":"trace[775022802] linearizableReadLoop","detail":"{readStateIndex:680; appliedIndex:679; }","duration":"123.671224ms","start":"2026-09-02T16:20:10.535678Z","end":"2026-09-02T16:20:10.659349Z","steps":["trace[775022802] 'read index received' (duration: 122.777864ms)","trace[775022802] 'applied index is now lower than readState.Index' (duration: 892.65µs)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:20:10.659481Z","caller":"traceutil/trace.go:171","msg":"trace[1493844899] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"202.564891ms","start":"2026-09-02T16:20:10.456887Z","end":"2026-09-02T16:20:10.659452Z","steps":["trace[1493844899] 'process raft request' (duration: 201.809214ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:20:10.65959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.910239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-09-02T16:20:10.659681Z","caller":"traceutil/trace.go:171","msg":"trace[353175256] range","detail":"{range_begin:/registry/masterleases/162.253.55.57; range_end:; response_count:1; response_revision:654; }","duration":"124.062063ms","start":"2026-09-02T16:20:10.535606Z","end":"2026-09-02T16:20:10.659668Z","steps":["trace[353175256] 'agreement among raft nodes before linearized reading' (duration: 123.857748ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:20:29.700488Z","caller":"traceutil/trace.go:171","msg":"trace[1693124873] transaction","detail":"{read_only:false; response_revision:826; number_of_response:1; }","duration":"181.89108ms","start":"2026-09-02T16:20:29.518568Z","end":"2026-09-02T16:20:29.700459Z","steps":["trace[1693124873] 'process raft request' (duration: 167.01803ms)","trace[1693124873] 'compare' (duration: 14.715215ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:20:59.770243Z","caller":"traceutil/trace.go:171","msg":"trace[1258946182] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"117.624149ms","start":"2026-09-02T16:20:59.652595Z","end":"2026-09-02T16:20:59.770219Z","steps":["trace[1258946182] 'process raft request' (duration: 117.387994ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:21:00.438924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.896787ms","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-02T16:21:00.439019Z","caller":"traceutil/trace.go:171","msg":"trace[1282824320] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1230; }","duration":"284.005899ms","start":"2026-09-02T16:21:00.154999Z","end":"2026-09-02T16:21:00.439005Z","steps":["trace[1282824320] 'range keys from in-memory index tree' (duration: 283.883557ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:21:00.439457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.028647ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-02T16:21:00.439831Z","caller":"traceutil/trace.go:171","msg":"trace[1151394003] linearizableReadLoop","detail":"{readStateIndex:1271; appliedIndex:1269; }","duration":"113.013262ms","start":"2026-09-02T16:21:00.326801Z","end":"2026-09-02T16:21:00.439814Z","steps":["trace[1151394003] 'read index received' (duration: 108.005689ms)","trace[1151394003] 'applied index is now lower than readState.Index' (duration: 5.006553ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:21:00.439959Z","caller":"traceutil/trace.go:171","msg":"trace[917720494] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"594.640138ms","start":"2026-09-02T16:20:59.845307Z","end":"2026-09-02T16:21:00.439947Z","steps":["trace[917720494] 'process raft request' (duration: 121.006899ms)","trace[917720494] 'compare' (duration: 472.839563ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:21:00.440004Z","caller":"traceutil/trace.go:171","msg":"trace[1773761928] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"419.453649ms","start":"2026-09-02T16:21:00.02053Z","end":"2026-09-02T16:21:00.439984Z","steps":["trace[1773761928] 'process raft request' (duration: 419.219645ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:21:00.440066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:20:59.84529Z","time spent":"594.699459ms","remote":"127.0.0.1:58186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-02T16:21:00.440146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.338218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-09-02T16:21:00.440189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:21:00.020507Z","time spent":"419.605993ms","remote":"127.0.0.1:58186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-02T16:21:00.440218Z","caller":"traceutil/trace.go:171","msg":"trace[1660438907] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1232; }","duration":"113.45665ms","start":"2026-09-02T16:21:00.326743Z","end":"2026-09-02T16:21:00.4402Z","steps":["trace[1660438907] 'agreement among raft nodes before linearized reading' (duration: 113.210006ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:21:00.4402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.805137ms","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-02T16:21:00.440304Z","caller":"traceutil/trace.go:171","msg":"trace[106509788] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1232; }","duration":"111.93384ms","start":"2026-09-02T16:21:00.328359Z","end":"2026-09-02T16:21:00.440292Z","steps":["trace[106509788] 'agreement among raft nodes before linearized reading' (duration: 111.618734ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:21:37.282723Z","caller":"traceutil/trace.go:171","msg":"trace[450391500] transaction","detail":"{read_only:false; response_revision:1744; number_of_response:1; }","duration":"125.064789ms","start":"2026-09-02T16:21:37.157636Z","end":"2026-09-02T16:21:37.282701Z","steps":["trace[450391500] 'process raft request' (duration: 59.013211ms)","trace[450391500] 'compare' (duration: 65.706581ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:21:40.141026Z","caller":"traceutil/trace.go:171","msg":"trace[829099223] transaction","detail":"{read_only:false; response_revision:1781; number_of_response:1; }","duration":"108.146812ms","start":"2026-09-02T16:21:40.032853Z","end":"2026-09-02T16:21:40.141Z","steps":["trace[829099223] 'process raft request' (duration: 56.818705ms)","trace[829099223] 'compare' (duration: 51.178585ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T16:21:49.557604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.059176ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-02T16:21:49.557928Z","caller":"traceutil/trace.go:171","msg":"trace[858334927] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"411.812067ms","start":"2026-09-02T16:21:49.146082Z","end":"2026-09-02T16:21:49.557894Z","steps":["trace[858334927] 'process raft request' (duration: 111.343193ms)","trace[858334927] 'compare' (duration: 299.927003ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:21:49.557971Z","caller":"traceutil/trace.go:171","msg":"trace[603297823] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"316.093834ms","start":"2026-09-02T16:21:49.24186Z","end":"2026-09-02T16:21:49.557954Z","steps":["trace[603297823] 'process raft request' (duration: 315.87549ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:21:49.557932Z","caller":"traceutil/trace.go:171","msg":"trace[487001807] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"223.328578ms","start":"2026-09-02T16:21:49.334583Z","end":"2026-09-02T16:21:49.557912Z","steps":["trace[487001807] 'process raft request' (duration: 223.260177ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:21:49.558082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:21:49.241846Z","time spent":"316.190625ms","remote":"127.0.0.1:58186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-02T16:21:49.55814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.76741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9500a633-f461-4c0f-b09a-1bc392a216ec\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-09-02T16:21:49.557957Z","caller":"traceutil/trace.go:171","msg":"trace[1889220523] linearizableReadLoop","detail":"{readStateIndex:1981; appliedIndex:1980; }","duration":"405.560815ms","start":"2026-09-02T16:21:49.152372Z","end":"2026-09-02T16:21:49.557933Z","steps":["trace[1889220523] 'read index received' (duration: 105.028291ms)","trace[1889220523] 'applied index is now lower than readState.Index' (duration: 300.530124ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:21:49.558197Z","caller":"traceutil/trace.go:171","msg":"trace[856904095] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9500a633-f461-4c0f-b09a-1bc392a216ec; range_end:; response_count:1; response_revision:1908; }","duration":"405.875502ms","start":"2026-09-02T16:21:49.152306Z","end":"2026-09-02T16:21:49.558182Z","steps":["trace[856904095] 'agreement among raft nodes before linearized reading' (duration: 405.689678ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:21:49.558244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:21:49.15228Z","time spent":"405.954203ms","remote":"127.0.0.1:58128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3648,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9500a633-f461-4c0f-b09a-1bc392a216ec\" "} {"level":"warn","ts":"2026-09-02T16:21:49.55817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:21:49.146067Z","time spent":"411.99389ms","remote":"127.0.0.1:58186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-02T16:21:49.558395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.785442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10667"} {"level":"info","ts":"2026-09-02T16:21:49.558456Z","caller":"traceutil/trace.go:171","msg":"trace[1475689021] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1908; }","duration":"390.879623ms","start":"2026-09-02T16:21:49.167559Z","end":"2026-09-02T16:21:49.558439Z","steps":["trace[1475689021] 'agreement among raft nodes before linearized reading' (duration: 390.699049ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:21:49.558503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:21:49.167545Z","time spent":"390.946325ms","remote":"127.0.0.1:58128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":10689,"request content":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" "} {"level":"info","ts":"2026-09-02T16:21:49.990282Z","caller":"traceutil/trace.go:171","msg":"trace[1474412432] transaction","detail":"{read_only:false; response_revision:1911; number_of_response:1; }","duration":"341.635325ms","start":"2026-09-02T16:21:49.648622Z","end":"2026-09-02T16:21:49.990257Z","steps":["trace[1474412432] 'process raft request' (duration: 288.067145ms)","trace[1474412432] 'compare' (duration: 53.388857ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T16:21:49.990532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:21:49.648599Z","time spent":"341.751398ms","remote":"127.0.0.1:58106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-02T16:21:49.990588Z","caller":"traceutil/trace.go:171","msg":"trace[307553013] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"341.747369ms","start":"2026-09-02T16:21:49.648808Z","end":"2026-09-02T16:21:49.990555Z","steps":["trace[307553013] 'process raft request' (duration: 341.408191ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:21:49.9908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:21:49.648799Z","time spent":"341.876601ms","remote":"127.0.0.1:58106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-02T16:21:49.990815Z","caller":"traceutil/trace.go:171","msg":"trace[961131723] linearizableReadLoop","detail":"{readStateIndex:1989; appliedIndex:1985; }","duration":"297.594828ms","start":"2026-09-02T16:21:49.6932Z","end":"2026-09-02T16:21:49.990795Z","steps":["trace[961131723] 'read index received' (duration: 243.468826ms)","trace[961131723] 'applied index is now lower than readState.Index' (duration: 54.124882ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:21:49.990859Z","caller":"traceutil/trace.go:171","msg":"trace[100924889] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"341.485203ms","start":"2026-09-02T16:21:49.649352Z","end":"2026-09-02T16:21:49.990837Z","steps":["trace[100924889] 'process raft request' (duration: 341.054204ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:21:49.990906Z","caller":"traceutil/trace.go:171","msg":"trace[1954004765] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"337.350143ms","start":"2026-09-02T16:21:49.653539Z","end":"2026-09-02T16:21:49.990889Z","steps":["trace[1954004765] 'process raft request' (duration: 337.133319ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:21:49.990981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:21:49.653527Z","time spent":"337.408974ms","remote":"127.0.0.1:58128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3731,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-02T16:21:49.990985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:21:49.649341Z","time spent":"341.589284ms","remote":"127.0.0.1:58198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1529,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-02T16:21:49.991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.794361ms","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-02T16:21:49.991034Z","caller":"traceutil/trace.go:171","msg":"trace[1178487499] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1914; }","duration":"297.834832ms","start":"2026-09-02T16:21:49.693188Z","end":"2026-09-02T16:21:49.991023Z","steps":["trace[1178487499] 'agreement among raft nodes before linearized reading' (duration: 297.70588ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:21:49.991095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.673038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T16:21:49.99113Z","caller":"traceutil/trace.go:171","msg":"trace[1483665845] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1914; }","duration":"165.706319ms","start":"2026-09-02T16:21:49.825414Z","end":"2026-09-02T16:21:49.991121Z","steps":["trace[1483665845] 'agreement among raft nodes before linearized reading' (duration: 165.652368ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:21:49.991341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.934815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-02T16:21:49.991394Z","caller":"traceutil/trace.go:171","msg":"trace[614230505] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1914; }","duration":"124.130039ms","start":"2026-09-02T16:21:49.867249Z","end":"2026-09-02T16:21:49.991379Z","steps":["trace[614230505] 'agreement among raft nodes before linearized reading' (duration: 123.913555ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:21:56.857988Z","caller":"traceutil/trace.go:171","msg":"trace[1953777118] linearizableReadLoop","detail":"{readStateIndex:2062; appliedIndex:2061; }","duration":"123.353047ms","start":"2026-09-02T16:21:56.734605Z","end":"2026-09-02T16:21:56.857958Z","steps":["trace[1953777118] 'read index received' (duration: 49.204791ms)","trace[1953777118] 'applied index is now lower than readState.Index' (duration: 74.146626ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:21:56.858103Z","caller":"traceutil/trace.go:171","msg":"trace[1640023089] transaction","detail":"{read_only:false; response_revision:1984; number_of_response:1; }","duration":"128.909244ms","start":"2026-09-02T16:21:56.729139Z","end":"2026-09-02T16:21:56.858049Z","steps":["trace[1640023089] 'process raft request' (duration: 54.719905ms)","trace[1640023089] 'compare' (duration: 73.812451ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T16:21:56.858355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.735585ms","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-02T16:21:56.85837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.13481ms","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-02T16:21:56.858439Z","caller":"traceutil/trace.go:171","msg":"trace[423927348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1984; }","duration":"123.863987ms","start":"2026-09-02T16:21:56.734547Z","end":"2026-09-02T16:21:56.858411Z","steps":["trace[423927348] 'agreement among raft nodes before linearized reading' (duration: 123.594412ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:21:56.858445Z","caller":"traceutil/trace.go:171","msg":"trace[299351982] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1984; }","duration":"116.247121ms","start":"2026-09-02T16:21:56.742173Z","end":"2026-09-02T16:21:56.85842Z","steps":["trace[299351982] 'agreement among raft nodes before linearized reading' (duration: 116.040858ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:22:02.64135Z","caller":"traceutil/trace.go:171","msg":"trace[1294162117] transaction","detail":"{read_only:false; response_revision:2017; number_of_response:1; }","duration":"146.283968ms","start":"2026-09-02T16:22:02.495039Z","end":"2026-09-02T16:22:02.641323Z","steps":["trace[1294162117] 'process raft request' (duration: 146.105995ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:22:03.090486Z","caller":"traceutil/trace.go:171","msg":"trace[137149546] linearizableReadLoop","detail":"{readStateIndex:2099; appliedIndex:2098; }","duration":"170.212132ms","start":"2026-09-02T16:22:02.920245Z","end":"2026-09-02T16:22:03.090457Z","steps":["trace[137149546] 'read index received' (duration: 169.978938ms)","trace[137149546] 'applied index is now lower than readState.Index' (duration: 231.874µs)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:22:03.09064Z","caller":"traceutil/trace.go:171","msg":"trace[2633730] transaction","detail":"{read_only:false; response_revision:2020; number_of_response:1; }","duration":"179.289386ms","start":"2026-09-02T16:22:02.911339Z","end":"2026-09-02T16:22:03.090628Z","steps":["trace[2633730] 'process raft request' (duration: 178.917318ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:22:03.090858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.922523ms","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-02T16:22:03.090948Z","caller":"traceutil/trace.go:171","msg":"trace[562335735] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2020; }","duration":"124.061795ms","start":"2026-09-02T16:22:02.966865Z","end":"2026-09-02T16:22:03.090927Z","steps":["trace[562335735] 'agreement among raft nodes before linearized reading' (duration: 123.859142ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:22:03.091215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.556789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11988"} {"level":"info","ts":"2026-09-02T16:22:03.09125Z","caller":"traceutil/trace.go:171","msg":"trace[1824695026] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2020; }","duration":"119.636631ms","start":"2026-09-02T16:22:02.971604Z","end":"2026-09-02T16:22:03.091241Z","steps":["trace[1824695026] 'agreement among raft nodes before linearized reading' (duration: 119.532139ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:22:03.091437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.16483ms","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-02T16:22:03.091491Z","caller":"traceutil/trace.go:171","msg":"trace[1225236048] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2020; }","duration":"171.238531ms","start":"2026-09-02T16:22:02.920238Z","end":"2026-09-02T16:22:03.091476Z","steps":["trace[1225236048] 'agreement among raft nodes before linearized reading' (duration: 171.100179ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:22:22.823138Z","caller":"traceutil/trace.go:171","msg":"trace[1656854388] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"104.663853ms","start":"2026-09-02T16:22:22.718449Z","end":"2026-09-02T16:22:22.823113Z","steps":["trace[1656854388] 'process raft request' (duration: 104.538861ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:22:23.349048Z","caller":"traceutil/trace.go:171","msg":"trace[1035032842] linearizableReadLoop","detail":"{readStateIndex:2230; appliedIndex:2229; }","duration":"155.103582ms","start":"2026-09-02T16:22:23.193922Z","end":"2026-09-02T16:22:23.349025Z","steps":["trace[1035032842] 'read index received' (duration: 154.933379ms)","trace[1035032842] 'applied index is now lower than readState.Index' (duration: 168.693µs)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:22:23.349409Z","caller":"traceutil/trace.go:171","msg":"trace[306245927] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"160.521062ms","start":"2026-09-02T16:22:23.188871Z","end":"2026-09-02T16:22:23.349392Z","steps":["trace[306245927] 'process raft request' (duration: 159.935681ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:22:23.349823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.879087ms","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-02T16:22:23.349905Z","caller":"traceutil/trace.go:171","msg":"trace[527355448] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2146; }","duration":"156.012438ms","start":"2026-09-02T16:22:23.193872Z","end":"2026-09-02T16:22:23.349884Z","steps":["trace[527355448] 'agreement among raft nodes before linearized reading' (duration: 155.769174ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:22:23.647931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.452346ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-02T16:22:23.648129Z","caller":"traceutil/trace.go:171","msg":"trace[916532523] linearizableReadLoop","detail":"{readStateIndex:2231; appliedIndex:2230; }","duration":"298.974914ms","start":"2026-09-02T16:22:23.349135Z","end":"2026-09-02T16:22:23.64811Z","steps":["trace[916532523] 'read index received' (duration: 103.931479ms)","trace[916532523] 'applied index is now lower than readState.Index' (duration: 195.042415ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:22:23.648131Z","caller":"traceutil/trace.go:171","msg":"trace[941407955] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"371.392424ms","start":"2026-09-02T16:22:23.276705Z","end":"2026-09-02T16:22:23.648097Z","steps":["trace[941407955] 'process raft request' (duration: 176.347888ms)","trace[941407955] 'compare' (duration: 194.198061ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T16:22:23.648285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:22:23.276688Z","time spent":"371.549177ms","remote":"127.0.0.1:58186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-02T16:22:23.648314Z","caller":"traceutil/trace.go:171","msg":"trace[1231019996] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"293.485523ms","start":"2026-09-02T16:22:23.354811Z","end":"2026-09-02T16:22:23.648297Z","steps":["trace[1231019996] 'process raft request' (duration: 293.227047ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:22:23.64849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.432495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12385"} {"level":"info","ts":"2026-09-02T16:22:23.649563Z","caller":"traceutil/trace.go:171","msg":"trace[538262033] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2149; }","duration":"439.527675ms","start":"2026-09-02T16:22:23.210017Z","end":"2026-09-02T16:22:23.649545Z","steps":["trace[538262033] 'agreement among raft nodes before linearized reading' (duration: 438.355134ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:22:23.649622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:22:23.210007Z","time spent":"439.599816ms","remote":"127.0.0.1:58128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12407,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-09-02T16:22:23.64865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.418067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-02T16:22:23.649841Z","caller":"traceutil/trace.go:171","msg":"trace[228167088] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2149; }","duration":"422.633819ms","start":"2026-09-02T16:22:23.227195Z","end":"2026-09-02T16:22:23.649828Z","steps":["trace[228167088] 'agreement among raft nodes before linearized reading' (duration: 421.373196ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:22:23.649885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:22:23.227182Z","time spent":"422.68914ms","remote":"127.0.0.1:56810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-09-02T16:22:23.648763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.895503ms","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-02T16:22:23.650173Z","caller":"traceutil/trace.go:171","msg":"trace[1180423682] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2149; }","duration":"455.32033ms","start":"2026-09-02T16:22:23.194837Z","end":"2026-09-02T16:22:23.650158Z","steps":["trace[1180423682] 'agreement among raft nodes before linearized reading' (duration: 453.855202ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:22:23.650233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:22:23.194827Z","time spent":"455.391401ms","remote":"127.0.0.1:58186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-02T16:22:23.807005Z","caller":"traceutil/trace.go:171","msg":"trace[735442723] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"103.718154ms","start":"2026-09-02T16:22:23.703256Z","end":"2026-09-02T16:22:23.806974Z","steps":["trace[735442723] 'process raft request' (duration: 66.807735ms)","trace[735442723] 'compare' (duration: 36.546792ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T16:22:24.586814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.162851ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-02T16:22:24.586907Z","caller":"traceutil/trace.go:171","msg":"trace[2049552607] linearizableReadLoop","detail":"{readStateIndex:2238; appliedIndex:2237; }","duration":"140.150641ms","start":"2026-09-02T16:22:24.44674Z","end":"2026-09-02T16:22:24.586891Z","steps":["trace[2049552607] 'read index received' (duration: 68.462µs)","trace[2049552607] 'applied index is now lower than readState.Index' (duration: 140.080839ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:22:24.586976Z","caller":"traceutil/trace.go:171","msg":"trace[205259999] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"304.705236ms","start":"2026-09-02T16:22:24.282239Z","end":"2026-09-02T16:22:24.586944Z","steps":["trace[205259999] 'process raft request' (duration: 98.334092ms)","trace[205259999] 'compare' (duration: 206.008198ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T16:22:24.587039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.292533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-02T16:22:24.587071Z","caller":"traceutil/trace.go:171","msg":"trace[223054941] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:2154; }","duration":"140.363355ms","start":"2026-09-02T16:22:24.446694Z","end":"2026-09-02T16:22:24.587057Z","steps":["trace[223054941] 'agreement among raft nodes before linearized reading' (duration: 140.301064ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:22:24.587124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:22:24.28222Z","time spent":"304.820288ms","remote":"127.0.0.1:58186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-02T16:22:24.587295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.615011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T16:22:24.587367Z","caller":"traceutil/trace.go:171","msg":"trace[905002872] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:2154; }","duration":"103.668962ms","start":"2026-09-02T16:22:24.483647Z","end":"2026-09-02T16:22:24.587316Z","steps":["trace[905002872] 'agreement among raft nodes before linearized reading' (duration: 103.59331ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:22:24.942437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.774021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T16:22:24.942584Z","caller":"traceutil/trace.go:171","msg":"trace[212210589] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2154; }","duration":"120.000526ms","start":"2026-09-02T16:22:24.822566Z","end":"2026-09-02T16:22:24.942567Z","steps":["trace[212210589] 'range keys from in-memory index tree' (duration: 119.608408ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:22:25.064979Z","caller":"traceutil/trace.go:171","msg":"trace[2098383060] linearizableReadLoop","detail":"{readStateIndex:2239; appliedIndex:2238; }","duration":"218.202494ms","start":"2026-09-02T16:22:24.846742Z","end":"2026-09-02T16:22:25.064945Z","steps":["trace[2098383060] 'read index received' (duration: 217.99488ms)","trace[2098383060] 'applied index is now lower than readState.Index' (duration: 205.864µs)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:22:25.065031Z","caller":"traceutil/trace.go:171","msg":"trace[1333317695] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"238.240388ms","start":"2026-09-02T16:22:24.826757Z","end":"2026-09-02T16:22:25.064997Z","steps":["trace[1333317695] 'process raft request' (duration: 237.941302ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:22:25.065181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.397298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T16:22:25.065249Z","caller":"traceutil/trace.go:171","msg":"trace[1445023014] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:2155; }","duration":"218.52505ms","start":"2026-09-02T16:22:24.846706Z","end":"2026-09-02T16:22:25.065231Z","steps":["trace[1445023014] 'agreement among raft nodes before linearized reading' (duration: 218.395867ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:22:25.140196Z","caller":"traceutil/trace.go:171","msg":"trace[847318417] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"253.819486ms","start":"2026-09-02T16:22:24.886349Z","end":"2026-09-02T16:22:25.140169Z","steps":["trace[847318417] 'process raft request' (duration: 253.645032ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:22:25.14048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.688432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T16:22:25.140542Z","caller":"traceutil/trace.go:171","msg":"trace[84560869] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2156; }","duration":"196.811695ms","start":"2026-09-02T16:22:24.943718Z","end":"2026-09-02T16:22:25.140529Z","steps":["trace[84560869] 'agreement among raft nodes before linearized reading' (duration: 196.419028ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:23:19.349409Z","caller":"traceutil/trace.go:171","msg":"trace[562975935] transaction","detail":"{read_only:false; response_revision:2494; number_of_response:1; }","duration":"107.01414ms","start":"2026-09-02T16:23:19.242366Z","end":"2026-09-02T16:23:19.34938Z","steps":["trace[562975935] 'process raft request' (duration: 106.846697ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:23:36.82112Z","caller":"traceutil/trace.go:171","msg":"trace[824709684] transaction","detail":"{read_only:false; response_revision:2643; number_of_response:1; }","duration":"178.176218ms","start":"2026-09-02T16:23:36.642924Z","end":"2026-09-02T16:23:36.8211Z","steps":["trace[824709684] 'process raft request' (duration: 178.039996ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:24:11.167084Z","caller":"traceutil/trace.go:171","msg":"trace[112754211] transaction","detail":"{read_only:false; response_revision:2833; number_of_response:1; }","duration":"138.670979ms","start":"2026-09-02T16:24:11.028391Z","end":"2026-09-02T16:24:11.167062Z","steps":["trace[112754211] 'process raft request' (duration: 138.495596ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:24:11.42287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.194421ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-02T16:24:11.423191Z","caller":"traceutil/trace.go:171","msg":"trace[1297172195] linearizableReadLoop","detail":"{readStateIndex:2942; appliedIndex:2941; }","duration":"220.36141ms","start":"2026-09-02T16:24:11.202812Z","end":"2026-09-02T16:24:11.423173Z","steps":["trace[1297172195] 'read index received' (duration: 65.569198ms)","trace[1297172195] 'applied index is now lower than readState.Index' (duration: 154.790442ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:24:11.423242Z","caller":"traceutil/trace.go:171","msg":"trace[2090860088] transaction","detail":"{read_only:false; response_revision:2834; number_of_response:1; }","duration":"252.097656ms","start":"2026-09-02T16:24:11.171096Z","end":"2026-09-02T16:24:11.423194Z","steps":["trace[2090860088] 'process raft request' (duration: 97.306724ms)","trace[2090860088] 'compare' (duration: 153.982848ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T16:24:11.423339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.526212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T16:24:11.423374Z","caller":"traceutil/trace.go:171","msg":"trace[1231957790] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:2834; }","duration":"220.602024ms","start":"2026-09-02T16:24:11.202762Z","end":"2026-09-02T16:24:11.423364Z","steps":["trace[1231957790] 'agreement among raft nodes before linearized reading' (duration: 220.536583ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:28:38.640495Z","caller":"traceutil/trace.go:171","msg":"trace[2136180150] transaction","detail":"{read_only:false; response_revision:4997; number_of_response:1; }","duration":"160.6319ms","start":"2026-09-02T16:28:38.479834Z","end":"2026-09-02T16:28:38.640466Z","steps":["trace[2136180150] 'process raft request' (duration: 160.469736ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:28:38.784749Z","caller":"traceutil/trace.go:171","msg":"trace[288153969] transaction","detail":"{read_only:false; response_revision:4998; number_of_response:1; }","duration":"284.954364ms","start":"2026-09-02T16:28:38.499754Z","end":"2026-09-02T16:28:38.784709Z","steps":["trace[288153969] 'process raft request' (duration: 221.195094ms)","trace[288153969] 'compare' (duration: 63.527524ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:28:38.784961Z","caller":"traceutil/trace.go:171","msg":"trace[1364925547] linearizableReadLoop","detail":"{readStateIndex:5187; appliedIndex:5185; }","duration":"188.139415ms","start":"2026-09-02T16:28:38.596798Z","end":"2026-09-02T16:28:38.784937Z","steps":["trace[1364925547] 'read index received' (duration: 43.901275ms)","trace[1364925547] 'applied index is now lower than readState.Index' (duration: 144.2368ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T16:28:38.785122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.31114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-02T16:28:38.785158Z","caller":"traceutil/trace.go:171","msg":"trace[321885047] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:4999; }","duration":"188.369402ms","start":"2026-09-02T16:28:38.596779Z","end":"2026-09-02T16:28:38.785149Z","steps":["trace[321885047] 'agreement among raft nodes before linearized reading' (duration: 188.238018ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:28:38.785236Z","caller":"traceutil/trace.go:171","msg":"trace[1003543430] transaction","detail":"{read_only:false; response_revision:4999; number_of_response:1; }","duration":"250.925758ms","start":"2026-09-02T16:28:38.534294Z","end":"2026-09-02T16:28:38.785219Z","steps":["trace[1003543430] 'process raft request' (duration: 250.369244ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:28:39.261699Z","caller":"traceutil/trace.go:171","msg":"trace[167881296] transaction","detail":"{read_only:false; response_revision:5002; number_of_response:1; }","duration":"106.677226ms","start":"2026-09-02T16:28:39.154985Z","end":"2026-09-02T16:28:39.261662Z","steps":["trace[167881296] 'process raft request' (duration: 63.904813ms)","trace[167881296] 'compare' (duration: 42.396382ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:28:53.654357Z","caller":"traceutil/trace.go:171","msg":"trace[301392934] linearizableReadLoop","detail":"{readStateIndex:5383; appliedIndex:5382; }","duration":"151.982737ms","start":"2026-09-02T16:28:53.502336Z","end":"2026-09-02T16:28:53.654319Z","steps":["trace[301392934] 'read index received' (duration: 151.592717ms)","trace[301392934] 'applied index is now lower than readState.Index' (duration: 388.38µs)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:28:53.654406Z","caller":"traceutil/trace.go:171","msg":"trace[2035903053] transaction","detail":"{read_only:false; response_revision:5188; number_of_response:1; }","duration":"197.481873ms","start":"2026-09-02T16:28:53.456881Z","end":"2026-09-02T16:28:53.654363Z","steps":["trace[2035903053] 'process raft request' (duration: 197.181295ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:28:53.654674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.59598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-02T16:28:53.65473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.341057ms","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-02T16:28:53.654783Z","caller":"traceutil/trace.go:171","msg":"trace[240828726] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5188; }","duration":"152.477111ms","start":"2026-09-02T16:28:53.502294Z","end":"2026-09-02T16:28:53.654771Z","steps":["trace[240828726] 'agreement among raft nodes before linearized reading' (duration: 152.203462ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:28:53.65488Z","caller":"traceutil/trace.go:171","msg":"trace[655550141] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:5188; }","duration":"110.754226ms","start":"2026-09-02T16:28:53.544003Z","end":"2026-09-02T16:28:53.654757Z","steps":["trace[655550141] 'agreement among raft nodes before linearized reading' (duration: 110.591851ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:28:54.046208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.370731ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-02T16:28:54.046664Z","caller":"traceutil/trace.go:171","msg":"trace[431326227] transaction","detail":"{read_only:false; response_revision:5189; number_of_response:1; }","duration":"384.501901ms","start":"2026-09-02T16:28:53.662121Z","end":"2026-09-02T16:28:54.046623Z","steps":["trace[431326227] 'process raft request' (duration: 151.100822ms)","trace[431326227] 'compare' (duration: 231.966901ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:28:54.046762Z","caller":"traceutil/trace.go:171","msg":"trace[771684027] transaction","detail":"{read_only:false; response_revision:5190; number_of_response:1; }","duration":"383.668529ms","start":"2026-09-02T16:28:53.663073Z","end":"2026-09-02T16:28:54.046742Z","steps":["trace[771684027] 'process raft request' (duration: 383.249739ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:28:54.046907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:28:53.662096Z","time spent":"384.72906ms","remote":"127.0.0.1:58186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-02T16:28:54.046972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:28:53.663047Z","time spent":"383.879076ms","remote":"127.0.0.1:58106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1283,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-02T16:28:54.04732Z","caller":"traceutil/trace.go:171","msg":"trace[212931685] transaction","detail":"{read_only:false; response_revision:5191; number_of_response:1; }","duration":"383.718701ms","start":"2026-09-02T16:28:53.663587Z","end":"2026-09-02T16:28:54.047306Z","steps":["trace[212931685] 'process raft request' (duration: 382.811156ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:28:54.047433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:28:53.663535Z","time spent":"383.858675ms","remote":"127.0.0.1:58198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1455,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-02T16:28:54.048924Z","caller":"traceutil/trace.go:171","msg":"trace[1199169946] linearizableReadLoop","detail":"{readStateIndex:5389; appliedIndex:5383; }","duration":"272.044461ms","start":"2026-09-02T16:28:53.776858Z","end":"2026-09-02T16:28:54.048902Z","steps":["trace[1199169946] 'read index received' (duration: 36.37782ms)","trace[1199169946] 'applied index is now lower than readState.Index' (duration: 235.665431ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:28:54.049163Z","caller":"traceutil/trace.go:171","msg":"trace[470313905] transaction","detail":"{read_only:false; response_revision:5193; number_of_response:1; }","duration":"384.713438ms","start":"2026-09-02T16:28:53.664437Z","end":"2026-09-02T16:28:54.04915Z","steps":["trace[470313905] 'process raft request' (duration: 384.317137ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:28:54.04919Z","caller":"traceutil/trace.go:171","msg":"trace[1987814196] transaction","detail":"{read_only:false; response_revision:5192; number_of_response:1; }","duration":"385.388126ms","start":"2026-09-02T16:28:53.663776Z","end":"2026-09-02T16:28:54.049164Z","steps":["trace[1987814196] 'process raft request' (duration: 383.083554ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:28:54.049324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:28:53.663757Z","time spent":"385.475229ms","remote":"127.0.0.1:58198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1869,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-02T16:28:54.049353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:28:53.664423Z","time spent":"384.77789ms","remote":"127.0.0.1:58106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":906,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-02T16:28:54.04979Z","caller":"traceutil/trace.go:171","msg":"trace[941403144] transaction","detail":"{read_only:false; response_revision:5194; number_of_response:1; }","duration":"376.702253ms","start":"2026-09-02T16:28:53.673073Z","end":"2026-09-02T16:28:54.049775Z","steps":["trace[941403144] 'process raft request' (duration: 375.758637ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:28:54.049904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.048329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-09-02T16:28:54.04995Z","caller":"traceutil/trace.go:171","msg":"trace[1262349499] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5194; }","duration":"273.140771ms","start":"2026-09-02T16:28:53.776798Z","end":"2026-09-02T16:28:54.049939Z","steps":["trace[1262349499] 'agreement among raft nodes before linearized reading' (duration: 273.001657ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:28:54.050284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.531393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-02T16:28:54.051882Z","caller":"traceutil/trace.go:171","msg":"trace[1725725232] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5194; }","duration":"248.162537ms","start":"2026-09-02T16:28:53.803704Z","end":"2026-09-02T16:28:54.051866Z","steps":["trace[1725725232] 'agreement among raft nodes before linearized reading' (duration: 246.470521ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:28:54.05058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:28:53.67305Z","time spent":"376.778024ms","remote":"127.0.0.1:58404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12012,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-02T16:29:17.329974Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2864} {"level":"info","ts":"2026-09-02T16:29:17.432397Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2864,"took":"100.809342ms","hash":2684903508,"current-db-size-bytes":52891648,"current-db-size":"53 MB","current-db-size-in-use-bytes":27734016,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-02T16:29:17.432512Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2684903508,"revision":2864,"compact-revision":-1} {"level":"info","ts":"2026-09-02T16:34:17.336663Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5350} {"level":"info","ts":"2026-09-02T16:34:17.457287Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5350,"took":"119.197623ms","hash":1352167247,"current-db-size-bytes":52891648,"current-db-size":"53 MB","current-db-size-in-use-bytes":18845696,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-02T16:34:17.457401Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1352167247,"revision":5350,"compact-revision":2864} {"level":"info","ts":"2026-09-02T16:39:17.343155Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7392} {"level":"info","ts":"2026-09-02T16:39:17.402499Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7392,"took":"57.861291ms","hash":78504592,"current-db-size-bytes":52891648,"current-db-size":"53 MB","current-db-size-in-use-bytes":15429632,"current-db-size-in-use":"15 MB"} {"level":"info","ts":"2026-09-02T16:39:17.402593Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":78504592,"revision":7392,"compact-revision":5350} {"level":"info","ts":"2026-09-02T16:41:42.280268Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"db28a37eabf8270","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-02T16:41:42.287552Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-09-02T16:41:42.28768Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}