{"level":"warn","ts":"2026-06-25T22:14:51.132769Z","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-25T22:14:51.132863Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248: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.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248: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-25T22:14:51.132984Z","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-25T22:14:51.133003Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-06-25T22:14:51.133027Z","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-25T22:14:51.134812Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]} {"level":"info","ts":"2026-06-25T22:14:51.134891Z","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.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248: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-25T22:14:51.162711Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"27.593917ms"} {"level":"info","ts":"2026-06-25T22:14:51.210608Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"} {"level":"info","ts":"2026-06-25T22:14:51.210687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"} {"level":"info","ts":"2026-06-25T22:14:51.210707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"} {"level":"info","ts":"2026-06-25T22:14:51.210717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-25T22:14:51.210728Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"} {"level":"info","ts":"2026-06-25T22:14:51.210757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"warn","ts":"2026-06-25T22:14:51.278234Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-25T22:14:51.293997Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-25T22:14:51.304762Z","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-25T22:14:51.317008Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-25T22:14:51.317179Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-25T22:14:51.317607Z","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-25T22:14:51.319591Z","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-25T22:14:51.319654Z","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-25T22:14:51.32279Z","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-25T22:14:51.323081Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-25T22:14:51.323152Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-25T22:14:51.323704Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-06-25T22:14:51.323729Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-06-25T22:14:51.323975Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"info","ts":"2026-06-25T22:14:51.324061Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-06-25T22:14:51.714522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"} {"level":"info","ts":"2026-06-25T22:14:51.714566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-25T22:14:51.714593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"} {"level":"info","ts":"2026-06-25T22:14:51.714605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"} {"level":"info","ts":"2026-06-25T22:14:51.71461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-06-25T22:14:51.714619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"} {"level":"info","ts":"2026-06-25T22:14:51.714626Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-06-25T22:14:51.746738Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"} {"level":"info","ts":"2026-06-25T22:14:51.746768Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-25T22:14:51.746904Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-25T22:14:51.747105Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-25T22:14:51.747185Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-25T22:14:51.748024Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-25T22:14:51.751723Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-25T22:14:51.752613Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"} {"level":"info","ts":"2026-06-25T22:14:51.761317Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"} {"level":"info","ts":"2026-06-25T22:14:51.761526Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-25T22:14:51.761676Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-25T22:14:53.364198Z","caller":"traceutil/trace.go:171","msg":"trace[1359545261] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"240.742504ms","start":"2026-06-25T22:14:53.123418Z","end":"2026-06-25T22:14:53.36416Z","steps":["trace[1359545261] 'process raft request' (duration: 240.618551ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:53.364147Z","caller":"traceutil/trace.go:171","msg":"trace[623031771] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"312.204373ms","start":"2026-06-25T22:14:53.051875Z","end":"2026-06-25T22:14:53.36408Z","steps":["trace[623031771] 'process raft request' (duration: 293.742142ms)","trace[623031771] 'compare' (duration: 18.257246ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:14:53.364425Z","caller":"traceutil/trace.go:171","msg":"trace[1025035304] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"311.270329ms","start":"2026-06-25T22:14:53.053136Z","end":"2026-06-25T22:14:53.364406Z","steps":["trace[1025035304] 'read index received' (duration: 90.212478ms)","trace[1025035304] 'applied index is now lower than readState.Index' (duration: 221.056931ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:14:53.364537Z","caller":"traceutil/trace.go:171","msg":"trace[411764815] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"224.121481ms","start":"2026-06-25T22:14:53.140403Z","end":"2026-06-25T22:14:53.364524Z","steps":["trace[411764815] 'process raft request' (duration: 223.808283ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:53.364757Z","caller":"traceutil/trace.go:171","msg":"trace[1172584764] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"221.712109ms","start":"2026-06-25T22:14:53.143016Z","end":"2026-06-25T22:14:53.364728Z","steps":["trace[1172584764] 'process raft request' (duration: 221.355719ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:53.364888Z","caller":"traceutil/trace.go:171","msg":"trace[34665309] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"225.969879ms","start":"2026-06-25T22:14:53.138852Z","end":"2026-06-25T22:14:53.364822Z","steps":["trace[34665309] 'process raft request' (duration: 225.294682ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:53.365012Z","caller":"traceutil/trace.go:171","msg":"trace[801185871] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"222.262303ms","start":"2026-06-25T22:14:53.142712Z","end":"2026-06-25T22:14:53.364974Z","steps":["trace[801185871] 'process raft request' (duration: 221.625527ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:53.364894Z","caller":"traceutil/trace.go:171","msg":"trace[594580421] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"227.640533ms","start":"2026-06-25T22:14:53.137159Z","end":"2026-06-25T22:14:53.364799Z","steps":["trace[594580421] 'process raft request' (duration: 226.917074ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:53.365229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.272999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-25T22:14:53.365285Z","caller":"traceutil/trace.go:171","msg":"trace[1403379231] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"228.392823ms","start":"2026-06-25T22:14:53.136881Z","end":"2026-06-25T22:14:53.365274Z","steps":["trace[1403379231] 'agreement among raft nodes before linearized reading' (duration: 228.211418ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:53.365408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.728157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-25T22:14:53.365439Z","caller":"traceutil/trace.go:171","msg":"trace[1391380315] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"224.778069ms","start":"2026-06-25T22:14:53.14065Z","end":"2026-06-25T22:14:53.365428Z","steps":["trace[1391380315] 'agreement among raft nodes before linearized reading' (duration: 224.739948ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:53.365517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.23804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-25T22:14:53.365634Z","caller":"traceutil/trace.go:171","msg":"trace[487654121] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"175.331272ms","start":"2026-06-25T22:14:53.190255Z","end":"2026-06-25T22:14:53.365587Z","steps":["trace[487654121] 'agreement among raft nodes before linearized reading' (duration: 175.174308ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:53.365657Z","caller":"traceutil/trace.go:171","msg":"trace[1104122648] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"224.474991ms","start":"2026-06-25T22:14:53.141173Z","end":"2026-06-25T22:14:53.365648Z","steps":["trace[1104122648] 'process raft request' (duration: 223.068344ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:53.365687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.556371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-25T22:14:53.3657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.581753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-06-25T22:14:53.365739Z","caller":"traceutil/trace.go:171","msg":"trace[75735211] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"262.631214ms","start":"2026-06-25T22:14:53.103096Z","end":"2026-06-25T22:14:53.365727Z","steps":["trace[75735211] 'agreement among raft nodes before linearized reading' (duration: 262.559112ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:53.36575Z","caller":"traceutil/trace.go:171","msg":"trace[1717213826] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"312.655115ms","start":"2026-06-25T22:14:53.053081Z","end":"2026-06-25T22:14:53.365736Z","steps":["trace[1717213826] 'agreement among raft nodes before linearized reading' (duration: 312.555912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:53.365843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.401359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-25T22:14:53.36585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.818849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-25T22:14:53.365817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:14:53.053071Z","time spent":"312.723196ms","remote":"127.0.0.1:34638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3194,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-06-25T22:14:53.365873Z","caller":"traceutil/trace.go:171","msg":"trace[1633556116] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:0; response_revision:11; }","duration":"244.46536ms","start":"2026-06-25T22:14:53.121401Z","end":"2026-06-25T22:14:53.365866Z","steps":["trace[1633556116] 'agreement among raft nodes before linearized reading' (duration: 244.412799ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:53.365878Z","caller":"traceutil/trace.go:171","msg":"trace[167775764] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"262.869209ms","start":"2026-06-25T22:14:53.103001Z","end":"2026-06-25T22:14:53.36587Z","steps":["trace[167775764] 'agreement among raft nodes before linearized reading' (duration: 262.820598ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:53.364951Z","caller":"traceutil/trace.go:171","msg":"trace[1028222885] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"222.883289ms","start":"2026-06-25T22:14:53.142038Z","end":"2026-06-25T22:14:53.364921Z","steps":["trace[1028222885] 'process raft request' (duration: 222.268113ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:53.36687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.42283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-25T22:14:53.366899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:14:53.051862Z","time spent":"312.481441ms","remote":"127.0.0.1:34528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-25T22:14:53.366961Z","caller":"traceutil/trace.go:171","msg":"trace[1153208926] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"264.538753ms","start":"2026-06-25T22:14:53.102393Z","end":"2026-06-25T22:14:53.366932Z","steps":["trace[1153208926] 'agreement among raft nodes before linearized reading' (duration: 262.424768ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:53.500316Z","caller":"traceutil/trace.go:171","msg":"trace[428633019] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"129.248703ms","start":"2026-06-25T22:14:53.371038Z","end":"2026-06-25T22:14:53.500287Z","steps":["trace[428633019] 'process raft request' (duration: 129.14692ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:53.500488Z","caller":"traceutil/trace.go:171","msg":"trace[1249896617] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"128.00398ms","start":"2026-06-25T22:14:53.372453Z","end":"2026-06-25T22:14:53.500457Z","steps":["trace[1249896617] 'process raft request' (duration: 127.856117ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:53.500568Z","caller":"traceutil/trace.go:171","msg":"trace[1904051261] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"129.108659ms","start":"2026-06-25T22:14:53.371451Z","end":"2026-06-25T22:14:53.50056Z","steps":["trace[1904051261] 'process raft request' (duration: 128.809761ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:53.500619Z","caller":"traceutil/trace.go:171","msg":"trace[766257396] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"127.158288ms","start":"2026-06-25T22:14:53.373452Z","end":"2026-06-25T22:14:53.500611Z","steps":["trace[766257396] 'process raft request' (duration: 126.890691ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:53.500639Z","caller":"traceutil/trace.go:171","msg":"trace[1993733793] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"129.472649ms","start":"2026-06-25T22:14:53.371159Z","end":"2026-06-25T22:14:53.500631Z","steps":["trace[1993733793] 'process raft request' (duration: 129.056268ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:53.500517Z","caller":"traceutil/trace.go:171","msg":"trace[55083383] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"130.196578ms","start":"2026-06-25T22:14:53.370309Z","end":"2026-06-25T22:14:53.500505Z","steps":["trace[55083383] 'process raft request' (duration: 114.044777ms)","trace[55083383] 'compare' (duration: 15.717379ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:14:53.500809Z","caller":"traceutil/trace.go:171","msg":"trace[1883464071] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"121.488761ms","start":"2026-06-25T22:14:53.379314Z","end":"2026-06-25T22:14:53.500803Z","steps":["trace[1883464071] 'process raft request' (duration: 121.05626ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:53.50086Z","caller":"traceutil/trace.go:171","msg":"trace[841446499] transaction","detail":"{read_only:false; number_of_response:0; response_revision:15; }","duration":"129.429467ms","start":"2026-06-25T22:14:53.371415Z","end":"2026-06-25T22:14:53.500844Z","steps":["trace[841446499] 'process raft request' (duration: 128.825432ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:53.500912Z","caller":"traceutil/trace.go:171","msg":"trace[2044438193] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"129.240403ms","start":"2026-06-25T22:14:53.371658Z","end":"2026-06-25T22:14:53.500899Z","steps":["trace[2044438193] 'process raft request' (duration: 128.629007ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:53.501117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.724855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-wpxx9\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-06-25T22:14:53.501146Z","caller":"traceutil/trace.go:171","msg":"trace[1846406743] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-wpxx9; range_end:; response_count:1; response_revision:21; }","duration":"129.779237ms","start":"2026-06-25T22:14:53.37136Z","end":"2026-06-25T22:14:53.501139Z","steps":["trace[1846406743] 'agreement among raft nodes before linearized reading' (duration: 129.713495ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:53.789965Z","caller":"traceutil/trace.go:171","msg":"trace[832515072] transaction","detail":"{read_only:false; response_revision:46; number_of_response:1; }","duration":"158.853174ms","start":"2026-06-25T22:14:53.631087Z","end":"2026-06-25T22:14:53.789941Z","steps":["trace[832515072] 'process raft request' (duration: 106.108141ms)","trace[832515072] 'compare' (duration: 52.560868ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:14:53.790106Z","caller":"traceutil/trace.go:171","msg":"trace[1097716742] transaction","detail":"{read_only:false; response_revision:47; number_of_response:1; }","duration":"147.760225ms","start":"2026-06-25T22:14:53.642329Z","end":"2026-06-25T22:14:53.790089Z","steps":["trace[1097716742] 'process raft request' (duration: 147.538799ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:54.147005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.845818ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-25T22:14:54.147254Z","caller":"traceutil/trace.go:171","msg":"trace[563058942] linearizableReadLoop","detail":"{readStateIndex:72; appliedIndex:70; }","duration":"124.14045ms","start":"2026-06-25T22:14:54.023092Z","end":"2026-06-25T22:14:54.147233Z","steps":["trace[563058942] 'read index received' (duration: 22.771159ms)","trace[563058942] 'applied index is now lower than readState.Index' (duration: 101.367831ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:14:54.147403Z","caller":"traceutil/trace.go:171","msg":"trace[1965518803] transaction","detail":"{read_only:false; response_revision:67; number_of_response:1; }","duration":"171.267112ms","start":"2026-06-25T22:14:53.976117Z","end":"2026-06-25T22:14:54.147384Z","steps":["trace[1965518803] 'process raft request' (duration: 69.761887ms)","trace[1965518803] 'compare' (duration: 100.677444ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:14:54.147518Z","caller":"traceutil/trace.go:171","msg":"trace[43813509] transaction","detail":"{read_only:false; response_revision:68; number_of_response:1; }","duration":"129.132579ms","start":"2026-06-25T22:14:54.018355Z","end":"2026-06-25T22:14:54.147487Z","steps":["trace[43813509] 'process raft request' (duration: 128.769649ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:54.147607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.249872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-25T22:14:54.147639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.55039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-25T22:14:54.147651Z","caller":"traceutil/trace.go:171","msg":"trace[29474689] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:68; }","duration":"124.340605ms","start":"2026-06-25T22:14:54.023297Z","end":"2026-06-25T22:14:54.147638Z","steps":["trace[29474689] 'agreement among raft nodes before linearized reading' (duration: 124.264823ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:54.147678Z","caller":"traceutil/trace.go:171","msg":"trace[1618302466] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:68; }","duration":"124.628792ms","start":"2026-06-25T22:14:54.023037Z","end":"2026-06-25T22:14:54.147666Z","steps":["trace[1618302466] 'agreement among raft nodes before linearized reading' (duration: 124.502189ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:54.57013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.787176ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-25T22:14:54.570231Z","caller":"traceutil/trace.go:171","msg":"trace[1772279493] transaction","detail":"{read_only:false; response_revision:79; number_of_response:1; }","duration":"169.383109ms","start":"2026-06-25T22:14:54.400832Z","end":"2026-06-25T22:14:54.570215Z","steps":["trace[1772279493] 'compare' (duration: 158.657912ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:54.593627Z","caller":"traceutil/trace.go:171","msg":"trace[501330972] linearizableReadLoop","detail":"{readStateIndex:84; appliedIndex:83; }","duration":"171.154425ms","start":"2026-06-25T22:14:54.422446Z","end":"2026-06-25T22:14:54.593601Z","steps":["trace[501330972] 'read index received' (duration: 170.915808ms)","trace[501330972] 'applied index is now lower than readState.Index' (duration: 237.307µs)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:14:54.593689Z","caller":"traceutil/trace.go:171","msg":"trace[1043438405] transaction","detail":"{read_only:false; response_revision:80; number_of_response:1; }","duration":"182.644592ms","start":"2026-06-25T22:14:54.41102Z","end":"2026-06-25T22:14:54.593664Z","steps":["trace[1043438405] 'process raft request' (duration: 182.466838ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:54.593809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.365521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-25T22:14:54.593864Z","caller":"traceutil/trace.go:171","msg":"trace[498439027] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:80; }","duration":"171.457793ms","start":"2026-06-25T22:14:54.422395Z","end":"2026-06-25T22:14:54.593853Z","steps":["trace[498439027] 'agreement among raft nodes before linearized reading' (duration: 171.34148ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:54.851407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.698399ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-25T22:14:54.851494Z","caller":"traceutil/trace.go:171","msg":"trace[348939105] transaction","detail":"{read_only:false; response_revision:81; number_of_response:1; }","duration":"254.091169ms","start":"2026-06-25T22:14:54.597389Z","end":"2026-06-25T22:14:54.85148Z","steps":["trace[348939105] 'process raft request' (duration: 135.193315ms)","trace[348939105] 'compare' (duration: 118.526374ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:14:55.198975Z","caller":"traceutil/trace.go:171","msg":"trace[2043385834] transaction","detail":"{read_only:false; response_revision:91; number_of_response:1; }","duration":"129.828266ms","start":"2026-06-25T22:14:55.069107Z","end":"2026-06-25T22:14:55.198935Z","steps":["trace[2043385834] 'process raft request' (duration: 43.793555ms)","trace[2043385834] 'compare' (duration: 85.832965ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:14:55.436735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.946484ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-25T22:14:55.436938Z","caller":"traceutil/trace.go:171","msg":"trace[1220346062] transaction","detail":"{read_only:false; response_revision:96; number_of_response:1; }","duration":"154.172601ms","start":"2026-06-25T22:14:55.282738Z","end":"2026-06-25T22:14:55.43691Z","steps":["trace[1220346062] 'process raft request' (duration: 52.980501ms)","trace[1220346062] 'compare' (duration: 100.780959ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:14:55.86981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.43766ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-25T22:14:55.869972Z","caller":"traceutil/trace.go:171","msg":"trace[1454480623] linearizableReadLoop","detail":"{readStateIndex:101; appliedIndex:100; }","duration":"348.004351ms","start":"2026-06-25T22:14:55.521944Z","end":"2026-06-25T22:14:55.869949Z","steps":["trace[1454480623] 'read index received' (duration: 31.226292ms)","trace[1454480623] 'applied index is now lower than readState.Index' (duration: 316.776559ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:14:55.870045Z","caller":"traceutil/trace.go:171","msg":"trace[1063892606] transaction","detail":"{read_only:false; response_revision:97; number_of_response:1; }","duration":"428.416418ms","start":"2026-06-25T22:14:55.441598Z","end":"2026-06-25T22:14:55.870007Z","steps":["trace[1063892606] 'process raft request' (duration: 111.663419ms)","trace[1063892606] 'compare' (duration: 316.201524ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:14:55.870141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.185495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-25T22:14:55.870216Z","caller":"traceutil/trace.go:171","msg":"trace[67904546] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:97; }","duration":"348.296068ms","start":"2026-06-25T22:14:55.521898Z","end":"2026-06-25T22:14:55.870194Z","steps":["trace[67904546] 'agreement among raft nodes before linearized reading' (duration: 348.120154ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:55.870222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:14:55.441572Z","time spent":"428.53375ms","remote":"127.0.0.1:34774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":705,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-25T22:14:55.870258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:14:55.521878Z","time spent":"348.369561ms","remote":"127.0.0.1:34470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-25T22:14:55.87101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.664528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-25T22:14:55.87108Z","caller":"traceutil/trace.go:171","msg":"trace[386089279] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:97; }","duration":"334.776651ms","start":"2026-06-25T22:14:55.536283Z","end":"2026-06-25T22:14:55.87106Z","steps":["trace[386089279] 'agreement among raft nodes before linearized reading' (duration: 333.810347ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:55.871135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:14:55.536266Z","time spent":"334.855123ms","remote":"127.0.0.1:34714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-25T22:14:56.204309Z","caller":"traceutil/trace.go:171","msg":"trace[1989360759] transaction","detail":"{read_only:false; response_revision:98; number_of_response:1; }","duration":"329.74364ms","start":"2026-06-25T22:14:55.874527Z","end":"2026-06-25T22:14:56.204271Z","steps":["trace[1989360759] 'process raft request' (duration: 246.065314ms)","trace[1989360759] 'compare' (duration: 83.486761ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:14:56.204521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:14:55.87451Z","time spent":"329.885203ms","remote":"127.0.0.1:34714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-25T22:14:58.222456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000417961s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-25T22:14:58.222634Z","caller":"traceutil/trace.go:171","msg":"trace[1259288702] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000640287s","start":"2026-06-25T22:14:56.221968Z","end":"2026-06-25T22:14:58.222608Z","steps":["trace[1259288702] 'agreement among raft nodes before linearized reading' (duration: 2.000445352s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:58.2227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:14:56.221951Z","time spent":"2.000734289s","remote":"127.0.0.1:34458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/25 22:14:58 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-25T22:14:58.594108Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.513476036s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-25T22:14:58.682633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.001127516s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-25T22:14:58.682875Z","caller":"traceutil/trace.go:171","msg":"trace[993872691] transaction","detail":"{read_only:false; response_revision:99; number_of_response:1; }","duration":"2.80148469s","start":"2026-06-25T22:14:55.881348Z","end":"2026-06-25T22:14:58.682832Z","steps":["trace[993872691] 'process raft request' (duration: 800.078277ms)","trace[993872691] 'compare' (duration: 2.000319476s)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:14:58.682915Z","caller":"traceutil/trace.go:171","msg":"trace[1673294807] transaction","detail":"{read_only:false; response_revision:101; number_of_response:1; }","duration":"1.602425239s","start":"2026-06-25T22:14:57.08047Z","end":"2026-06-25T22:14:58.682895Z","steps":["trace[1673294807] 'process raft request' (duration: 1.602387958s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:58.682978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:14:57.080441Z","time spent":"1.602513191s","remote":"127.0.0.1:34640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-25T22:14:58.682994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:14:55.881337Z","time spent":"2.801599784s","remote":"127.0.0.1:34774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":710,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-25T22:14:58.683366Z","caller":"traceutil/trace.go:171","msg":"trace[190629070] transaction","detail":"{read_only:false; response_revision:100; number_of_response:1; }","duration":"2.793214999s","start":"2026-06-25T22:14:55.890137Z","end":"2026-06-25T22:14:58.683352Z","steps":["trace[190629070] 'process raft request' (duration: 2.792599743s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:58.683432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:14:55.890098Z","time spent":"2.793296381s","remote":"127.0.0.1:34640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4649,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-25T22:14:58.683553Z","caller":"traceutil/trace.go:171","msg":"trace[620547939] linearizableReadLoop","detail":"{readStateIndex:104; appliedIndex:102; }","duration":"2.473906297s","start":"2026-06-25T22:14:56.209637Z","end":"2026-06-25T22:14:58.683544Z","steps":["trace[620547939] 'read index received' (duration: 471.819337ms)","trace[620547939] 'applied index is now lower than readState.Index' (duration: 2.00208607s)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:14:58.68367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.47403836s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-25T22:14:58.6837Z","caller":"traceutil/trace.go:171","msg":"trace[254985265] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:101; }","duration":"2.474121592s","start":"2026-06-25T22:14:56.20957Z","end":"2026-06-25T22:14:58.683691Z","steps":["trace[254985265] 'agreement among raft nodes before linearized reading' (duration: 2.474064991s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:58.683728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:14:56.209547Z","time spent":"2.474174554s","remote":"127.0.0.1:34714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-25T22:14:58.683865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.334605201s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-25T22:14:58.68389Z","caller":"traceutil/trace.go:171","msg":"trace[1792140782] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:101; }","duration":"2.334667853s","start":"2026-06-25T22:14:56.349214Z","end":"2026-06-25T22:14:58.683882Z","steps":["trace[1792140782] 'agreement among raft nodes before linearized reading' (duration: 2.334629942s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:58.683915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:14:56.349194Z","time spent":"2.334715314s","remote":"127.0.0.1:34714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-25T22:14:58.683996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.201303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-25T22:14:58.684018Z","caller":"traceutil/trace.go:171","msg":"trace[539910902] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:101; }","duration":"461.262574ms","start":"2026-06-25T22:14:58.222748Z","end":"2026-06-25T22:14:58.684011Z","steps":["trace[539910902] 'agreement among raft nodes before linearized reading' (duration: 461.231043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:58.684042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:14:58.222722Z","time spent":"461.314195ms","remote":"127.0.0.1:34470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-25T22:14:58.684176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.413501874s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-25T22:14:58.684205Z","caller":"traceutil/trace.go:171","msg":"trace[1241213726] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:101; }","duration":"1.413569757s","start":"2026-06-25T22:14:57.270624Z","end":"2026-06-25T22:14:58.684194Z","steps":["trace[1241213726] 'agreement among raft nodes before linearized reading' (duration: 1.413533206s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:58.684233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:14:57.270604Z","time spent":"1.413622938s","remote":"127.0.0.1:34458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-25T22:14:59.222968Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415873668384049940,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-25T22:14:59.723959Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415873668384049940,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-25T22:14:59.832746Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.144078539s","expected-duration":"1s"} {"level":"info","ts":"2026-06-25T22:14:59.852274Z","caller":"traceutil/trace.go:171","msg":"trace[1614509841] transaction","detail":"{read_only:false; response_revision:102; number_of_response:1; }","duration":"1.16365925s","start":"2026-06-25T22:14:58.688584Z","end":"2026-06-25T22:14:59.852243Z","steps":["trace[1614509841] 'process raft request' (duration: 1.144333986s)","trace[1614509841] 'compare' (duration: 19.17211ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:14:59.85256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:14:58.688561Z","time spent":"1.163784054s","remote":"127.0.0.1:34714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-25T22:14:59.858585Z","caller":"traceutil/trace.go:171","msg":"trace[664848605] transaction","detail":"{read_only:false; response_revision:103; number_of_response:1; }","duration":"1.169574849s","start":"2026-06-25T22:14:58.688971Z","end":"2026-06-25T22:14:59.858546Z","steps":["trace[664848605] 'process raft request' (duration: 1.169310152s)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:59.858662Z","caller":"traceutil/trace.go:171","msg":"trace[1361050016] transaction","detail":"{read_only:false; response_revision:104; number_of_response:1; }","duration":"1.168953963s","start":"2026-06-25T22:14:58.689683Z","end":"2026-06-25T22:14:59.858637Z","steps":["trace[1361050016] 'process raft request' (duration: 1.168736237s)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:14:59.858719Z","caller":"traceutil/trace.go:171","msg":"trace[518750060] linearizableReadLoop","detail":"{readStateIndex:111; appliedIndex:105; }","duration":"1.135799338s","start":"2026-06-25T22:14:58.7229Z","end":"2026-06-25T22:14:59.8587Z","steps":["trace[518750060] 'read index received' (duration: 1.110029861s)","trace[518750060] 'applied index is now lower than readState.Index' (duration: 25.768696ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:14:59.858771Z","caller":"traceutil/trace.go:171","msg":"trace[1073811427] transaction","detail":"{read_only:false; response_revision:106; number_of_response:1; }","duration":"944.958044ms","start":"2026-06-25T22:14:58.913787Z","end":"2026-06-25T22:14:59.858745Z","steps":["trace[1073811427] 'process raft request' (duration: 944.766449ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:59.858814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:14:58.689673Z","time spent":"1.169045176s","remote":"127.0.0.1:34774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":666,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-25T22:14:59.858825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:14:59.093223Z","time spent":"765.600184ms","remote":"127.0.0.1:34542","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-25T22:14:59.858864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:14:58.688948Z","time spent":"1.169769024s","remote":"127.0.0.1:34714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T22:14:59.858896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:14:58.913752Z","time spent":"945.086667ms","remote":"127.0.0.1:34640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-25T22:14:59.859045Z","caller":"traceutil/trace.go:171","msg":"trace[424076195] transaction","detail":"{read_only:false; response_revision:105; number_of_response:1; }","duration":"1.163003844s","start":"2026-06-25T22:14:58.696017Z","end":"2026-06-25T22:14:59.859021Z","steps":["trace[424076195] 'process raft request' (duration: 1.16244607s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:59.859113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.136215948s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-25T22:14:59.859149Z","caller":"traceutil/trace.go:171","msg":"trace[735218324] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:106; }","duration":"1.1363294s","start":"2026-06-25T22:14:58.722809Z","end":"2026-06-25T22:14:59.859138Z","steps":["trace[735218324] 'agreement among raft nodes before linearized reading' (duration: 1.136268059s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:14:59.859153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:14:58.696006Z","time spent":"1.163077685s","remote":"127.0.0.1:34640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6950,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T22:14:59.859181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:14:58.722792Z","time spent":"1.136379422s","remote":"127.0.0.1:34458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-25T22:15:00.583383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.692158ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-25T22:15:00.58362Z","caller":"traceutil/trace.go:171","msg":"trace[208269044] transaction","detail":"{read_only:false; response_revision:140; number_of_response:1; }","duration":"382.209324ms","start":"2026-06-25T22:15:00.201389Z","end":"2026-06-25T22:15:00.583599Z","steps":["trace[208269044] 'process raft request' (duration: 382.116572ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:00.58376Z","caller":"traceutil/trace.go:171","msg":"trace[396651101] transaction","detail":"{read_only:false; response_revision:139; number_of_response:1; }","duration":"383.850325ms","start":"2026-06-25T22:15:00.199861Z","end":"2026-06-25T22:15:00.583711Z","steps":["trace[396651101] 'process raft request' (duration: 252.748958ms)","trace[396651101] 'compare' (duration: 130.530593ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:15:00.58383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:00.201374Z","time spent":"382.390669ms","remote":"127.0.0.1:34542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T22:15:00.583935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:00.199841Z","time spent":"384.018059ms","remote":"127.0.0.1:34774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":828,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-25T22:15:01.894838Z","caller":"traceutil/trace.go:171","msg":"trace[1567750732] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"130.655577ms","start":"2026-06-25T22:15:01.764122Z","end":"2026-06-25T22:15:01.894778Z","steps":["trace[1567750732] 'process raft request' (duration: 130.414391ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:01.894847Z","caller":"traceutil/trace.go:171","msg":"trace[664589955] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"121.465219ms","start":"2026-06-25T22:15:01.773361Z","end":"2026-06-25T22:15:01.894826Z","steps":["trace[664589955] 'process raft request' (duration: 121.284495ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:02.144784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.623908ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-25T22:15:02.145094Z","caller":"traceutil/trace.go:171","msg":"trace[1494360061] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"300.118463ms","start":"2026-06-25T22:15:01.844911Z","end":"2026-06-25T22:15:02.14503Z","steps":["trace[1494360061] 'process raft request' (duration: 143.166077ms)","trace[1494360061] 'compare' (duration: 156.449994ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:15:02.145129Z","caller":"traceutil/trace.go:171","msg":"trace[1256057975] transaction","detail":"{read_only:false; response_revision:260; number_of_response:1; }","duration":"245.905991ms","start":"2026-06-25T22:15:01.899194Z","end":"2026-06-25T22:15:02.1451Z","steps":["trace[1256057975] 'process raft request' (duration: 245.829279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:02.145239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.809971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-25T22:15:02.145335Z","caller":"traceutil/trace.go:171","msg":"trace[271337914] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:260; }","duration":"279.964404ms","start":"2026-06-25T22:15:01.865346Z","end":"2026-06-25T22:15:02.145311Z","steps":["trace[271337914] 'agreement among raft nodes before linearized reading' (duration: 279.760499ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:02.145232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:01.844885Z","time spent":"300.285748ms","remote":"127.0.0.1:34654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-25T22:15:02.145361Z","caller":"traceutil/trace.go:171","msg":"trace[536540221] linearizableReadLoop","detail":"{readStateIndex:265; appliedIndex:262; }","duration":"279.694177ms","start":"2026-06-25T22:15:01.865406Z","end":"2026-06-25T22:15:02.1451Z","steps":["trace[536540221] 'read index received' (duration: 29.220793ms)","trace[536540221] 'applied index is now lower than readState.Index' (duration: 250.470124ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:15:02.145628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.870479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-25T22:15:02.145703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.399533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2918"} {"level":"info","ts":"2026-06-25T22:15:02.14573Z","caller":"traceutil/trace.go:171","msg":"trace[894650510] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:260; }","duration":"248.046643ms","start":"2026-06-25T22:15:01.897674Z","end":"2026-06-25T22:15:02.145721Z","steps":["trace[894650510] 'agreement among raft nodes before linearized reading' (duration: 247.92093ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:02.145757Z","caller":"traceutil/trace.go:171","msg":"trace[348746309] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:260; }","duration":"246.478345ms","start":"2026-06-25T22:15:01.899266Z","end":"2026-06-25T22:15:02.145744Z","steps":["trace[348746309] 'agreement among raft nodes before linearized reading' (duration: 246.390453ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:02.458627Z","caller":"traceutil/trace.go:171","msg":"trace[1400226580] linearizableReadLoop","detail":"{readStateIndex:273; appliedIndex:272; }","duration":"133.15506ms","start":"2026-06-25T22:15:02.325448Z","end":"2026-06-25T22:15:02.458603Z","steps":["trace[1400226580] 'read index received' (duration: 128.569346ms)","trace[1400226580] 'applied index is now lower than readState.Index' (duration: 4.584834ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:15:02.458664Z","caller":"traceutil/trace.go:171","msg":"trace[88254993] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"149.177104ms","start":"2026-06-25T22:15:02.309458Z","end":"2026-06-25T22:15:02.458636Z","steps":["trace[88254993] 'process raft request' (duration: 144.615862ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:02.45876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.290993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:15:02.458794Z","caller":"traceutil/trace.go:171","msg":"trace[826326011] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:0; response_revision:267; }","duration":"133.373715ms","start":"2026-06-25T22:15:02.325411Z","end":"2026-06-25T22:15:02.458785Z","steps":["trace[826326011] 'agreement among raft nodes before linearized reading' (duration: 133.277173ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:03.768335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.851607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:15:03.768404Z","caller":"traceutil/trace.go:171","msg":"trace[1455541534] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:0; response_revision:288; }","duration":"136.012511ms","start":"2026-06-25T22:15:03.632377Z","end":"2026-06-25T22:15:03.76839Z","steps":["trace[1455541534] 'range keys from in-memory index tree' (duration: 135.667573ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:03.77753Z","caller":"traceutil/trace.go:171","msg":"trace[1499413017] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"144.419568ms","start":"2026-06-25T22:15:03.633091Z","end":"2026-06-25T22:15:03.77751Z","steps":["trace[1499413017] 'process raft request' (duration: 143.993887ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:04.316766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.420247ms","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-06-25T22:15:04.316917Z","caller":"traceutil/trace.go:171","msg":"trace[1657929827] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:296; }","duration":"213.578511ms","start":"2026-06-25T22:15:04.103307Z","end":"2026-06-25T22:15:04.316885Z","steps":["trace[1657929827] 'range keys from in-memory index tree' (duration: 213.401516ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:04.372927Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415873668384050342,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-25T22:15:04.394367Z","caller":"traceutil/trace.go:171","msg":"trace[178690172] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"524.641512ms","start":"2026-06-25T22:15:03.869697Z","end":"2026-06-25T22:15:04.394339Z","steps":["trace[178690172] 'process raft request' (duration: 524.456037ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:04.394859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:03.869675Z","time spent":"524.872857ms","remote":"127.0.0.1:34776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-25T22:15:04.579638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.362527ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-25T22:15:04.579769Z","caller":"traceutil/trace.go:171","msg":"trace[311850322] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"646.870149ms","start":"2026-06-25T22:15:03.93287Z","end":"2026-06-25T22:15:04.57974Z","steps":["trace[311850322] 'process raft request' (duration: 520.340058ms)","trace[311850322] 'compare' (duration: 126.254494ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:15:04.579906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:03.932662Z","time spent":"647.171756ms","remote":"127.0.0.1:34714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-25T22:15:04.579909Z","caller":"traceutil/trace.go:171","msg":"trace[653172190] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"180.855563ms","start":"2026-06-25T22:15:04.399037Z","end":"2026-06-25T22:15:04.579892Z","steps":["trace[653172190] 'process raft request' (duration: 180.684138ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:04.580035Z","caller":"traceutil/trace.go:171","msg":"trace[1431988533] linearizableReadLoop","detail":"{readStateIndex:304; appliedIndex:302; }","duration":"708.018856ms","start":"2026-06-25T22:15:03.87193Z","end":"2026-06-25T22:15:04.579949Z","steps":["trace[1431988533] 'read index received' (duration: 522.256873ms)","trace[1431988533] 'applied index is now lower than readState.Index' (duration: 185.760293ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:15:04.580241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.33899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-25T22:15:04.580237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.276982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-06-25T22:15:04.580331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.800567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6963"} {"level":"info","ts":"2026-06-25T22:15:04.580368Z","caller":"traceutil/trace.go:171","msg":"trace[1722931960] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:299; }","duration":"165.883739ms","start":"2026-06-25T22:15:04.414473Z","end":"2026-06-25T22:15:04.580357Z","steps":["trace[1722931960] 'agreement among raft nodes before linearized reading' (duration: 165.755286ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:04.580531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.043605ms","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-06-25T22:15:04.580576Z","caller":"traceutil/trace.go:171","msg":"trace[10509498] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:299; }","duration":"348.124456ms","start":"2026-06-25T22:15:04.232442Z","end":"2026-06-25T22:15:04.580566Z","steps":["trace[10509498] 'agreement among raft nodes before linearized reading' (duration: 347.87126ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:04.580341Z","caller":"traceutil/trace.go:171","msg":"trace[411038338] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:299; }","duration":"708.413835ms","start":"2026-06-25T22:15:03.871906Z","end":"2026-06-25T22:15:04.58032Z","steps":["trace[411038338] 'agreement among raft nodes before linearized reading' (duration: 708.170249ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:04.580621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:04.232386Z","time spent":"348.226919ms","remote":"127.0.0.1:34714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-25T22:15:04.58063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:03.871897Z","time spent":"708.719233ms","remote":"127.0.0.1:34654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"info","ts":"2026-06-25T22:15:04.580283Z","caller":"traceutil/trace.go:171","msg":"trace[79019885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:299; }","duration":"419.408641ms","start":"2026-06-25T22:15:04.160863Z","end":"2026-06-25T22:15:04.580272Z","steps":["trace[79019885] 'agreement among raft nodes before linearized reading' (duration: 419.320889ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:04.580724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:04.160846Z","time spent":"419.863672ms","remote":"127.0.0.1:34714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-25T22:15:04.720682Z","caller":"traceutil/trace.go:171","msg":"trace[823463448] linearizableReadLoop","detail":"{readStateIndex:307; appliedIndex:305; }","duration":"133.948142ms","start":"2026-06-25T22:15:04.58671Z","end":"2026-06-25T22:15:04.720658Z","steps":["trace[823463448] 'read index received' (duration: 40.302531ms)","trace[823463448] 'applied index is now lower than readState.Index' (duration: 93.644811ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:15:04.720894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.092695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:15:04.720886Z","caller":"traceutil/trace.go:171","msg":"trace[770295564] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"130.014646ms","start":"2026-06-25T22:15:04.590851Z","end":"2026-06-25T22:15:04.720866Z","steps":["trace[770295564] 'process raft request' (duration: 129.76536ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:04.720797Z","caller":"traceutil/trace.go:171","msg":"trace[854136790] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"133.941972ms","start":"2026-06-25T22:15:04.586788Z","end":"2026-06-25T22:15:04.72073Z","steps":["trace[854136790] 'process raft request' (duration: 133.774207ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:04.720985Z","caller":"traceutil/trace.go:171","msg":"trace[1603997496] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-controller; range_end:; response_count:0; response_revision:303; }","duration":"134.235268ms","start":"2026-06-25T22:15:04.586681Z","end":"2026-06-25T22:15:04.720916Z","steps":["trace[1603997496] 'agreement among raft nodes before linearized reading' (duration: 134.070814ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:04.721398Z","caller":"traceutil/trace.go:171","msg":"trace[1422490970] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"134.523235ms","start":"2026-06-25T22:15:04.586677Z","end":"2026-06-25T22:15:04.7212Z","steps":["trace[1422490970] 'process raft request' (duration: 132.844094ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:09.229529Z","caller":"traceutil/trace.go:171","msg":"trace[554552914] linearizableReadLoop","detail":"{readStateIndex:405; appliedIndex:404; }","duration":"118.146267ms","start":"2026-06-25T22:15:09.111361Z","end":"2026-06-25T22:15:09.229508Z","steps":["trace[554552914] 'read index received' (duration: 117.970753ms)","trace[554552914] 'applied index is now lower than readState.Index' (duration: 174.684µs)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:15:09.229633Z","caller":"traceutil/trace.go:171","msg":"trace[904604721] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"492.399741ms","start":"2026-06-25T22:15:08.737225Z","end":"2026-06-25T22:15:09.229625Z","steps":["trace[904604721] 'process raft request' (duration: 492.148295ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:09.22972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:08.7372Z","time spent":"492.453612ms","remote":"127.0.0.1:34714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T22:15:09.229782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.427123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:15:09.229845Z","caller":"traceutil/trace.go:171","msg":"trace[840456638] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:390; }","duration":"118.527646ms","start":"2026-06-25T22:15:09.111307Z","end":"2026-06-25T22:15:09.229834Z","steps":["trace[840456638] 'agreement among raft nodes before linearized reading' (duration: 118.447174ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:09.467719Z","caller":"traceutil/trace.go:171","msg":"trace[1037166146] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"229.554843ms","start":"2026-06-25T22:15:09.238147Z","end":"2026-06-25T22:15:09.467702Z","steps":["trace[1037166146] 'process raft request' (duration: 229.451041ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:09.979744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.177207ms","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-06-25T22:15:09.979916Z","caller":"traceutil/trace.go:171","msg":"trace[455304787] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:391; }","duration":"142.408402ms","start":"2026-06-25T22:15:09.837488Z","end":"2026-06-25T22:15:09.979897Z","steps":["trace[455304787] 'range keys from in-memory index tree' (duration: 142.035573ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:10.611822Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415873668384050543,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-25T22:15:10.752551Z","caller":"traceutil/trace.go:171","msg":"trace[256706278] linearizableReadLoop","detail":"{readStateIndex:407; appliedIndex:406; }","duration":"641.077616ms","start":"2026-06-25T22:15:10.111443Z","end":"2026-06-25T22:15:10.752521Z","steps":["trace[256706278] 'read index received' (duration: 640.761948ms)","trace[256706278] 'applied index is now lower than readState.Index' (duration: 313.878µs)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:15:10.75265Z","caller":"traceutil/trace.go:171","msg":"trace[1927891748] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"768.554258ms","start":"2026-06-25T22:15:09.984076Z","end":"2026-06-25T22:15:10.75263Z","steps":["trace[1927891748] 'process raft request' (duration: 768.274132ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:10.753033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:09.98405Z","time spent":"768.900766ms","remote":"127.0.0.1:34714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T22:15:10.752767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.25787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:15:10.753329Z","caller":"traceutil/trace.go:171","msg":"trace[579043243] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:392; }","duration":"641.907725ms","start":"2026-06-25T22:15:10.111406Z","end":"2026-06-25T22:15:10.753314Z","steps":["trace[579043243] 'agreement among raft nodes before linearized reading' (duration: 641.24195ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:10.753373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:10.111388Z","time spent":"641.973696ms","remote":"127.0.0.1:34458","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-25T22:15:11.160555Z","caller":"traceutil/trace.go:171","msg":"trace[99269039] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"402.339584ms","start":"2026-06-25T22:15:10.758187Z","end":"2026-06-25T22:15:11.160527Z","steps":["trace[99269039] 'process raft request' (duration: 402.122139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:11.160728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:10.758171Z","time spent":"402.467747ms","remote":"127.0.0.1:34714","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-25T22:15:11.497894Z","caller":"traceutil/trace.go:171","msg":"trace[1242370351] linearizableReadLoop","detail":"{readStateIndex:409; appliedIndex:407; }","duration":"385.734564ms","start":"2026-06-25T22:15:11.112136Z","end":"2026-06-25T22:15:11.497871Z","steps":["trace[1242370351] 'read index received' (duration: 48.199029ms)","trace[1242370351] 'applied index is now lower than readState.Index' (duration: 337.534245ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:15:11.497929Z","caller":"traceutil/trace.go:171","msg":"trace[1586789779] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"735.555137ms","start":"2026-06-25T22:15:10.762341Z","end":"2026-06-25T22:15:11.497896Z","steps":["trace[1586789779] 'process raft request' (duration: 735.389993ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:11.49808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:10.762315Z","time spent":"735.683111ms","remote":"127.0.0.1:34640","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-25T22:15:11.498118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.87199ms","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-06-25T22:15:11.498163Z","caller":"traceutil/trace.go:171","msg":"trace[148463997] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:394; }","duration":"264.009123ms","start":"2026-06-25T22:15:11.234142Z","end":"2026-06-25T22:15:11.498151Z","steps":["trace[148463997] 'agreement among raft nodes before linearized reading' (duration: 263.86498ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:11.498439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.222085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:15:11.498702Z","caller":"traceutil/trace.go:171","msg":"trace[1852966624] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:394; }","duration":"386.569853ms","start":"2026-06-25T22:15:11.112096Z","end":"2026-06-25T22:15:11.498665Z","steps":["trace[1852966624] 'agreement among raft nodes before linearized reading' (duration: 385.968129ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:11.498896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:11.11208Z","time spent":"386.796598ms","remote":"127.0.0.1:34458","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-25T22:15:11.720832Z","caller":"traceutil/trace.go:171","msg":"trace[213933393] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"213.956213ms","start":"2026-06-25T22:15:11.506854Z","end":"2026-06-25T22:15:11.720811Z","steps":["trace[213933393] 'process raft request' (duration: 162.547478ms)","trace[213933393] 'compare' (duration: 51.242071ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:15:12.215207Z","caller":"traceutil/trace.go:171","msg":"trace[707181657] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"117.861706ms","start":"2026-06-25T22:15:12.09733Z","end":"2026-06-25T22:15:12.215191Z","steps":["trace[707181657] 'process raft request' (duration: 67.699737ms)","trace[707181657] 'compare' (duration: 49.944924ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:15:12.215453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.501381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:15:12.215545Z","caller":"traceutil/trace.go:171","msg":"trace[230754118] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:407; }","duration":"106.658815ms","start":"2026-06-25T22:15:12.108867Z","end":"2026-06-25T22:15:12.215526Z","steps":["trace[230754118] 'agreement among raft nodes before linearized reading' (duration: 106.46177ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:12.215154Z","caller":"traceutil/trace.go:171","msg":"trace[1070698748] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:422; }","duration":"106.197324ms","start":"2026-06-25T22:15:12.108932Z","end":"2026-06-25T22:15:12.21513Z","steps":["trace[1070698748] 'read index received' (duration: 10.627508ms)","trace[1070698748] 'applied index is now lower than readState.Index' (duration: 95.568656ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:15:13.335409Z","caller":"traceutil/trace.go:171","msg":"trace[489577116] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"160.379007ms","start":"2026-06-25T22:15:13.175004Z","end":"2026-06-25T22:15:13.335383Z","steps":["trace[489577116] 'process raft request' (duration: 159.747932ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:25.061809Z","caller":"traceutil/trace.go:171","msg":"trace[408357048] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"109.920327ms","start":"2026-06-25T22:15:24.951865Z","end":"2026-06-25T22:15:25.061785Z","steps":["trace[408357048] 'process raft request' (duration: 109.720553ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:40.58087Z","caller":"traceutil/trace.go:171","msg":"trace[1280518461] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"341.185108ms","start":"2026-06-25T22:15:40.239661Z","end":"2026-06-25T22:15:40.580847Z","steps":["trace[1280518461] 'process raft request' (duration: 341.054836ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:40.581089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:40.239636Z","time spent":"341.316221ms","remote":"127.0.0.1:34714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-25T22:15:41.304307Z","caller":"traceutil/trace.go:171","msg":"trace[387178734] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"1.027885052s","start":"2026-06-25T22:15:40.276321Z","end":"2026-06-25T22:15:41.304206Z","steps":["trace[387178734] 'process raft request' (duration: 1.027691018s)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:41.30439Z","caller":"traceutil/trace.go:171","msg":"trace[1107097692] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"1.019437468s","start":"2026-06-25T22:15:40.284944Z","end":"2026-06-25T22:15:41.304381Z","steps":["trace[1107097692] 'process raft request' (duration: 1.019214134s)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:41.304363Z","caller":"traceutil/trace.go:171","msg":"trace[1949075195] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"1.019367067s","start":"2026-06-25T22:15:40.284908Z","end":"2026-06-25T22:15:41.304275Z","steps":["trace[1949075195] 'process raft request' (duration: 1.019229404s)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:41.3044Z","caller":"traceutil/trace.go:171","msg":"trace[2010215960] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"1.014794374s","start":"2026-06-25T22:15:40.289554Z","end":"2026-06-25T22:15:41.304348Z","steps":["trace[2010215960] 'process raft request' (duration: 1.014663961s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:41.304472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:40.284926Z","time spent":"1.01948866s","remote":"127.0.0.1:34522","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-25T22:15:41.304472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:40.276301Z","time spent":"1.028090466s","remote":"127.0.0.1:34522","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-25T22:15:41.304525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:40.289545Z","time spent":"1.014923486s","remote":"127.0.0.1:34522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-25T22:15:41.304557Z","caller":"traceutil/trace.go:171","msg":"trace[119704514] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:568; }","duration":"374.784604ms","start":"2026-06-25T22:15:40.929753Z","end":"2026-06-25T22:15:41.304538Z","steps":["trace[119704514] 'read index received' (duration: 374.175342ms)","trace[119704514] 'applied index is now lower than readState.Index' (duration: 608.602µs)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:15:41.304332Z","caller":"traceutil/trace.go:171","msg":"trace[1762946610] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"1.017926988s","start":"2026-06-25T22:15:40.286387Z","end":"2026-06-25T22:15:41.304314Z","steps":["trace[1762946610] 'process raft request' (duration: 1.017807475s)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:41.304637Z","caller":"traceutil/trace.go:171","msg":"trace[2027779481] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"1.012083027s","start":"2026-06-25T22:15:40.292542Z","end":"2026-06-25T22:15:41.304625Z","steps":["trace[2027779481] 'process raft request' (duration: 1.01173079s)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:41.304646Z","caller":"traceutil/trace.go:171","msg":"trace[1996106156] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"1.003153314s","start":"2026-06-25T22:15:40.301471Z","end":"2026-06-25T22:15:41.304625Z","steps":["trace[1996106156] 'process raft request' (duration: 1.002852908s)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:41.304673Z","caller":"traceutil/trace.go:171","msg":"trace[982454177] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"1.008549475s","start":"2026-06-25T22:15:40.296107Z","end":"2026-06-25T22:15:41.304657Z","steps":["trace[982454177] 'process raft request' (duration: 1.008190778s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:41.304682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:40.292526Z","time spent":"1.012133939s","remote":"127.0.0.1:34522","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-25T22:15:41.30468Z","caller":"traceutil/trace.go:171","msg":"trace[1198012434] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"965.662405ms","start":"2026-06-25T22:15:40.339001Z","end":"2026-06-25T22:15:41.304664Z","steps":["trace[1198012434] 'process raft request' (duration: 965.383259ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:41.304727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:40.301451Z","time spent":"1.003223636s","remote":"127.0.0.1:34522","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-25T22:15:41.30471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:40.286377Z","time spent":"1.018255934s","remote":"127.0.0.1:34522","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-25T22:15:41.304744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:40.296095Z","time spent":"1.008615767s","remote":"127.0.0.1:34522","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-25T22:15:41.30476Z","caller":"traceutil/trace.go:171","msg":"trace[311264452] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"1.002744196s","start":"2026-06-25T22:15:40.302008Z","end":"2026-06-25T22:15:41.304752Z","steps":["trace[311264452] 'process raft request' (duration: 1.002346068s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:41.304802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:40.301996Z","time spent":"1.002787697s","remote":"127.0.0.1:34522","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-25T22:15:41.30464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:40.284895Z","time spent":"1.0195357s","remote":"127.0.0.1:34522","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-25T22:15:41.304595Z","caller":"traceutil/trace.go:171","msg":"trace[931662709] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"1.023264937s","start":"2026-06-25T22:15:40.281317Z","end":"2026-06-25T22:15:41.304581Z","steps":["trace[931662709] 'process raft request' (duration: 1.022800878s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:41.304751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:40.338982Z","time spent":"965.737677ms","remote":"127.0.0.1:34522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-25T22:15:41.30486Z","caller":"traceutil/trace.go:171","msg":"trace[617982887] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"871.502344ms","start":"2026-06-25T22:15:40.433341Z","end":"2026-06-25T22:15:41.304843Z","steps":["trace[617982887] 'process raft request' (duration: 871.126426ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:41.304901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:40.281298Z","time spent":"1.023568813s","remote":"127.0.0.1:34522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-25T22:15:41.304925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:40.433311Z","time spent":"871.581446ms","remote":"127.0.0.1:34522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-25T22:15:41.305006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.255785ms","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-06-25T22:15:41.305027Z","caller":"traceutil/trace.go:171","msg":"trace[304773015] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:557; }","duration":"375.317186ms","start":"2026-06-25T22:15:40.929704Z","end":"2026-06-25T22:15:41.305021Z","steps":["trace[304773015] 'agreement among raft nodes before linearized reading' (duration: 374.900118ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:41.305042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:40.929683Z","time spent":"375.356227ms","remote":"127.0.0.1:34714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-25T22:15:47.027242Z","caller":"traceutil/trace.go:171","msg":"trace[91029996] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:673; }","duration":"402.82395ms","start":"2026-06-25T22:15:46.624394Z","end":"2026-06-25T22:15:47.027218Z","steps":["trace[91029996] 'read index received' (duration: 401.698247ms)","trace[91029996] 'applied index is now lower than readState.Index' (duration: 1.124663ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:15:47.027363Z","caller":"traceutil/trace.go:171","msg":"trace[1776898175] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"623.76434ms","start":"2026-06-25T22:15:46.40355Z","end":"2026-06-25T22:15:47.027314Z","steps":["trace[1776898175] 'process raft request' (duration: 622.888173ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:47.027509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:46.403511Z","time spent":"623.918184ms","remote":"127.0.0.1:34562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T22:15:47.027496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.088415ms","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-25T22:15:47.027552Z","caller":"traceutil/trace.go:171","msg":"trace[1276306410] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:645; }","duration":"403.217087ms","start":"2026-06-25T22:15:46.624324Z","end":"2026-06-25T22:15:47.027541Z","steps":["trace[1276306410] 'agreement among raft nodes before linearized reading' (duration: 403.010263ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:47.027613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:46.624304Z","time spent":"403.300538ms","remote":"127.0.0.1:34714","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":"info","ts":"2026-06-25T22:15:47.830361Z","caller":"traceutil/trace.go:171","msg":"trace[272765695] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"301.851694ms","start":"2026-06-25T22:15:47.528472Z","end":"2026-06-25T22:15:47.830324Z","steps":["trace[272765695] 'process raft request' (duration: 301.208111ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:47.830537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:47.528444Z","time spent":"301.993737ms","remote":"127.0.0.1:34562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036265,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T22:15:48.325459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.388001ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-25T22:15:48.325563Z","caller":"traceutil/trace.go:171","msg":"trace[1117245230] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"490.259728ms","start":"2026-06-25T22:15:47.835285Z","end":"2026-06-25T22:15:48.325545Z","steps":["trace[1117245230] 'process raft request' (duration: 13.684713ms)","trace[1117245230] 'compare' (duration: 476.285369ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:15:48.325623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:47.835265Z","time spent":"490.33091ms","remote":"127.0.0.1:34714","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-25T22:15:48.350284Z","caller":"traceutil/trace.go:171","msg":"trace[1344012018] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:684; }","duration":"239.756876ms","start":"2026-06-25T22:15:48.110506Z","end":"2026-06-25T22:15:48.350263Z","steps":["trace[1344012018] 'read index received' (duration: 239.633783ms)","trace[1344012018] 'applied index is now lower than readState.Index' (duration: 122.373µs)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:15:48.35034Z","caller":"traceutil/trace.go:171","msg":"trace[646303249] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"445.189525ms","start":"2026-06-25T22:15:47.905119Z","end":"2026-06-25T22:15:48.350309Z","steps":["trace[646303249] 'process raft request' (duration: 445.061882ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:48.350438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.945649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:15:48.350468Z","caller":"traceutil/trace.go:171","msg":"trace[1960166808] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:655; }","duration":"240.016811ms","start":"2026-06-25T22:15:48.110443Z","end":"2026-06-25T22:15:48.350459Z","steps":["trace[1960166808] 'agreement among raft nodes before linearized reading' (duration: 239.933679ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:48.350632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:47.905098Z","time spent":"445.41425ms","remote":"127.0.0.1:34776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-25T22:15:48.35088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.566953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bsmw5\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-25T22:15:48.350914Z","caller":"traceutil/trace.go:171","msg":"trace[1221610812] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bsmw5; range_end:; response_count:1; response_revision:655; }","duration":"100.622884ms","start":"2026-06-25T22:15:48.250277Z","end":"2026-06-25T22:15:48.3509Z","steps":["trace[1221610812] 'agreement among raft nodes before linearized reading' (duration: 100.524322ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:48.469247Z","caller":"traceutil/trace.go:171","msg":"trace[721325181] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"103.574363ms","start":"2026-06-25T22:15:48.365627Z","end":"2026-06-25T22:15:48.469201Z","steps":["trace[721325181] 'process raft request' (duration: 69.436683ms)","trace[721325181] 'compare' (duration: 33.975557ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:15:49.549784Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415873668384051067,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-25T22:15:50.050554Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415873668384051067,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-25T22:15:50.550917Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415873668384051067,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-25T22:15:50.70498Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.934937675s","expected-duration":"1s"} {"level":"info","ts":"2026-06-25T22:15:50.711263Z","caller":"traceutil/trace.go:171","msg":"trace[1192248680] linearizableReadLoop","detail":"{readStateIndex:687; appliedIndex:686; }","duration":"1.661716344s","start":"2026-06-25T22:15:49.049522Z","end":"2026-06-25T22:15:50.711238Z","steps":["trace[1192248680] 'read index received' (duration: 1.655627834s)","trace[1192248680] 'applied index is now lower than readState.Index' (duration: 6.08753ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:15:50.7114Z","caller":"traceutil/trace.go:171","msg":"trace[2045969328] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"1.94280443s","start":"2026-06-25T22:15:48.768581Z","end":"2026-06-25T22:15:50.711385Z","steps":["trace[2045969328] 'process raft request' (duration: 1.936989296s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:50.711516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:48.768552Z","time spent":"1.942880161s","remote":"127.0.0.1:34562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036297,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T22:15:50.711771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.600484029s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:15:50.711854Z","caller":"traceutil/trace.go:171","msg":"trace[567635739] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:657; }","duration":"1.600613132s","start":"2026-06-25T22:15:49.111216Z","end":"2026-06-25T22:15:50.711829Z","steps":["trace[567635739] 'agreement among raft nodes before linearized reading' (duration: 1.600480189s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:50.711882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.762052ms","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-06-25T22:15:50.711958Z","caller":"traceutil/trace.go:171","msg":"trace[565853772] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:657; }","duration":"382.877843ms","start":"2026-06-25T22:15:50.32906Z","end":"2026-06-25T22:15:50.711938Z","steps":["trace[565853772] 'agreement among raft nodes before linearized reading' (duration: 382.6879ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:50.712012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:50.328967Z","time spent":"383.031386ms","remote":"127.0.0.1:34714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-25T22:15:50.712009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.6624861s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-25T22:15:50.71203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.35316531s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-25T22:15:50.711907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:49.111194Z","time spent":"1.600699583s","remote":"127.0.0.1:34458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-25T22:15:50.712394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.160240621s","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-06-25T22:15:50.713097Z","caller":"traceutil/trace.go:171","msg":"trace[142814476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:657; }","duration":"1.16123072s","start":"2026-06-25T22:15:49.551572Z","end":"2026-06-25T22:15:50.712803Z","steps":["trace[142814476] 'agreement among raft nodes before linearized reading' (duration: 1.16017882s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:50.713261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:49.551553Z","time spent":"1.161592947s","remote":"127.0.0.1:34714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-25T22:15:50.71465Z","caller":"traceutil/trace.go:171","msg":"trace[1140201295] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:657; }","duration":"1.353243012s","start":"2026-06-25T22:15:49.358816Z","end":"2026-06-25T22:15:50.712059Z","steps":["trace[1140201295] 'agreement among raft nodes before linearized reading' (duration: 1.353117289s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:50.714699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:49.358786Z","time spent":"1.355900264s","remote":"127.0.0.1:34714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-25T22:15:50.714725Z","caller":"traceutil/trace.go:171","msg":"trace[2041826950] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:657; }","duration":"1.662580012s","start":"2026-06-25T22:15:49.049473Z","end":"2026-06-25T22:15:50.712053Z","steps":["trace[2041826950] 'agreement among raft nodes before linearized reading' (duration: 1.662430549s)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:15:50.714833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:15:49.049432Z","time spent":"1.665366537s","remote":"127.0.0.1:34714","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":"info","ts":"2026-06-25T22:15:51.532546Z","caller":"traceutil/trace.go:171","msg":"trace[821892136] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"176.263675ms","start":"2026-06-25T22:15:51.356266Z","end":"2026-06-25T22:15:51.53253Z","steps":["trace[821892136] 'process raft request' (duration: 173.900468ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:15:52.811419Z","caller":"traceutil/trace.go:171","msg":"trace[1065780511] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"207.15878ms","start":"2026-06-25T22:15:52.604236Z","end":"2026-06-25T22:15:52.811395Z","steps":["trace[1065780511] 'process raft request' (duration: 207.036828ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:16:03.603398Z","caller":"traceutil/trace.go:171","msg":"trace[1156898638] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"209.788873ms","start":"2026-06-25T22:16:03.39358Z","end":"2026-06-25T22:16:03.603368Z","steps":["trace[1156898638] 'process raft request' (duration: 126.478041ms)","trace[1156898638] 'compare' (duration: 83.20066ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:16:03.661865Z","caller":"traceutil/trace.go:171","msg":"trace[192352949] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"267.328656ms","start":"2026-06-25T22:16:03.394514Z","end":"2026-06-25T22:16:03.661843Z","steps":["trace[192352949] 'process raft request' (duration: 267.166193ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:16:03.662127Z","caller":"traceutil/trace.go:171","msg":"trace[1507948890] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"264.109585ms","start":"2026-06-25T22:16:03.397979Z","end":"2026-06-25T22:16:03.662089Z","steps":["trace[1507948890] 'process raft request' (duration: 263.806469ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:16:03.797216Z","caller":"traceutil/trace.go:171","msg":"trace[1160870143] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"127.937239ms","start":"2026-06-25T22:16:03.66926Z","end":"2026-06-25T22:16:03.797197Z","steps":["trace[1160870143] 'process raft request' (duration: 127.743955ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:16:03.797391Z","caller":"traceutil/trace.go:171","msg":"trace[1142551202] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"125.459102ms","start":"2026-06-25T22:16:03.671907Z","end":"2026-06-25T22:16:03.797366Z","steps":["trace[1142551202] 'process raft request' (duration: 125.215478ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:16:07.674314Z","caller":"traceutil/trace.go:171","msg":"trace[1163448161] transaction","detail":"{read_only:false; response_revision:829; number_of_response:1; }","duration":"308.604273ms","start":"2026-06-25T22:16:07.365676Z","end":"2026-06-25T22:16:07.67428Z","steps":["trace[1163448161] 'process raft request' (duration: 308.388399ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:16:07.674581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:16:07.365652Z","time spent":"308.771626ms","remote":"127.0.0.1:34640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-25T22:16:35.387459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.20489ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-25T22:16:35.387576Z","caller":"traceutil/trace.go:171","msg":"trace[33185288] linearizableReadLoop","detail":"{readStateIndex:1084; appliedIndex:1083; }","duration":"217.058551ms","start":"2026-06-25T22:16:35.1705Z","end":"2026-06-25T22:16:35.387559Z","steps":["trace[33185288] 'read index received' (duration: 98.619726ms)","trace[33185288] 'applied index is now lower than readState.Index' (duration: 118.437385ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:16:35.387681Z","caller":"traceutil/trace.go:171","msg":"trace[1942487296] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"240.861349ms","start":"2026-06-25T22:16:35.146778Z","end":"2026-06-25T22:16:35.387639Z","steps":["trace[1942487296] 'process raft request' (duration: 122.387244ms)","trace[1942487296] 'compare' (duration: 118.052988ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:16:35.387766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.286414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-25T22:16:35.387807Z","caller":"traceutil/trace.go:171","msg":"trace[1178802817] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1043; }","duration":"217.350726ms","start":"2026-06-25T22:16:35.170444Z","end":"2026-06-25T22:16:35.387794Z","steps":["trace[1178802817] 'agreement among raft nodes before linearized reading' (duration: 217.203293ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:16:35.387894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.815436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-25T22:16:35.387994Z","caller":"traceutil/trace.go:171","msg":"trace[1164733715] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1043; }","duration":"162.965908ms","start":"2026-06-25T22:16:35.225012Z","end":"2026-06-25T22:16:35.387978Z","steps":["trace[1164733715] 'agreement among raft nodes before linearized reading' (duration: 162.724774ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:16:35.652068Z","caller":"traceutil/trace.go:171","msg":"trace[318175658] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"260.038118ms","start":"2026-06-25T22:16:35.392004Z","end":"2026-06-25T22:16:35.652042Z","steps":["trace[318175658] 'process raft request' (duration: 259.852834ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:16:37.772206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.769313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-25T22:16:37.772263Z","caller":"traceutil/trace.go:171","msg":"trace[1828031809] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1053; }","duration":"114.858654ms","start":"2026-06-25T22:16:37.657392Z","end":"2026-06-25T22:16:37.772251Z","steps":["trace[1828031809] 'range keys from in-memory index tree' (duration: 114.657151ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:16:38.549211Z","caller":"traceutil/trace.go:171","msg":"trace[1016041213] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"107.403471ms","start":"2026-06-25T22:16:38.44179Z","end":"2026-06-25T22:16:38.549193Z","steps":["trace[1016041213] 'process raft request' (duration: 107.284409ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:16:38.679573Z","caller":"traceutil/trace.go:171","msg":"trace[1911323724] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"104.352256ms","start":"2026-06-25T22:16:38.575186Z","end":"2026-06-25T22:16:38.679538Z","steps":["trace[1911323724] 'process raft request' (duration: 29.444655ms)","trace[1911323724] 'compare' (duration: 74.754449ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:16:57.711185Z","caller":"traceutil/trace.go:171","msg":"trace[1486056740] linearizableReadLoop","detail":"{readStateIndex:1169; appliedIndex:1168; }","duration":"113.186153ms","start":"2026-06-25T22:16:57.597964Z","end":"2026-06-25T22:16:57.71115Z","steps":["trace[1486056740] 'read index received' (duration: 112.804996ms)","trace[1486056740] 'applied index is now lower than readState.Index' (duration: 379.667µs)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:16:57.711241Z","caller":"traceutil/trace.go:171","msg":"trace[2116255619] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"129.349237ms","start":"2026-06-25T22:16:57.581852Z","end":"2026-06-25T22:16:57.711201Z","steps":["trace[2116255619] 'process raft request' (duration: 129.006251ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:16:57.711384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.383286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:16:57.711474Z","caller":"traceutil/trace.go:171","msg":"trace[1042928983] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1122; }","duration":"113.523798ms","start":"2026-06-25T22:16:57.59793Z","end":"2026-06-25T22:16:57.711453Z","steps":["trace[1042928983] 'agreement among raft nodes before linearized reading' (duration: 113.343775ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:17:09.225696Z","caller":"traceutil/trace.go:171","msg":"trace[2072921186] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"101.439947ms","start":"2026-06-25T22:17:09.124229Z","end":"2026-06-25T22:17:09.225669Z","steps":["trace[2072921186] 'process raft request' (duration: 101.295514ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:17:10.230328Z","caller":"traceutil/trace.go:171","msg":"trace[1014777172] linearizableReadLoop","detail":"{readStateIndex:1211; appliedIndex:1210; }","duration":"119.037708ms","start":"2026-06-25T22:17:10.111271Z","end":"2026-06-25T22:17:10.230309Z","steps":["trace[1014777172] 'read index received' (duration: 118.906826ms)","trace[1014777172] 'applied index is now lower than readState.Index' (duration: 130.252µs)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:17:10.230416Z","caller":"traceutil/trace.go:171","msg":"trace[492977143] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"199.633296ms","start":"2026-06-25T22:17:10.030775Z","end":"2026-06-25T22:17:10.230409Z","steps":["trace[492977143] 'process raft request' (duration: 199.420652ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:17:10.230591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.296813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-25T22:17:10.230656Z","caller":"traceutil/trace.go:171","msg":"trace[434489429] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1162; }","duration":"119.411295ms","start":"2026-06-25T22:17:10.111227Z","end":"2026-06-25T22:17:10.230639Z","steps":["trace[434489429] 'agreement among raft nodes before linearized reading' (duration: 119.288253ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:17:11.792664Z","caller":"traceutil/trace.go:171","msg":"trace[315240690] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"128.119038ms","start":"2026-06-25T22:17:11.664491Z","end":"2026-06-25T22:17:11.79261Z","steps":["trace[315240690] 'process raft request' (duration: 117.258067ms)","trace[315240690] 'compare' (duration: 10.684778ms)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:17:54.199387Z","caller":"traceutil/trace.go:171","msg":"trace[982672739] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"134.904762ms","start":"2026-06-25T22:17:54.064452Z","end":"2026-06-25T22:17:54.199356Z","steps":["trace[982672739] 'process raft request' (duration: 134.506525ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:18:02.704776Z","caller":"traceutil/trace.go:171","msg":"trace[833142840] linearizableReadLoop","detail":"{readStateIndex:1433; appliedIndex:1432; }","duration":"211.928166ms","start":"2026-06-25T22:18:02.492803Z","end":"2026-06-25T22:18:02.704731Z","steps":["trace[833142840] 'read index received' (duration: 211.593081ms)","trace[833142840] 'applied index is now lower than readState.Index' (duration: 333.785µs)"],"step_count":2} {"level":"info","ts":"2026-06-25T22:18:02.704905Z","caller":"traceutil/trace.go:171","msg":"trace[706670683] transaction","detail":"{read_only:false; response_revision:1371; number_of_response:1; }","duration":"452.847137ms","start":"2026-06-25T22:18:02.252021Z","end":"2026-06-25T22:18:02.704868Z","steps":["trace[706670683] 'process raft request' (duration: 452.45541ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:18:02.705045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.634015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-25T22:18:02.705071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-25T22:18:02.252004Z","time spent":"452.984728ms","remote":"127.0.0.1:34714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-25T22:18:02.70511Z","caller":"traceutil/trace.go:171","msg":"trace[2087570010] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1371; }","duration":"117.743027ms","start":"2026-06-25T22:18:02.58735Z","end":"2026-06-25T22:18:02.705093Z","steps":["trace[2087570010] 'agreement among raft nodes before linearized reading' (duration: 117.579015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-25T22:18:02.705132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.283732ms","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-06-25T22:18:02.705207Z","caller":"traceutil/trace.go:171","msg":"trace[1924913809] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1371; }","duration":"212.406504ms","start":"2026-06-25T22:18:02.492762Z","end":"2026-06-25T22:18:02.705168Z","steps":["trace[1924913809] 'agreement among raft nodes before linearized reading' (duration: 212.15362ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:18:51.108462Z","caller":"traceutil/trace.go:171","msg":"trace[754985333] transaction","detail":"{read_only:false; response_revision:1536; number_of_response:1; }","duration":"127.870045ms","start":"2026-06-25T22:18:50.980571Z","end":"2026-06-25T22:18:51.108441Z","steps":["trace[754985333] 'process raft request' (duration: 127.839904ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:18:51.108736Z","caller":"traceutil/trace.go:171","msg":"trace[1990294278] linearizableReadLoop","detail":"{readStateIndex:1607; appliedIndex:1606; }","duration":"128.106482ms","start":"2026-06-25T22:18:50.980595Z","end":"2026-06-25T22:18:51.108702Z","steps":["trace[1990294278] 'read index received' (duration: 48.196407ms)","trace[1990294278] 'applied index is now lower than readState.Index' (duration: 79.905785ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:18:51.108918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.309277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-06-25T22:18:51.108986Z","caller":"traceutil/trace.go:171","msg":"trace[1296310903] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:1536; }","duration":"128.40573ms","start":"2026-06-25T22:18:50.980563Z","end":"2026-06-25T22:18:51.108968Z","steps":["trace[1296310903] 'agreement among raft nodes before linearized reading' (duration: 128.284057ms)"],"step_count":1} {"level":"info","ts":"2026-06-25T22:18:51.109357Z","caller":"traceutil/trace.go:171","msg":"trace[1958777919] transaction","detail":"{read_only:false; response_revision:1535; number_of_response:1; }","duration":"128.910274ms","start":"2026-06-25T22:18:50.980414Z","end":"2026-06-25T22:18:51.109324Z","steps":["trace[1958777919] 'process raft request' (duration: 48.294639ms)","trace[1958777919] 'compare' (duration: 79.598057ms)"],"step_count":2} {"level":"warn","ts":"2026-06-25T22:18:51.644479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.85155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:85 size:63200"} {"level":"info","ts":"2026-06-25T22:18:51.644556Z","caller":"traceutil/trace.go:171","msg":"trace[2022387351] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:85; response_revision:1537; }","duration":"107.967303ms","start":"2026-06-25T22:18:51.53657Z","end":"2026-06-25T22:18:51.644537Z","steps":["trace[2022387351] 'range keys from in-memory index tree' (duration: 107.220142ms)"],"step_count":1}