{"level":"warn","ts":"2026-06-09T14:20:08.015937Z","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-09T14:20:08.016063Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.210: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.210:2380","--initial-cluster=instance=https://199.204.45.210:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.210:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.210: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-09T14:20:08.016153Z","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-09T14:20:08.016165Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-06-09T14:20:08.01619Z","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-09T14:20:08.017023Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"]} {"level":"info","ts":"2026-06-09T14:20:08.017116Z","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.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.210: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-09T14:20:08.024892Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.142688ms"} {"level":"info","ts":"2026-06-09T14:20:08.03726Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1cac722af8b2b8a6","cluster-id":"ba0a336ca61ee41d"} {"level":"info","ts":"2026-06-09T14:20:08.037326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=()"} {"level":"info","ts":"2026-06-09T14:20:08.037346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 0"} {"level":"info","ts":"2026-06-09T14:20:08.037356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1cac722af8b2b8a6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-09T14:20:08.037364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 1"} {"level":"info","ts":"2026-06-09T14:20:08.037396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"warn","ts":"2026-06-09T14:20:08.046994Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-09T14:20:08.052492Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-09T14:20:08.058099Z","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-09T14:20:08.061021Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1cac722af8b2b8a6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-09T14:20:08.066334Z","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-09T14:20:08.066403Z","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-09T14:20:08.066411Z","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-09T14:20:08.066494Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1cac722af8b2b8a6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-09T14:20:08.070416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"info","ts":"2026-06-09T14:20:08.070531Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","added-peer-id":"1cac722af8b2b8a6","added-peer-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-06-09T14:20:08.071619Z","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-09T14:20:08.071872Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1cac722af8b2b8a6","initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-09T14:20:08.071904Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-09T14:20:08.07202Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-06-09T14:20:08.072039Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-06-09T14:20:08.738104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 is starting a new election at term 1"} {"level":"info","ts":"2026-06-09T14:20:08.738195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-09T14:20:08.738231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgPreVoteResp from 1cac722af8b2b8a6 at term 1"} {"level":"info","ts":"2026-06-09T14:20:08.738259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became candidate at term 2"} {"level":"info","ts":"2026-06-09T14:20:08.738281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgVoteResp from 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-06-09T14:20:08.738297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became leader at term 2"} {"level":"info","ts":"2026-06-09T14:20:08.738311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1cac722af8b2b8a6 elected leader 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-06-09T14:20:08.739382Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T14:20:08.740381Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1cac722af8b2b8a6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.210:2379]}","request-path":"/0/members/1cac722af8b2b8a6/attributes","cluster-id":"ba0a336ca61ee41d","publish-timeout":"7s"} {"level":"info","ts":"2026-06-09T14:20:08.740552Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T14:20:08.740709Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T14:20:08.74076Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T14:20:08.740875Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T14:20:08.740912Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T14:20:08.743733Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.210:2379"} {"level":"info","ts":"2026-06-09T14:20:08.74398Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-09T14:20:08.74408Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-09T14:20:08.7441Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-06-09T14:20:11.463079Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496613926856215,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-09T14:20:11.544942Z","caller":"traceutil/trace.go:171","msg":"trace[407274508] linearizableReadLoop","detail":"{readStateIndex:118; appliedIndex:117; }","duration":"582.370119ms","start":"2026-06-09T14:20:10.962549Z","end":"2026-06-09T14:20:11.54492Z","steps":["trace[407274508] 'read index received' (duration: 582.193567ms)","trace[407274508] 'applied index is now lower than readState.Index' (duration: 175.882µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T14:20:11.544994Z","caller":"traceutil/trace.go:171","msg":"trace[1640536760] transaction","detail":"{read_only:false; response_revision:113; number_of_response:1; }","duration":"584.430965ms","start":"2026-06-09T14:20:10.960527Z","end":"2026-06-09T14:20:11.544958Z","steps":["trace[1640536760] 'process raft request' (duration: 584.263044ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:11.545099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.53813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-09T14:20:11.545183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.747678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T14:20:11.545254Z","caller":"traceutil/trace.go:171","msg":"trace[75717324] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:113; }","duration":"484.858698ms","start":"2026-06-09T14:20:11.060378Z","end":"2026-06-09T14:20:11.545237Z","steps":["trace[75717324] 'agreement among raft nodes before linearized reading' (duration: 484.732747ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T14:20:11.545183Z","caller":"traceutil/trace.go:171","msg":"trace[163726117] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:113; }","duration":"582.653151ms","start":"2026-06-09T14:20:10.962495Z","end":"2026-06-09T14:20:11.545148Z","steps":["trace[163726117] 'agreement among raft nodes before linearized reading' (duration: 582.54018ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:11.545294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:11.06036Z","time spent":"484.926089ms","remote":"127.0.0.1:47644","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-09T14:20:11.545356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:10.962473Z","time spent":"582.873812ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:aggregate-to-admin\" "} {"level":"warn","ts":"2026-06-09T14:20:11.545553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:10.960509Z","time spent":"584.562606ms","remote":"127.0.0.1:48016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T14:20:12.143175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.747983ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-09T14:20:12.14329Z","caller":"traceutil/trace.go:171","msg":"trace[520813394] linearizableReadLoop","detail":"{readStateIndex:119; appliedIndex:118; }","duration":"589.523117ms","start":"2026-06-09T14:20:11.55375Z","end":"2026-06-09T14:20:12.143273Z","steps":["trace[520813394] 'read index received' (duration: 190.398099ms)","trace[520813394] 'applied index is now lower than readState.Index' (duration: 399.123928ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T14:20:12.143339Z","caller":"traceutil/trace.go:171","msg":"trace[1032564831] transaction","detail":"{read_only:false; response_revision:114; number_of_response:1; }","duration":"590.680846ms","start":"2026-06-09T14:20:11.55261Z","end":"2026-06-09T14:20:12.143291Z","steps":["trace[1032564831] 'process raft request' (duration: 191.599319ms)","trace[1032564831] 'compare' (duration: 398.548552ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T14:20:12.143411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.659048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T14:20:12.143441Z","caller":"traceutil/trace.go:171","msg":"trace[1024897874] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:0; response_revision:114; }","duration":"589.691638ms","start":"2026-06-09T14:20:11.55374Z","end":"2026-06-09T14:20:12.143431Z","steps":["trace[1024897874] 'agreement among raft nodes before linearized reading' (duration: 589.616847ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:12.143484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:11.553703Z","time spent":"589.773378ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:aggregate-to-view\" "} {"level":"warn","ts":"2026-06-09T14:20:12.143599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:11.552589Z","time spent":"590.834167ms","remote":"127.0.0.1:48016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T14:20:12.956662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.406492ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-09T14:20:12.956924Z","caller":"traceutil/trace.go:171","msg":"trace[983852358] linearizableReadLoop","detail":"{readStateIndex:120; appliedIndex:119; }","duration":"605.84927ms","start":"2026-06-09T14:20:12.351051Z","end":"2026-06-09T14:20:12.9569Z","steps":["trace[983852358] 'read index received' (duration: 421.031866ms)","trace[983852358] 'applied index is now lower than readState.Index' (duration: 184.814984ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T14:20:12.956965Z","caller":"traceutil/trace.go:171","msg":"trace[1650035743] transaction","detail":"{read_only:false; response_revision:115; number_of_response:1; }","duration":"804.988188ms","start":"2026-06-09T14:20:12.151928Z","end":"2026-06-09T14:20:12.956916Z","steps":["trace[1650035743] 'process raft request' (duration: 620.250354ms)","trace[1650035743] 'compare' (duration: 184.260081ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T14:20:12.957132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:12.151911Z","time spent":"805.149819ms","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T14:20:12.957266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.206453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-09T14:20:12.957348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.34608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-09T14:20:12.957391Z","caller":"traceutil/trace.go:171","msg":"trace[1147199483] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:115; }","duration":"396.414271ms","start":"2026-06-09T14:20:12.560964Z","end":"2026-06-09T14:20:12.957378Z","steps":["trace[1147199483] 'agreement among raft nodes before linearized reading' (duration: 396.31405ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:12.957419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:12.560905Z","time spent":"396.508501ms","remote":"127.0.0.1:47646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-09T14:20:12.9575Z","caller":"traceutil/trace.go:171","msg":"trace[894189923] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:115; }","duration":"606.348844ms","start":"2026-06-09T14:20:12.350999Z","end":"2026-06-09T14:20:12.957347Z","steps":["trace[894189923] 'agreement among raft nodes before linearized reading' (duration: 606.128053ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:12.957601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:12.350979Z","time spent":"606.603446ms","remote":"127.0.0.1:47914","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-09T14:20:18.596959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.956957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-09T14:20:18.597063Z","caller":"traceutil/trace.go:171","msg":"trace[2102072707] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:324; }","duration":"165.080818ms","start":"2026-06-09T14:20:18.431957Z","end":"2026-06-09T14:20:18.597038Z","steps":["trace[2102072707] 'range keys from in-memory index tree' (duration: 164.876977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:18.596955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.106294ms","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-09T14:20:18.597196Z","caller":"traceutil/trace.go:171","msg":"trace[736842929] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:324; }","duration":"108.391686ms","start":"2026-06-09T14:20:18.488782Z","end":"2026-06-09T14:20:18.597173Z","steps":["trace[736842929] 'range keys from in-memory index tree' (duration: 107.972583ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:33.989026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.566222ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T14:20:33.98912Z","caller":"traceutil/trace.go:171","msg":"trace[1716178182] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"216.483404ms","start":"2026-06-09T14:20:33.772619Z","end":"2026-06-09T14:20:33.989102Z","steps":["trace[1716178182] 'process raft request' (duration: 77.630239ms)","trace[1716178182] 'compare' (duration: 138.376191ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T14:20:34.045875Z","caller":"traceutil/trace.go:171","msg":"trace[1320789665] linearizableReadLoop","detail":"{readStateIndex:457; appliedIndex:455; }","duration":"272.238977ms","start":"2026-06-09T14:20:33.773608Z","end":"2026-06-09T14:20:34.045847Z","steps":["trace[1320789665] 'read index received' (duration: 76.660332ms)","trace[1320789665] 'applied index is now lower than readState.Index' (duration: 195.577745ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T14:20:34.045922Z","caller":"traceutil/trace.go:171","msg":"trace[1404488581] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"272.54382ms","start":"2026-06-09T14:20:33.77334Z","end":"2026-06-09T14:20:34.045884Z","steps":["trace[1404488581] 'process raft request' (duration: 272.387339ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:34.046113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.763467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-06-09T14:20:34.046152Z","caller":"traceutil/trace.go:171","msg":"trace[841391389] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:443; }","duration":"270.855437ms","start":"2026-06-09T14:20:33.775285Z","end":"2026-06-09T14:20:34.04614Z","steps":["trace[841391389] 'agreement among raft nodes before linearized reading' (duration: 270.703286ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:34.04615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.506379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-qtmc2\" ","response":"range_response_count:1 size:4016"} {"level":"info","ts":"2026-06-09T14:20:34.046245Z","caller":"traceutil/trace.go:171","msg":"trace[1878244594] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-qtmc2; range_end:; response_count:1; response_revision:443; }","duration":"272.660631ms","start":"2026-06-09T14:20:33.77356Z","end":"2026-06-09T14:20:34.04622Z","steps":["trace[1878244594] 'agreement among raft nodes before linearized reading' (duration: 272.414439ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:46.849267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.011488ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T14:20:46.849435Z","caller":"traceutil/trace.go:171","msg":"trace[471796268] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"197.116275ms","start":"2026-06-09T14:20:46.6523Z","end":"2026-06-09T14:20:46.849416Z","steps":["trace[471796268] 'process raft request' (duration: 42.873525ms)","trace[471796268] 'compare' (duration: 153.893823ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T14:20:46.849653Z","caller":"traceutil/trace.go:171","msg":"trace[253527730] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:566; }","duration":"177.00722ms","start":"2026-06-09T14:20:46.672612Z","end":"2026-06-09T14:20:46.849619Z","steps":["trace[253527730] 'read index received' (duration: 22.57387ms)","trace[253527730] 'applied index is now lower than readState.Index' (duration: 154.43207ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T14:20:46.849675Z","caller":"traceutil/trace.go:171","msg":"trace[793303800] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"188.639483ms","start":"2026-06-09T14:20:46.661011Z","end":"2026-06-09T14:20:46.84965Z","steps":["trace[793303800] 'process raft request' (duration: 188.357368ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:46.849837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.21897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:995"} {"level":"info","ts":"2026-06-09T14:20:46.849878Z","caller":"traceutil/trace.go:171","msg":"trace[832713586] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:548; }","duration":"177.289994ms","start":"2026-06-09T14:20:46.672577Z","end":"2026-06-09T14:20:46.849867Z","steps":["trace[832713586] 'agreement among raft nodes before linearized reading' (duration: 177.165438ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:47.541879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.508294ms","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-09T14:20:47.542008Z","caller":"traceutil/trace.go:171","msg":"trace[548785493] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:548; }","duration":"313.657011ms","start":"2026-06-09T14:20:47.228332Z","end":"2026-06-09T14:20:47.541989Z","steps":["trace[548785493] 'range keys from in-memory index tree' (duration: 313.471251ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:47.542306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.062798ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T14:20:47.542509Z","caller":"traceutil/trace.go:171","msg":"trace[1025843438] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"857.229152ms","start":"2026-06-09T14:20:46.685254Z","end":"2026-06-09T14:20:47.542484Z","steps":["trace[1025843438] 'process raft request' (duration: 287.9006ms)","trace[1025843438] 'compare' (duration: 568.815876ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T14:20:47.542609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:46.685239Z","time spent":"857.332756ms","remote":"127.0.0.1:47698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T14:20:47.543037Z","caller":"traceutil/trace.go:171","msg":"trace[610487778] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"681.696775ms","start":"2026-06-09T14:20:46.86133Z","end":"2026-06-09T14:20:47.543027Z","steps":["trace[610487778] 'process raft request' (duration: 681.653973ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:47.543101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:46.861238Z","time spent":"681.831972ms","remote":"127.0.0.1:47698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T14:20:47.543267Z","caller":"traceutil/trace.go:171","msg":"trace[522181289] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"683.758379ms","start":"2026-06-09T14:20:46.859499Z","end":"2026-06-09T14:20:47.543258Z","steps":["trace[522181289] 'process raft request' (duration: 683.434673ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T14:20:47.543354Z","caller":"traceutil/trace.go:171","msg":"trace[504457472] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"853.583509ms","start":"2026-06-09T14:20:46.689732Z","end":"2026-06-09T14:20:47.543316Z","steps":["trace[504457472] 'process raft request' (duration: 852.723276ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T14:20:47.543278Z","caller":"traceutil/trace.go:171","msg":"trace[1190989017] linearizableReadLoop","detail":"{readStateIndex:570; appliedIndex:568; }","duration":"693.467954ms","start":"2026-06-09T14:20:46.849738Z","end":"2026-06-09T14:20:47.543206Z","steps":["trace[1190989017] 'read index received' (duration: 123.47474ms)","trace[1190989017] 'applied index is now lower than readState.Index' (duration: 569.987664ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T14:20:47.543436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.644789ms","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-09T14:20:47.543459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:46.689701Z","time spent":"853.704805ms","remote":"127.0.0.1:47698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T14:20:47.543482Z","caller":"traceutil/trace.go:171","msg":"trace[2011383018] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:552; }","duration":"803.720183ms","start":"2026-06-09T14:20:46.739747Z","end":"2026-06-09T14:20:47.543468Z","steps":["trace[2011383018] 'agreement among raft nodes before linearized reading' (duration: 803.579916ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:47.543513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:46.739734Z","time spent":"803.772426ms","remote":"127.0.0.1:47914","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":"warn","ts":"2026-06-09T14:20:47.543708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.55604ms","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-09T14:20:47.543739Z","caller":"traceutil/trace.go:171","msg":"trace[1838818374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:552; }","duration":"377.615633ms","start":"2026-06-09T14:20:47.166115Z","end":"2026-06-09T14:20:47.543731Z","steps":["trace[1838818374] 'agreement among raft nodes before linearized reading' (duration: 377.519168ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:47.54373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.054136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T14:20:47.543764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:47.1661Z","time spent":"377.657325ms","remote":"127.0.0.1:47914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-09T14:20:47.543776Z","caller":"traceutil/trace.go:171","msg":"trace[1749074791] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:552; }","duration":"503.154301ms","start":"2026-06-09T14:20:47.040607Z","end":"2026-06-09T14:20:47.543762Z","steps":["trace[1749074791] 'agreement among raft nodes before linearized reading' (duration: 503.023495ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:47.543849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:47.040588Z","time spent":"503.250666ms","remote":"127.0.0.1:47644","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-09T14:20:47.543884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.023686ms","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-09T14:20:47.543895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:46.859476Z","time spent":"683.816321ms","remote":"127.0.0.1:47698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10855,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T14:20:47.543926Z","caller":"traceutil/trace.go:171","msg":"trace[108321958] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:552; }","duration":"448.098759ms","start":"2026-06-09T14:20:47.095815Z","end":"2026-06-09T14:20:47.543914Z","steps":["trace[108321958] 'agreement among raft nodes before linearized reading' (duration: 447.950152ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:47.543964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:47.095797Z","time spent":"448.158582ms","remote":"127.0.0.1:47914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-09T14:20:47.544038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"871.108425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:1019"} {"level":"info","ts":"2026-06-09T14:20:47.54412Z","caller":"traceutil/trace.go:171","msg":"trace[571078134] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:552; }","duration":"871.459173ms","start":"2026-06-09T14:20:46.672638Z","end":"2026-06-09T14:20:47.544097Z","steps":["trace[571078134] 'agreement among raft nodes before linearized reading' (duration: 870.812041ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:47.544168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:46.672634Z","time spent":"871.521416ms","remote":"127.0.0.1:48220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1042,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io\" "} {"level":"warn","ts":"2026-06-09T14:20:47.998418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.82318ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T14:20:47.998554Z","caller":"traceutil/trace.go:171","msg":"trace[1554302906] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"448.341452ms","start":"2026-06-09T14:20:47.550187Z","end":"2026-06-09T14:20:47.998528Z","steps":["trace[1554302906] 'process raft request' (duration: 281.308601ms)","trace[1554302906] 'compare' (duration: 166.634601ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T14:20:47.998643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:47.550162Z","time spent":"448.439856ms","remote":"127.0.0.1:47914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T14:20:48.003026Z","caller":"traceutil/trace.go:171","msg":"trace[1522222422] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"452.78495ms","start":"2026-06-09T14:20:47.550228Z","end":"2026-06-09T14:20:48.003012Z","steps":["trace[1522222422] 'process raft request' (duration: 452.697146ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:48.003086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:47.550208Z","time spent":"452.849274ms","remote":"127.0.0.1:47914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T14:20:48.003766Z","caller":"traceutil/trace.go:171","msg":"trace[2008175147] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"450.022144ms","start":"2026-06-09T14:20:47.553733Z","end":"2026-06-09T14:20:48.003755Z","steps":["trace[2008175147] 'process raft request' (duration: 449.54577ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:48.003833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:47.553724Z","time spent":"450.072446ms","remote":"127.0.0.1:47698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31102,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T14:20:48.003903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.950152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-09T14:20:48.004008Z","caller":"traceutil/trace.go:171","msg":"trace[1003251110] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:559; }","duration":"155.10919ms","start":"2026-06-09T14:20:47.848888Z","end":"2026-06-09T14:20:48.003997Z","steps":["trace[1003251110] 'agreement among raft nodes before linearized reading' (duration: 154.90499ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T14:20:48.003748Z","caller":"traceutil/trace.go:171","msg":"trace[1221645511] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:573; }","duration":"154.787064ms","start":"2026-06-09T14:20:47.848941Z","end":"2026-06-09T14:20:48.003728Z","steps":["trace[1221645511] 'read index received' (duration: 154.010295ms)","trace[1221645511] 'applied index is now lower than readState.Index' (duration: 775.799µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T14:20:48.004193Z","caller":"traceutil/trace.go:171","msg":"trace[1163710106] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"453.620721ms","start":"2026-06-09T14:20:47.550544Z","end":"2026-06-09T14:20:48.004165Z","steps":["trace[1163710106] 'process raft request' (duration: 452.439503ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T14:20:48.00436Z","caller":"traceutil/trace.go:171","msg":"trace[1556522892] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"407.618947ms","start":"2026-06-09T14:20:47.596712Z","end":"2026-06-09T14:20:48.004331Z","steps":["trace[1556522892] 'process raft request' (duration: 406.771295ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:48.004519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:47.596683Z","time spent":"407.767734ms","remote":"127.0.0.1:47698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T14:20:48.004557Z","caller":"traceutil/trace.go:171","msg":"trace[1332564919] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"402.156297ms","start":"2026-06-09T14:20:47.602349Z","end":"2026-06-09T14:20:48.004505Z","steps":["trace[1332564919] 'process raft request' (duration: 401.245992ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:48.004554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:47.550516Z","time spent":"453.822222ms","remote":"127.0.0.1:47914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T14:20:48.004678Z","caller":"traceutil/trace.go:171","msg":"trace[1986635027] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"435.237662ms","start":"2026-06-09T14:20:47.569429Z","end":"2026-06-09T14:20:48.004666Z","steps":["trace[1986635027] 'process raft request' (duration: 433.99023ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:48.004751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:47.569403Z","time spent":"435.306656ms","remote":"127.0.0.1:47698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T14:20:48.004821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:47.602319Z","time spent":"402.325186ms","remote":"127.0.0.1:47698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T14:20:49.166209Z","caller":"traceutil/trace.go:171","msg":"trace[835706988] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"691.521975ms","start":"2026-06-09T14:20:48.474658Z","end":"2026-06-09T14:20:49.166179Z","steps":["trace[835706988] 'process raft request' (duration: 668.82872ms)","trace[835706988] 'compare' (duration: 22.411762ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T14:20:49.166333Z","caller":"traceutil/trace.go:171","msg":"trace[237476726] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"673.041713ms","start":"2026-06-09T14:20:48.493253Z","end":"2026-06-09T14:20:49.166295Z","steps":["trace[237476726] 'process raft request' (duration: 672.845513ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:49.166396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:48.474637Z","time spent":"691.673544ms","remote":"127.0.0.1:47698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98689,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T14:20:49.166513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:48.491846Z","time spent":"674.574078ms","remote":"127.0.0.1:47698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18041,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T14:20:49.166527Z","caller":"traceutil/trace.go:171","msg":"trace[582148506] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"515.537307ms","start":"2026-06-09T14:20:48.65098Z","end":"2026-06-09T14:20:49.166517Z","steps":["trace[582148506] 'process raft request' (duration: 515.328167ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:49.16659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:48.650948Z","time spent":"515.61922ms","remote":"127.0.0.1:47698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T14:20:49.186374Z","caller":"traceutil/trace.go:171","msg":"trace[1706676249] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:603; }","duration":"148.190496ms","start":"2026-06-09T14:20:49.038162Z","end":"2026-06-09T14:20:49.186353Z","steps":["trace[1706676249] 'read index received' (duration: 106.369776ms)","trace[1706676249] 'applied index is now lower than readState.Index' (duration: 41.8194ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T14:20:49.186468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.29655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T14:20:49.186501Z","caller":"traceutil/trace.go:171","msg":"trace[804174912] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"148.340983ms","start":"2026-06-09T14:20:49.038152Z","end":"2026-06-09T14:20:49.186493Z","steps":["trace[804174912] 'agreement among raft nodes before linearized reading' (duration: 148.27405ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T14:20:50.136008Z","caller":"traceutil/trace.go:171","msg":"trace[1936206856] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:624; }","duration":"112.33349ms","start":"2026-06-09T14:20:50.023628Z","end":"2026-06-09T14:20:50.135961Z","steps":["trace[1936206856] 'read index received' (duration: 109.81906ms)","trace[1936206856] 'applied index is now lower than readState.Index' (duration: 2.51272ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T14:20:50.136323Z","caller":"traceutil/trace.go:171","msg":"trace[1781568446] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"125.188353ms","start":"2026-06-09T14:20:50.011099Z","end":"2026-06-09T14:20:50.136287Z","steps":["trace[1781568446] 'process raft request' (duration: 122.376709ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:50.136512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.841234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-09T14:20:50.136571Z","caller":"traceutil/trace.go:171","msg":"trace[1030419269] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:604; }","duration":"112.96527ms","start":"2026-06-09T14:20:50.023588Z","end":"2026-06-09T14:20:50.136554Z","steps":["trace[1030419269] 'agreement among raft nodes before linearized reading' (duration: 112.685947ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T14:20:55.72061Z","caller":"traceutil/trace.go:171","msg":"trace[1081059079] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"416.546423ms","start":"2026-06-09T14:20:55.304026Z","end":"2026-06-09T14:20:55.720573Z","steps":["trace[1081059079] 'process raft request' (duration: 416.326204ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:55.72082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:55.304004Z","time spent":"416.714181ms","remote":"127.0.0.1:47842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T14:20:56.199953Z","caller":"traceutil/trace.go:171","msg":"trace[1057210642] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:664; }","duration":"167.72565ms","start":"2026-06-09T14:20:56.0322Z","end":"2026-06-09T14:20:56.199926Z","steps":["trace[1057210642] 'read index received' (duration: 167.514021ms)","trace[1057210642] 'applied index is now lower than readState.Index' (duration: 210.169µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T14:20:56.200087Z","caller":"traceutil/trace.go:171","msg":"trace[499709388] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"321.896911ms","start":"2026-06-09T14:20:55.878147Z","end":"2026-06-09T14:20:56.200044Z","steps":["trace[499709388] 'process raft request' (duration: 321.604209ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:56.200234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.015642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-09T14:20:56.200279Z","caller":"traceutil/trace.go:171","msg":"trace[2001875631] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:643; }","duration":"168.143258ms","start":"2026-06-09T14:20:56.032123Z","end":"2026-06-09T14:20:56.200266Z","steps":["trace[2001875631] 'agreement among raft nodes before linearized reading' (duration: 167.967531ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:56.200316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T14:20:55.878112Z","time spent":"322.078279ms","remote":"127.0.0.1:47914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T14:20:56.200524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.387208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T14:20:56.200615Z","caller":"traceutil/trace.go:171","msg":"trace[271551812] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"159.520075ms","start":"2026-06-09T14:20:56.041071Z","end":"2026-06-09T14:20:56.200591Z","steps":["trace[271551812] 'agreement among raft nodes before linearized reading' (duration: 159.353137ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:20:56.200672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.961849ms","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-09T14:20:56.200718Z","caller":"traceutil/trace.go:171","msg":"trace[1534736597] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:643; }","duration":"159.027344ms","start":"2026-06-09T14:20:56.041676Z","end":"2026-06-09T14:20:56.200703Z","steps":["trace[1534736597] 'agreement among raft nodes before linearized reading' (duration: 158.886936ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T14:21:04.362059Z","caller":"traceutil/trace.go:171","msg":"trace[264753418] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"142.524388ms","start":"2026-06-09T14:21:04.21949Z","end":"2026-06-09T14:21:04.362015Z","steps":["trace[264753418] 'process raft request' (duration: 120.973862ms)","trace[264753418] 'compare' (duration: 20.91163ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T14:21:13.687004Z","caller":"traceutil/trace.go:171","msg":"trace[245627204] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"268.858494ms","start":"2026-06-09T14:21:13.418103Z","end":"2026-06-09T14:21:13.686961Z","steps":["trace[245627204] 'process raft request' (duration: 268.623066ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T14:23:33.218999Z","caller":"traceutil/trace.go:171","msg":"trace[1318952101] linearizableReadLoop","detail":"{readStateIndex:1497; appliedIndex:1496; }","duration":"122.24518ms","start":"2026-06-09T14:23:33.096726Z","end":"2026-06-09T14:23:33.218971Z","steps":["trace[1318952101] 'read index received' (duration: 122.065727ms)","trace[1318952101] 'applied index is now lower than readState.Index' (duration: 178.463µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T14:23:33.219144Z","caller":"traceutil/trace.go:171","msg":"trace[1872824] transaction","detail":"{read_only:false; response_revision:1438; number_of_response:1; }","duration":"123.296515ms","start":"2026-06-09T14:23:33.095831Z","end":"2026-06-09T14:23:33.219128Z","steps":["trace[1872824] 'process raft request' (duration: 122.994791ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:23:33.219341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.390892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/cilium-config-agent\" ","response":"range_response_count:1 size:695"} {"level":"info","ts":"2026-06-09T14:23:33.219438Z","caller":"traceutil/trace.go:171","msg":"trace[1156276229] range","detail":"{range_begin:/registry/roles/kube-system/cilium-config-agent; range_end:; response_count:1; response_revision:1438; }","duration":"100.523443ms","start":"2026-06-09T14:23:33.118892Z","end":"2026-06-09T14:23:33.219415Z","steps":["trace[1156276229] 'agreement among raft nodes before linearized reading' (duration: 100.362341ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T14:23:33.22009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.351646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:3760"} {"level":"info","ts":"2026-06-09T14:23:33.220165Z","caller":"traceutil/trace.go:171","msg":"trace[1057762585] range","detail":"{range_begin:/registry/deployments/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:1438; }","duration":"123.443637ms","start":"2026-06-09T14:23:33.0967Z","end":"2026-06-09T14:23:33.220143Z","steps":["trace[1057762585] 'agreement among raft nodes before linearized reading' (duration: 123.239814ms)"],"step_count":1}