{"level":"warn","ts":"2026-06-04T15:52:08.977469Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-04T15:52:08.977546Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.246: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://199.204.45.246:2380","--initial-cluster=instance=https://199.204.45.246:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.246:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.246: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-06-04T15:52:08.977619Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-04T15:52:08.977631Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.246:2380"]} {"level":"info","ts":"2026-06-04T15:52:08.977648Z","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-06-04T15:52:08.978259Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"]} {"level":"info","ts":"2026-06-04T15:52:08.978336Z","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://199.204.45.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.246: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-06-04T15:52:08.982852Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.347694ms"} {"level":"info","ts":"2026-06-04T15:52:08.991521Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ab97322ebdd79664","cluster-id":"87bc89380c3dc2c"} {"level":"info","ts":"2026-06-04T15:52:08.991671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=()"} {"level":"info","ts":"2026-06-04T15:52:08.991818Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 0"} {"level":"info","ts":"2026-06-04T15:52:08.991907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ab97322ebdd79664 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-04T15:52:08.991929Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 1"} {"level":"info","ts":"2026-06-04T15:52:08.992071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"} {"level":"warn","ts":"2026-06-04T15:52:08.999515Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-04T15:52:09.001236Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-04T15:52:09.002361Z","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-06-04T15:52:09.004476Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ab97322ebdd79664","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-04T15:52:09.004789Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ab97322ebdd79664","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-04T15:52:09.005091Z","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-06-04T15:52:09.005207Z","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-06-04T15:52:09.005222Z","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-06-04T15:52:09.006826Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"} {"level":"info","ts":"2026-06-04T15:52:09.007009Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","added-peer-id":"ab97322ebdd79664","added-peer-peer-urls":["https://199.204.45.246:2380"]} {"level":"info","ts":"2026-06-04T15:52:09.010268Z","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-06-04T15:52:09.011195Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.246:2380"} {"level":"info","ts":"2026-06-04T15:52:09.011229Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.246:2380"} {"level":"info","ts":"2026-06-04T15:52:09.011383Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ab97322ebdd79664","initial-advertise-peer-urls":["https://199.204.45.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-04T15:52:09.011492Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-04T15:52:09.093329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 is starting a new election at term 1"} {"level":"info","ts":"2026-06-04T15:52:09.093394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-04T15:52:09.093423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgPreVoteResp from ab97322ebdd79664 at term 1"} {"level":"info","ts":"2026-06-04T15:52:09.093444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became candidate at term 2"} {"level":"info","ts":"2026-06-04T15:52:09.093455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgVoteResp from ab97322ebdd79664 at term 2"} {"level":"info","ts":"2026-06-04T15:52:09.093471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became leader at term 2"} {"level":"info","ts":"2026-06-04T15:52:09.093485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ab97322ebdd79664 elected leader ab97322ebdd79664 at term 2"} {"level":"info","ts":"2026-06-04T15:52:09.09467Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ab97322ebdd79664","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.246:2379]}","request-path":"/0/members/ab97322ebdd79664/attributes","cluster-id":"87bc89380c3dc2c","publish-timeout":"7s"} {"level":"info","ts":"2026-06-04T15:52:09.094721Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-04T15:52:09.094693Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-04T15:52:09.094812Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-04T15:52:09.095145Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-04T15:52:09.095272Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-04T15:52:09.095934Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","cluster-version":"3.5"} {"level":"info","ts":"2026-06-04T15:52:09.096086Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-04T15:52:09.09651Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-04T15:52:09.098603Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.246:2379"} {"level":"info","ts":"2026-06-04T15:52:09.098923Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-06-04T15:52:15.932857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.915654ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-04T15:52:15.93314Z","caller":"traceutil/trace.go:171","msg":"trace[2115441416] transaction","detail":"{read_only:false; response_revision:263; number_of_response:1; }","duration":"489.519957ms","start":"2026-06-04T15:52:15.443434Z","end":"2026-06-04T15:52:15.932954Z","steps":["trace[2115441416] 'process raft request' (duration: 219.977034ms)","trace[2115441416] 'compare' (duration: 268.596628ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T15:52:15.933252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:15.443414Z","time spent":"489.779621ms","remote":"127.0.0.1:58344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":180,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-04T15:52:16.575532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.523062ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T15:52:16.575627Z","caller":"traceutil/trace.go:171","msg":"trace[168985237] linearizableReadLoop","detail":"{readStateIndex:276; appliedIndex:275; }","duration":"638.147353ms","start":"2026-06-04T15:52:15.937463Z","end":"2026-06-04T15:52:16.57561Z","steps":["trace[168985237] 'read index received' (duration: 296.361198ms)","trace[168985237] 'applied index is now lower than readState.Index' (duration: 341.784775ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T15:52:16.575733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"638.266816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ephemeral-volume-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T15:52:16.575769Z","caller":"traceutil/trace.go:171","msg":"trace[1267522354] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ephemeral-volume-controller; range_end:; response_count:0; response_revision:264; }","duration":"638.329747ms","start":"2026-06-04T15:52:15.937428Z","end":"2026-06-04T15:52:16.575758Z","steps":["trace[1267522354] 'agreement among raft nodes before linearized reading' (duration: 638.273856ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T15:52:16.575681Z","caller":"traceutil/trace.go:171","msg":"trace[595796114] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"1.11184757s","start":"2026-06-04T15:52:15.463796Z","end":"2026-06-04T15:52:16.575643Z","steps":["trace[595796114] 'process raft request' (duration: 770.018885ms)","trace[595796114] 'compare' (duration: 341.384828ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T15:52:16.575821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:15.937412Z","time spent":"638.399857ms","remote":"127.0.0.1:58344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/ephemeral-volume-controller\" "} {"level":"warn","ts":"2026-06-04T15:52:16.575971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:15.463778Z","time spent":"1.112051334s","remote":"127.0.0.1:58334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5321,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T15:52:16.576068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.58084ms","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-06-04T15:52:16.576167Z","caller":"traceutil/trace.go:171","msg":"trace[1006789746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:264; }","duration":"111.734434ms","start":"2026-06-04T15:52:16.46439Z","end":"2026-06-04T15:52:16.576124Z","steps":["trace[1006789746] 'agreement among raft nodes before linearized reading' (duration: 111.54918ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:16.576173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.677632ms","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-06-04T15:52:16.576212Z","caller":"traceutil/trace.go:171","msg":"trace[1835467985] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:264; }","duration":"111.752373ms","start":"2026-06-04T15:52:16.464448Z","end":"2026-06-04T15:52:16.5762Z","steps":["trace[1835467985] 'agreement among raft nodes before linearized reading' (duration: 111.683312ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T15:52:20.337447Z","caller":"traceutil/trace.go:171","msg":"trace[1733185516] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"109.869946ms","start":"2026-06-04T15:52:20.227552Z","end":"2026-06-04T15:52:20.337422Z","steps":["trace[1733185516] 'process raft request' (duration: 109.49863ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T15:52:50.994855Z","caller":"traceutil/trace.go:171","msg":"trace[999573063] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"406.715975ms","start":"2026-06-04T15:52:50.588115Z","end":"2026-06-04T15:52:50.994831Z","steps":["trace[999573063] 'process raft request' (duration: 406.55896ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:50.99499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:50.588095Z","time spent":"406.8346ms","remote":"127.0.0.1:58226","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-06-04T15:52:51.064648Z","caller":"traceutil/trace.go:171","msg":"trace[621819559] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"464.08357ms","start":"2026-06-04T15:52:50.600514Z","end":"2026-06-04T15:52:51.064597Z","steps":["trace[621819559] 'process raft request' (duration: 463.766558ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T15:52:51.064699Z","caller":"traceutil/trace.go:171","msg":"trace[362270982] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"472.157194ms","start":"2026-06-04T15:52:50.592501Z","end":"2026-06-04T15:52:51.064658Z","steps":["trace[362270982] 'process raft request' (duration: 471.515ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T15:52:51.064788Z","caller":"traceutil/trace.go:171","msg":"trace[1869501155] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:508; }","duration":"288.877969ms","start":"2026-06-04T15:52:50.775888Z","end":"2026-06-04T15:52:51.064766Z","steps":["trace[1869501155] 'read index received' (duration: 219.318877ms)","trace[1869501155] 'applied index is now lower than readState.Index' (duration: 69.558022ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T15:52:51.0648Z","caller":"traceutil/trace.go:171","msg":"trace[1728652390] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"465.775154ms","start":"2026-06-04T15:52:50.599012Z","end":"2026-06-04T15:52:51.064787Z","steps":["trace[1728652390] 'process raft request' (duration: 465.16165ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T15:52:51.064849Z","caller":"traceutil/trace.go:171","msg":"trace[1753974263] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"453.528784ms","start":"2026-06-04T15:52:50.611293Z","end":"2026-06-04T15:52:51.064822Z","steps":["trace[1753974263] 'process raft request' (duration: 453.171101ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T15:52:51.064884Z","caller":"traceutil/trace.go:171","msg":"trace[1038464551] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"433.384887ms","start":"2026-06-04T15:52:50.631487Z","end":"2026-06-04T15:52:51.064872Z","steps":["trace[1038464551] 'process raft request' (duration: 433.030274ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T15:52:51.064729Z","caller":"traceutil/trace.go:171","msg":"trace[1096490023] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"466.71558ms","start":"2026-06-04T15:52:50.597973Z","end":"2026-06-04T15:52:51.064688Z","steps":["trace[1096490023] 'process raft request' (duration: 466.155729ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:51.064934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:50.597958Z","time spent":"466.955288ms","remote":"127.0.0.1:58226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-04T15:52:51.064946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:50.599005Z","time spent":"465.855346ms","remote":"127.0.0.1:58226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-04T15:52:51.064943Z","caller":"traceutil/trace.go:171","msg":"trace[1360073611] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"299.839002ms","start":"2026-06-04T15:52:50.765062Z","end":"2026-06-04T15:52:51.064901Z","steps":["trace[1360073611] 'process raft request' (duration: 299.610183ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T15:52:51.065015Z","caller":"traceutil/trace.go:171","msg":"trace[1892042427] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"463.375454ms","start":"2026-06-04T15:52:50.601627Z","end":"2026-06-04T15:52:51.065003Z","steps":["trace[1892042427] 'process raft request' (duration: 462.690877ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:51.064875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:50.592482Z","time spent":"472.31552ms","remote":"127.0.0.1:58226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-04T15:52:51.065108Z","caller":"traceutil/trace.go:171","msg":"trace[1978249498] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"408.137589ms","start":"2026-06-04T15:52:50.656959Z","end":"2026-06-04T15:52:51.065097Z","steps":["trace[1978249498] 'process raft request' (duration: 407.608259ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T15:52:51.06513Z","caller":"traceutil/trace.go:171","msg":"trace[882415503] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"457.802515ms","start":"2026-06-04T15:52:50.607315Z","end":"2026-06-04T15:52:51.065118Z","steps":["trace[882415503] 'process raft request' (duration: 457.034806ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T15:52:51.065134Z","caller":"traceutil/trace.go:171","msg":"trace[169692283] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"456.718134ms","start":"2026-06-04T15:52:50.608406Z","end":"2026-06-04T15:52:51.065125Z","steps":["trace[169692283] 'process raft request' (duration: 456.012177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:51.065175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:50.656939Z","time spent":"408.196181ms","remote":"127.0.0.1:58226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-04T15:52:51.064967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:50.631471Z","time spent":"433.44235ms","remote":"127.0.0.1:58226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-04T15:52:51.065087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:50.601621Z","time spent":"463.433376ms","remote":"127.0.0.1:58226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-04T15:52:51.065295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:50.607305Z","time spent":"457.864396ms","remote":"127.0.0.1:58226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-04T15:52:51.065086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.200842ms","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-06-04T15:52:51.065383Z","caller":"traceutil/trace.go:171","msg":"trace[897673808] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:500; }","duration":"289.528114ms","start":"2026-06-04T15:52:50.775837Z","end":"2026-06-04T15:52:51.065365Z","steps":["trace[897673808] 'agreement among raft nodes before linearized reading' (duration: 289.15692ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:51.06519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:50.608395Z","time spent":"456.776925ms","remote":"127.0.0.1:58226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-04T15:52:51.064946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:50.611272Z","time spent":"453.627498ms","remote":"127.0.0.1:58226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-04T15:52:51.065895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:50.600504Z","time spent":"464.261446ms","remote":"127.0.0.1:58226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-04T15:52:51.201429Z","caller":"traceutil/trace.go:171","msg":"trace[433015150] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"199.455157ms","start":"2026-06-04T15:52:51.00194Z","end":"2026-06-04T15:52:51.201395Z","steps":["trace[433015150] 'process raft request' (duration: 170.962986ms)","trace[433015150] 'compare' (duration: 28.126638ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T15:52:51.201489Z","caller":"traceutil/trace.go:171","msg":"trace[2044514865] linearizableReadLoop","detail":"{readStateIndex:521; appliedIndex:519; }","duration":"136.621338ms","start":"2026-06-04T15:52:51.06484Z","end":"2026-06-04T15:52:51.201462Z","steps":["trace[2044514865] 'read index received' (duration: 108.154387ms)","trace[2044514865] 'applied index is now lower than readState.Index' (duration: 28.465891ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T15:52:51.20161Z","caller":"traceutil/trace.go:171","msg":"trace[693471560] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"197.129751ms","start":"2026-06-04T15:52:51.004458Z","end":"2026-06-04T15:52:51.201588Z","steps":["trace[693471560] 'process raft request' (duration: 196.82908ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:51.201667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.172984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T15:52:51.201725Z","caller":"traceutil/trace.go:171","msg":"trace[272881463] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:502; }","duration":"372.262778ms","start":"2026-06-04T15:52:50.829448Z","end":"2026-06-04T15:52:51.201711Z","steps":["trace[272881463] 'agreement among raft nodes before linearized reading' (duration: 372.194045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:51.201612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.460875ms","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-06-04T15:52:51.201777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:50.829427Z","time spent":"372.337741ms","remote":"127.0.0.1:58176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-04T15:52:51.201793Z","caller":"traceutil/trace.go:171","msg":"trace[2001566196] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:502; }","duration":"413.683484ms","start":"2026-06-04T15:52:50.788085Z","end":"2026-06-04T15:52:51.201768Z","steps":["trace[2001566196] 'agreement among raft nodes before linearized reading' (duration: 413.459135ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:51.202396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:50.788064Z","time spent":"414.309646ms","remote":"127.0.0.1:58402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-04T15:52:51.781323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.870889ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T15:52:51.781586Z","caller":"traceutil/trace.go:171","msg":"trace[2004102061] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"712.064734ms","start":"2026-06-04T15:52:51.069488Z","end":"2026-06-04T15:52:51.781553Z","steps":["trace[2004102061] 'process raft request' (duration: 311.881713ms)","trace[2004102061] 'compare' (duration: 399.731845ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T15:52:51.781745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:51.069466Z","time spent":"712.195179ms","remote":"127.0.0.1:58402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T15:52:51.781881Z","caller":"traceutil/trace.go:171","msg":"trace[1439442736] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"703.087871ms","start":"2026-06-04T15:52:51.078767Z","end":"2026-06-04T15:52:51.781855Z","steps":["trace[1439442736] 'process raft request' (duration: 702.793039ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T15:52:51.78333Z","caller":"traceutil/trace.go:171","msg":"trace[127668435] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"695.393473ms","start":"2026-06-04T15:52:51.087881Z","end":"2026-06-04T15:52:51.783275Z","steps":["trace[127668435] 'process raft request' (duration: 693.891287ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:51.783466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:51.087869Z","time spent":"695.531189ms","remote":"127.0.0.1:58226","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-06-04T15:52:51.784075Z","caller":"traceutil/trace.go:171","msg":"trace[674074632] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"704.891087ms","start":"2026-06-04T15:52:51.079162Z","end":"2026-06-04T15:52:51.784054Z","steps":["trace[674074632] 'process raft request' (duration: 702.452197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:51.784176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:51.079155Z","time spent":"704.96942ms","remote":"127.0.0.1:58634","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-06-04T15:52:51.784921Z","caller":"traceutil/trace.go:171","msg":"trace[500545208] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"702.696936ms","start":"2026-06-04T15:52:51.082193Z","end":"2026-06-04T15:52:51.78489Z","steps":["trace[500545208] 'process raft request' (duration: 699.465205ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:51.785025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:51.082176Z","time spent":"702.79405ms","remote":"127.0.0.1:58226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T15:52:51.787583Z","caller":"traceutil/trace.go:171","msg":"trace[1641985842] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"701.874805ms","start":"2026-06-04T15:52:51.085687Z","end":"2026-06-04T15:52:51.787561Z","steps":["trace[1641985842] 'process raft request' (duration: 696.035588ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:51.787686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:51.085671Z","time spent":"701.973419ms","remote":"127.0.0.1:58634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-04T15:52:51.782605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:51.07875Z","time spent":"703.204885ms","remote":"127.0.0.1:58226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T15:52:51.789339Z","caller":"traceutil/trace.go:171","msg":"trace[810443759] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"714.524036ms","start":"2026-06-04T15:52:51.074742Z","end":"2026-06-04T15:52:51.789266Z","steps":["trace[810443759] 'process raft request' (duration: 706.760837ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:51.789409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:51.074738Z","time spent":"714.64251ms","remote":"127.0.0.1:58634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-04T15:52:51.789502Z","caller":"traceutil/trace.go:171","msg":"trace[439620068] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"218.694764ms","start":"2026-06-04T15:52:51.57079Z","end":"2026-06-04T15:52:51.789485Z","steps":["trace[439620068] 'process raft request' (duration: 218.309829ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T15:52:51.789637Z","caller":"traceutil/trace.go:171","msg":"trace[39133567] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"714.827817ms","start":"2026-06-04T15:52:51.074684Z","end":"2026-06-04T15:52:51.789511Z","steps":["trace[39133567] 'process raft request' (duration: 706.735126ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:51.7897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:51.074675Z","time spent":"714.994053ms","remote":"127.0.0.1:58634","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-06-04T15:52:51.79008Z","caller":"traceutil/trace.go:171","msg":"trace[1090525252] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"579.074432ms","start":"2026-06-04T15:52:51.210992Z","end":"2026-06-04T15:52:51.790067Z","steps":["trace[1090525252] 'process raft request' (duration: 576.076211ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T15:52:51.790122Z","caller":"traceutil/trace.go:171","msg":"trace[1638671736] linearizableReadLoop","detail":"{readStateIndex:532; appliedIndex:521; }","duration":"587.291898ms","start":"2026-06-04T15:52:51.202768Z","end":"2026-06-04T15:52:51.790059Z","steps":["trace[1638671736] 'read index received' (duration: 178.731045ms)","trace[1638671736] 'applied index is now lower than readState.Index' (duration: 408.129437ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T15:52:51.79034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:51.210978Z","time spent":"579.131204ms","remote":"127.0.0.1:58402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T15:52:51.791527Z","caller":"traceutil/trace.go:171","msg":"trace[1067251988] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"702.991697ms","start":"2026-06-04T15:52:51.088522Z","end":"2026-06-04T15:52:51.791514Z","steps":["trace[1067251988] 'process raft request' (duration: 693.325877ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:51.791582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:51.088516Z","time spent":"703.038278ms","remote":"127.0.0.1:58226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T15:52:51.791826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.058673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T15:52:51.791851Z","caller":"traceutil/trace.go:171","msg":"trace[2145104171] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:516; }","duration":"589.121997ms","start":"2026-06-04T15:52:51.202722Z","end":"2026-06-04T15:52:51.791844Z","steps":["trace[2145104171] 'agreement among raft nodes before linearized reading' (duration: 587.493646ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:51.79187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:51.202705Z","time spent":"589.161069ms","remote":"127.0.0.1:58182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-04T15:52:51.792003Z","caller":"traceutil/trace.go:171","msg":"trace[1537180412] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"696.410771ms","start":"2026-06-04T15:52:51.095584Z","end":"2026-06-04T15:52:51.791995Z","steps":["trace[1537180412] 'process raft request' (duration: 688.449325ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:51.792062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:51.095576Z","time spent":"696.464242ms","remote":"127.0.0.1:58226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T15:52:51.792116Z","caller":"traceutil/trace.go:171","msg":"trace[2058048138] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"660.39549ms","start":"2026-06-04T15:52:51.129849Z","end":"2026-06-04T15:52:51.790244Z","steps":["trace[2058048138] 'process raft request' (duration: 656.822057ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:51.792141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:51.129824Z","time spent":"662.303651ms","remote":"127.0.0.1:58226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-04T15:52:51.792218Z","caller":"traceutil/trace.go:171","msg":"trace[453035819] transaction","detail":"{read_only:false; number_of_response:1; response_revision:515; }","duration":"580.867449ms","start":"2026-06-04T15:52:51.211345Z","end":"2026-06-04T15:52:51.792212Z","steps":["trace[453035819] 'process raft request' (duration: 577.452842ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:51.792251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:51.211334Z","time spent":"580.897ms","remote":"127.0.0.1:58226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":101,"response count":0,"response size":10112,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T15:52:51.792373Z","caller":"traceutil/trace.go:171","msg":"trace[1530404792] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"581.323037ms","start":"2026-06-04T15:52:51.211043Z","end":"2026-06-04T15:52:51.792366Z","steps":["trace[1530404792] 'process raft request' (duration: 577.148281ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:51.792408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:51.211025Z","time spent":"581.364277ms","remote":"127.0.0.1:58226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T15:52:51.792789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.340123ms","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-06-04T15:52:51.792824Z","caller":"traceutil/trace.go:171","msg":"trace[1509630656] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:516; }","duration":"358.417726ms","start":"2026-06-04T15:52:51.434398Z","end":"2026-06-04T15:52:51.792815Z","steps":["trace[1509630656] 'agreement among raft nodes before linearized reading' (duration: 358.28647ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:51.792846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:51.434375Z","time spent":"358.465698ms","remote":"127.0.0.1:58402","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-06-04T15:52:51.793025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.971744ms","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-06-04T15:52:51.793045Z","caller":"traceutil/trace.go:171","msg":"trace[725451994] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:516; }","duration":"320.031666ms","start":"2026-06-04T15:52:51.473007Z","end":"2026-06-04T15:52:51.793039Z","steps":["trace[725451994] 'agreement among raft nodes before linearized reading' (duration: 319.991974ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:51.793061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:51.472986Z","time spent":"320.071428ms","remote":"127.0.0.1:58402","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-06-04T15:52:58.087779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.094748ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T15:52:58.087905Z","caller":"traceutil/trace.go:171","msg":"trace[1306283338] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"248.327128ms","start":"2026-06-04T15:52:57.839562Z","end":"2026-06-04T15:52:58.087889Z","steps":["trace[1306283338] 'read index received' (duration: 41.019913ms)","trace[1306283338] 'applied index is now lower than readState.Index' (duration: 207.306185ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T15:52:58.088005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.447562ms","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-06-04T15:52:58.087995Z","caller":"traceutil/trace.go:171","msg":"trace[1688533030] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"267.231578ms","start":"2026-06-04T15:52:57.820737Z","end":"2026-06-04T15:52:58.087969Z","steps":["trace[1688533030] 'process raft request' (duration: 59.858069ms)","trace[1688533030] 'compare' (duration: 206.972614ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T15:52:58.088051Z","caller":"traceutil/trace.go:171","msg":"trace[126678753] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:599; }","duration":"248.541354ms","start":"2026-06-04T15:52:57.839498Z","end":"2026-06-04T15:52:58.08804Z","steps":["trace[126678753] 'agreement among raft nodes before linearized reading' (duration: 248.453322ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T15:52:58.135909Z","caller":"traceutil/trace.go:171","msg":"trace[1267589972] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"220.632523ms","start":"2026-06-04T15:52:57.915259Z","end":"2026-06-04T15:52:58.135892Z","steps":["trace[1267589972] 'process raft request' (duration: 219.737271ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:58.967649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.172017ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-04T15:52:58.968084Z","caller":"traceutil/trace.go:171","msg":"trace[1629446881] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"769.513175ms","start":"2026-06-04T15:52:58.198549Z","end":"2026-06-04T15:52:58.968062Z","steps":["trace[1629446881] 'process raft request' (duration: 769.446992ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:58.968228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:58.198523Z","time spent":"769.629499ms","remote":"127.0.0.1:58376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-04T15:52:58.968856Z","caller":"traceutil/trace.go:171","msg":"trace[1278753825] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"876.866885ms","start":"2026-06-04T15:52:58.091976Z","end":"2026-06-04T15:52:58.968843Z","steps":["trace[1278753825] 'process raft request' (duration: 875.831018ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:58.968964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:58.091954Z","time spent":"876.944518ms","remote":"127.0.0.1:58402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T15:52:58.969107Z","caller":"traceutil/trace.go:171","msg":"trace[255237177] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:621; }","duration":"881.099424ms","start":"2026-06-04T15:52:58.08793Z","end":"2026-06-04T15:52:58.96903Z","steps":["trace[255237177] 'read index received' (duration: 46.767623ms)","trace[255237177] 'applied index is now lower than readState.Index' (duration: 834.32725ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T15:52:58.969322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.123103817s","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-06-04T15:52:58.969355Z","caller":"traceutil/trace.go:171","msg":"trace[976220278] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:602; }","duration":"1.123190011s","start":"2026-06-04T15:52:57.846156Z","end":"2026-06-04T15:52:58.969346Z","steps":["trace[976220278] 'agreement among raft nodes before linearized reading' (duration: 1.123061876s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:58.969331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.873067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-04T15:52:58.969386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:57.846148Z","time spent":"1.123231703s","remote":"127.0.0.1:58402","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-06-04T15:52:58.969393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.753376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-g4h4n\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-04T15:52:58.969408Z","caller":"traceutil/trace.go:171","msg":"trace[2078677881] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:602; }","duration":"139.007563ms","start":"2026-06-04T15:52:58.830377Z","end":"2026-06-04T15:52:58.969384Z","steps":["trace[2078677881] 'agreement among raft nodes before linearized reading' (duration: 138.884418ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T15:52:58.969435Z","caller":"traceutil/trace.go:171","msg":"trace[1248662336] range","detail":"{range_begin:/registry/pods/kube-system/cilium-g4h4n; range_end:; response_count:1; response_revision:602; }","duration":"451.841668ms","start":"2026-06-04T15:52:58.517581Z","end":"2026-06-04T15:52:58.969423Z","steps":["trace[1248662336] 'agreement among raft nodes before linearized reading' (duration: 451.671322ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:52:58.969481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T15:52:58.517553Z","time spent":"451.920411ms","remote":"127.0.0.1:58334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-g4h4n\" "} {"level":"warn","ts":"2026-06-04T15:53:14.026516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.156485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T15:53:14.026664Z","caller":"traceutil/trace.go:171","msg":"trace[1719929681] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:763; }","duration":"197.342621ms","start":"2026-06-04T15:53:13.829285Z","end":"2026-06-04T15:53:14.026628Z","steps":["trace[1719929681] 'range keys from in-memory index tree' (duration: 197.045452ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T15:53:14.026804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.875993ms","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-06-04T15:53:14.026897Z","caller":"traceutil/trace.go:171","msg":"trace[700078813] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:763; }","duration":"132.035877ms","start":"2026-06-04T15:53:13.894842Z","end":"2026-06-04T15:53:14.026878Z","steps":["trace[700078813] 'range keys from in-memory index tree' (duration: 131.669755ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T15:55:06.771419Z","caller":"traceutil/trace.go:171","msg":"trace[405876949] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"102.619948ms","start":"2026-06-04T15:55:06.668772Z","end":"2026-06-04T15:55:06.771392Z","steps":["trace[405876949] 'process raft request' (duration: 52.1874ms)","trace[405876949] 'compare' (duration: 50.339516ms)"],"step_count":2}