{"level":"warn","ts":"2026-05-05T06:46:15.169472Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T06:46:15.169597Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.78: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.78:2380","--initial-cluster=instance=https://199.204.45.78:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.78:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.78: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-05-05T06:46:15.169681Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T06:46:15.169695Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-05-05T06:46:15.169722Z","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-05-05T06:46:15.170322Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"]} {"level":"info","ts":"2026-05-05T06:46:15.170405Z","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.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.78: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-05-05T06:46:15.174926Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.310962ms"} {"level":"info","ts":"2026-05-05T06:46:15.181912Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6eb8766b1ec86e92","cluster-id":"9bbfe9e5d45d3718"} {"level":"info","ts":"2026-05-05T06:46:15.18203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T06:46:15.18206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 0"} {"level":"info","ts":"2026-05-05T06:46:15.182099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6eb8766b1ec86e92 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-05T06:46:15.182131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 1"} {"level":"info","ts":"2026-05-05T06:46:15.18218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"warn","ts":"2026-05-05T06:46:15.190317Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T06:46:15.194701Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T06:46:15.198771Z","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-05-05T06:46:15.201688Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6eb8766b1ec86e92","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-05T06:46:15.202309Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6eb8766b1ec86e92","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-05T06:46:15.20258Z","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-05-05T06:46:15.203401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"info","ts":"2026-05-05T06:46:15.203647Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","added-peer-id":"6eb8766b1ec86e92","added-peer-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-05-05T06:46:15.202685Z","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-05-05T06:46:15.203776Z","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-05-05T06:46:15.20701Z","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-05-05T06:46:15.20733Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6eb8766b1ec86e92","initial-advertise-peer-urls":["https://199.204.45.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-05T06:46:15.207395Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T06:46:15.208524Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-05-05T06:46:15.208562Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-05-05T06:46:15.983137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T06:46:15.98332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T06:46:15.983357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgPreVoteResp from 6eb8766b1ec86e92 at term 1"} {"level":"info","ts":"2026-05-05T06:46:15.983382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became candidate at term 2"} {"level":"info","ts":"2026-05-05T06:46:15.983394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgVoteResp from 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-05-05T06:46:15.983414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became leader at term 2"} {"level":"info","ts":"2026-05-05T06:46:15.983437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6eb8766b1ec86e92 elected leader 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-05-05T06:46:15.984881Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T06:46:15.986133Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T06:46:15.98623Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T06:46:15.986295Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T06:46:15.986318Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T06:46:15.986331Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T06:46:15.986321Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6eb8766b1ec86e92","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.78:2379]}","request-path":"/0/members/6eb8766b1ec86e92/attributes","cluster-id":"9bbfe9e5d45d3718","publish-timeout":"7s"} {"level":"info","ts":"2026-05-05T06:46:15.987119Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T06:46:15.987152Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-05T06:46:15.988949Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-05T06:46:15.994826Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.78:2379"} {"level":"info","ts":"2026-05-05T06:46:54.899069Z","caller":"traceutil/trace.go:171","msg":"trace[458980961] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"111.805093ms","start":"2026-05-05T06:46:54.787251Z","end":"2026-05-05T06:46:54.899057Z","steps":["trace[458980961] 'process raft request' (duration: 111.587398ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:46:55.387652Z","caller":"traceutil/trace.go:171","msg":"trace[1938266358] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"154.366018ms","start":"2026-05-05T06:46:55.233261Z","end":"2026-05-05T06:46:55.387627Z","steps":["trace[1938266358] 'process raft request' (duration: 154.241895ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:46:55.398854Z","caller":"traceutil/trace.go:171","msg":"trace[1636351985] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"158.329787ms","start":"2026-05-05T06:46:55.24051Z","end":"2026-05-05T06:46:55.39884Z","steps":["trace[1636351985] 'process raft request' (duration: 158.191563ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:46:55.399024Z","caller":"traceutil/trace.go:171","msg":"trace[1755896134] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"147.727049ms","start":"2026-05-05T06:46:55.251281Z","end":"2026-05-05T06:46:55.399008Z","steps":["trace[1755896134] 'process raft request' (duration: 147.470553ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:46:55.399102Z","caller":"traceutil/trace.go:171","msg":"trace[156375984] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"160.435202ms","start":"2026-05-05T06:46:55.238657Z","end":"2026-05-05T06:46:55.399092Z","steps":["trace[156375984] 'process raft request' (duration: 159.97886ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:46:55.399204Z","caller":"traceutil/trace.go:171","msg":"trace[775242596] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"147.221048ms","start":"2026-05-05T06:46:55.251944Z","end":"2026-05-05T06:46:55.399165Z","steps":["trace[775242596] 'process raft request' (duration: 146.830447ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:46:55.399631Z","caller":"traceutil/trace.go:171","msg":"trace[1246929142] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"105.574176ms","start":"2026-05-05T06:46:55.294048Z","end":"2026-05-05T06:46:55.399622Z","steps":["trace[1246929142] 'process raft request' (duration: 105.547696ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:46:55.399635Z","caller":"traceutil/trace.go:171","msg":"trace[660981098] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"143.236626ms","start":"2026-05-05T06:46:55.256385Z","end":"2026-05-05T06:46:55.399622Z","steps":["trace[660981098] 'process raft request' (duration: 143.117033ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:46:55.399725Z","caller":"traceutil/trace.go:171","msg":"trace[1528691488] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"133.633945ms","start":"2026-05-05T06:46:55.266086Z","end":"2026-05-05T06:46:55.39972Z","steps":["trace[1528691488] 'process raft request' (duration: 133.44516ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:46:55.399768Z","caller":"traceutil/trace.go:171","msg":"trace[922813297] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"120.701327ms","start":"2026-05-05T06:46:55.279064Z","end":"2026-05-05T06:46:55.399765Z","steps":["trace[922813297] 'process raft request' (duration: 120.497002ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:46:55.399805Z","caller":"traceutil/trace.go:171","msg":"trace[1182515746] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"144.059368ms","start":"2026-05-05T06:46:55.255741Z","end":"2026-05-05T06:46:55.399801Z","steps":["trace[1182515746] 'process raft request' (duration: 143.709239ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:46:55.399093Z","caller":"traceutil/trace.go:171","msg":"trace[1478980] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"151.204637ms","start":"2026-05-05T06:46:55.247773Z","end":"2026-05-05T06:46:55.398977Z","steps":["trace[1478980] 'process raft request' (duration: 150.950611ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:47:00.694478Z","caller":"traceutil/trace.go:171","msg":"trace[900247074] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"103.819751ms","start":"2026-05-05T06:47:00.590628Z","end":"2026-05-05T06:47:00.694448Z","steps":["trace[900247074] 'process raft request' (duration: 103.245267ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:47:01.863942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.908116ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T06:47:01.864219Z","caller":"traceutil/trace.go:171","msg":"trace[1421132049] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"302.644461ms","start":"2026-05-05T06:47:01.561526Z","end":"2026-05-05T06:47:01.864171Z","steps":["trace[1421132049] 'process raft request' (duration: 27.624128ms)","trace[1421132049] 'compare' (duration: 273.725861ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:47:01.864476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:47:01.56151Z","time spent":"302.833707ms","remote":"127.0.0.1:33122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:47:02.030162Z","caller":"traceutil/trace.go:171","msg":"trace[1357785801] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"234.068851ms","start":"2026-05-05T06:47:01.796046Z","end":"2026-05-05T06:47:02.030115Z","steps":["trace[1357785801] 'process raft request' (duration: 233.318062ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:47:02.749103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.451058ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T06:47:02.749284Z","caller":"traceutil/trace.go:171","msg":"trace[1054146899] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"661.417641ms","start":"2026-05-05T06:47:02.087851Z","end":"2026-05-05T06:47:02.749269Z","steps":["trace[1054146899] 'process raft request' (duration: 661.353979ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:47:02.749365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:47:02.087821Z","time spent":"661.500823ms","remote":"127.0.0.1:33096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T06:47:02.749642Z","caller":"traceutil/trace.go:171","msg":"trace[1736049250] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"880.611815ms","start":"2026-05-05T06:47:01.869018Z","end":"2026-05-05T06:47:02.74963Z","steps":["trace[1736049250] 'process raft request' (duration: 272.553331ms)","trace[1736049250] 'compare' (duration: 606.880064ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:47:02.749697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:47:01.869001Z","time spent":"880.666006ms","remote":"127.0.0.1:33122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:47:02.749783Z","caller":"traceutil/trace.go:171","msg":"trace[1228628293] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:660; }","duration":"752.698625ms","start":"2026-05-05T06:47:01.997051Z","end":"2026-05-05T06:47:02.749749Z","steps":["trace[1228628293] 'read index received' (duration: 31.789512ms)","trace[1228628293] 'applied index is now lower than readState.Index' (duration: 720.906423ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:47:02.750019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.920116ms","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-05-05T06:47:02.750054Z","caller":"traceutil/trace.go:171","msg":"trace[1498087723] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:642; }","duration":"347.993807ms","start":"2026-05-05T06:47:02.40205Z","end":"2026-05-05T06:47:02.750043Z","steps":["trace[1498087723] 'agreement among raft nodes before linearized reading' (duration: 347.875454ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:47:02.750085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:47:02.40203Z","time spent":"348.047559ms","remote":"127.0.0.1:33122","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":"warn","ts":"2026-05-05T06:47:02.750093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"753.028103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-htt6z\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-05T06:47:02.750156Z","caller":"traceutil/trace.go:171","msg":"trace[623403653] range","detail":"{range_begin:/registry/pods/kube-system/cilium-htt6z; range_end:; response_count:1; response_revision:642; }","duration":"753.162047ms","start":"2026-05-05T06:47:01.996976Z","end":"2026-05-05T06:47:02.750138Z","steps":["trace[623403653] 'agreement among raft nodes before linearized reading' (duration: 752.932582ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:47:02.750203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:47:01.996962Z","time spent":"753.227749ms","remote":"127.0.0.1:33036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-htt6z\" "} {"level":"info","ts":"2026-05-05T06:47:16.913512Z","caller":"traceutil/trace.go:171","msg":"trace[994426870] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"100.717772ms","start":"2026-05-05T06:47:16.812759Z","end":"2026-05-05T06:47:16.913476Z","steps":["trace[994426870] 'process raft request' (duration: 100.025675ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:47:51.200274Z","caller":"traceutil/trace.go:171","msg":"trace[1796757024] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"111.13598ms","start":"2026-05-05T06:47:51.089083Z","end":"2026-05-05T06:47:51.200219Z","steps":["trace[1796757024] 'process raft request' (duration: 110.842603ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:48:30.748927Z","caller":"traceutil/trace.go:171","msg":"trace[2020490075] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"335.036269ms","start":"2026-05-05T06:48:30.41387Z","end":"2026-05-05T06:48:30.748906Z","steps":["trace[2020490075] 'process raft request' (duration: 334.901016ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:48:30.749053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:48:30.413859Z","time spent":"335.131461ms","remote":"127.0.0.1:33122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:48:47.73968Z","caller":"traceutil/trace.go:171","msg":"trace[348704929] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"160.691566ms","start":"2026-05-05T06:48:47.578965Z","end":"2026-05-05T06:48:47.739657Z","steps":["trace[348704929] 'process raft request' (duration: 146.9217ms)","trace[348704929] 'compare' (duration: 13.660464ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:48:47.963696Z","caller":"traceutil/trace.go:171","msg":"trace[1723661984] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"234.560666ms","start":"2026-05-05T06:48:47.729114Z","end":"2026-05-05T06:48:47.963675Z","steps":["trace[1723661984] 'process raft request' (duration: 234.502845ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:48:47.963775Z","caller":"traceutil/trace.go:171","msg":"trace[2000404075] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"383.989489ms","start":"2026-05-05T06:48:47.579754Z","end":"2026-05-05T06:48:47.963744Z","steps":["trace[2000404075] 'process raft request' (duration: 339.69363ms)","trace[2000404075] 'compare' (duration: 43.968111ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:48:47.963902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:48:47.579741Z","time spent":"384.092751ms","remote":"127.0.0.1:33122","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-05-05T06:48:47.96408Z","caller":"traceutil/trace.go:171","msg":"trace[1028377894] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"383.946289ms","start":"2026-05-05T06:48:47.580118Z","end":"2026-05-05T06:48:47.964064Z","steps":["trace[1028377894] 'process raft request' (duration: 383.411985ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:48:47.964198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:48:47.580105Z","time spent":"384.015271ms","remote":"127.0.0.1:33122","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-05-05T06:48:47.964412Z","caller":"traceutil/trace.go:171","msg":"trace[894633739] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"362.597968ms","start":"2026-05-05T06:48:47.601802Z","end":"2026-05-05T06:48:47.964399Z","steps":["trace[894633739] 'process raft request' (duration: 361.770247ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:48:47.964486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:48:47.601784Z","time spent":"362.66445ms","remote":"127.0.0.1:33122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:48:59.953022Z","caller":"traceutil/trace.go:171","msg":"trace[1375764084] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"162.629464ms","start":"2026-05-05T06:48:59.790367Z","end":"2026-05-05T06:48:59.952996Z","steps":["trace[1375764084] 'process raft request' (duration: 162.432449ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:49:00.288846Z","caller":"traceutil/trace.go:171","msg":"trace[1119515464] linearizableReadLoop","detail":"{readStateIndex:1412; appliedIndex:1411; }","duration":"280.658521ms","start":"2026-05-05T06:49:00.008151Z","end":"2026-05-05T06:49:00.288809Z","steps":["trace[1119515464] 'read index received' (duration: 280.349784ms)","trace[1119515464] 'applied index is now lower than readState.Index' (duration: 307.177µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:49:00.288936Z","caller":"traceutil/trace.go:171","msg":"trace[467039541] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"284.600767ms","start":"2026-05-05T06:49:00.004303Z","end":"2026-05-05T06:49:00.288904Z","steps":["trace[467039541] 'process raft request' (duration: 284.247909ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:49:00.289062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.895376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T06:49:00.289155Z","caller":"traceutil/trace.go:171","msg":"trace[663568574] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1360; }","duration":"281.04853ms","start":"2026-05-05T06:49:00.008081Z","end":"2026-05-05T06:49:00.289129Z","steps":["trace[663568574] 'agreement among raft nodes before linearized reading' (duration: 280.874515ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:49:00.28924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.266733ms","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-05-05T06:49:00.289282Z","caller":"traceutil/trace.go:171","msg":"trace[1259388439] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1360; }","duration":"276.320055ms","start":"2026-05-05T06:49:00.012949Z","end":"2026-05-05T06:49:00.289269Z","steps":["trace[1259388439] 'agreement among raft nodes before linearized reading' (duration: 276.169901ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:49:00.289306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.866818ms","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-05-05T06:49:00.289349Z","caller":"traceutil/trace.go:171","msg":"trace[724834578] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1360; }","duration":"276.949291ms","start":"2026-05-05T06:49:00.012387Z","end":"2026-05-05T06:49:00.289337Z","steps":["trace[724834578] 'agreement among raft nodes before linearized reading' (duration: 276.760506ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:49:00.289087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.537254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:49:00.289457Z","caller":"traceutil/trace.go:171","msg":"trace[1672416719] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1360; }","duration":"279.952803ms","start":"2026-05-05T06:49:00.009491Z","end":"2026-05-05T06:49:00.289444Z","steps":["trace[1672416719] 'agreement among raft nodes before linearized reading' (duration: 279.525063ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:49:00.289425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.216298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-05-05T06:49:00.289556Z","caller":"traceutil/trace.go:171","msg":"trace[698589871] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1360; }","duration":"179.372451ms","start":"2026-05-05T06:49:00.110168Z","end":"2026-05-05T06:49:00.28954Z","steps":["trace[698589871] 'agreement among raft nodes before linearized reading' (duration: 178.984172ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:49:00.429451Z","caller":"traceutil/trace.go:171","msg":"trace[1237990670] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"134.303304ms","start":"2026-05-05T06:49:00.295119Z","end":"2026-05-05T06:49:00.429422Z","steps":["trace[1237990670] 'process raft request' (duration: 118.801017ms)","trace[1237990670] 'compare' (duration: 15.344793ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:49:00.429641Z","caller":"traceutil/trace.go:171","msg":"trace[2111820432] transaction","detail":"{read_only:false; response_revision:1363; number_of_response:1; }","duration":"134.273813ms","start":"2026-05-05T06:49:00.295359Z","end":"2026-05-05T06:49:00.429633Z","steps":["trace[2111820432] 'process raft request' (duration: 134.025147ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:45.335585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.538674ms","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-05-05T06:50:45.335844Z","caller":"traceutil/trace.go:171","msg":"trace[1396888752] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1842; }","duration":"241.720038ms","start":"2026-05-05T06:50:45.093975Z","end":"2026-05-05T06:50:45.335695Z","steps":["trace[1396888752] 'range keys from in-memory index tree' (duration: 241.523064ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:50:46.015441Z","caller":"traceutil/trace.go:171","msg":"trace[676213660] linearizableReadLoop","detail":"{readStateIndex:1916; appliedIndex:1915; }","duration":"420.114271ms","start":"2026-05-05T06:50:45.595307Z","end":"2026-05-05T06:50:46.015421Z","steps":["trace[676213660] 'read index received' (duration: 419.965527ms)","trace[676213660] 'applied index is now lower than readState.Index' (duration: 147.984µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T06:50:46.015547Z","caller":"traceutil/trace.go:171","msg":"trace[1250318879] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"432.842594ms","start":"2026-05-05T06:50:45.582697Z","end":"2026-05-05T06:50:46.015539Z","steps":["trace[1250318879] 'process raft request' (duration: 432.596738ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:46.015643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:50:45.582684Z","time spent":"432.887365ms","remote":"127.0.0.1:33122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T06:50:46.015874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.558321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"} {"level":"info","ts":"2026-05-05T06:50:46.015948Z","caller":"traceutil/trace.go:171","msg":"trace[1165716584] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1843; }","duration":"420.653603ms","start":"2026-05-05T06:50:45.595277Z","end":"2026-05-05T06:50:46.015931Z","steps":["trace[1165716584] 'agreement among raft nodes before linearized reading' (duration: 420.52727ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:46.015992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:50:45.595257Z","time spent":"420.722335ms","remote":"127.0.0.1:33122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-05T06:50:46.653415Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967604374470368821,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T06:50:47.153608Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967604374470368821,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T06:50:47.641156Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.621076516s","expected-duration":"1s"} {"level":"info","ts":"2026-05-05T06:50:47.642095Z","caller":"traceutil/trace.go:171","msg":"trace[569967410] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"1.622154092s","start":"2026-05-05T06:50:46.01992Z","end":"2026-05-05T06:50:47.642074Z","steps":["trace[569967410] 'process raft request' (duration: 1.621633829s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:47.642207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:50:46.01988Z","time spent":"1.622266365s","remote":"127.0.0.1:33122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":519,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:50:47.650939Z","caller":"traceutil/trace.go:171","msg":"trace[987149296] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"1.629941304s","start":"2026-05-05T06:50:46.020964Z","end":"2026-05-05T06:50:47.650906Z","steps":["trace[987149296] 'process raft request' (duration: 1.62976052s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:47.651139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:50:46.020932Z","time spent":"1.630091128s","remote":"127.0.0.1:33122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:50:47.65131Z","caller":"traceutil/trace.go:171","msg":"trace[416856121] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"1.62972449s","start":"2026-05-05T06:50:46.02156Z","end":"2026-05-05T06:50:47.651285Z","steps":["trace[416856121] 'process raft request' (duration: 1.629284179s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:47.65149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:50:46.021549Z","time spent":"1.629861743s","remote":"127.0.0.1:33122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:50:47.651512Z","caller":"traceutil/trace.go:171","msg":"trace[351343211] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"854.193262ms","start":"2026-05-05T06:50:46.797289Z","end":"2026-05-05T06:50:47.651482Z","steps":["trace[351343211] 'process raft request' (duration: 853.837374ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:47.651625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:50:46.797263Z","time spent":"854.302575ms","remote":"127.0.0.1:33122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T06:50:47.651623Z","caller":"traceutil/trace.go:171","msg":"trace[13467520] linearizableReadLoop","detail":"{readStateIndex:1921; appliedIndex:1916; }","duration":"1.49850197s","start":"2026-05-05T06:50:46.153109Z","end":"2026-05-05T06:50:47.651611Z","steps":["trace[13467520] 'read index received' (duration: 1.488903815s)","trace[13467520] 'applied index is now lower than readState.Index' (duration: 9.597115ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:50:47.651842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.338171415s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:50:47.651876Z","caller":"traceutil/trace.go:171","msg":"trace[109779799] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1848; }","duration":"1.338238487s","start":"2026-05-05T06:50:46.313627Z","end":"2026-05-05T06:50:47.651865Z","steps":["trace[109779799] 'agreement among raft nodes before linearized reading' (duration: 1.338158085s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:47.651907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:50:46.313609Z","time spent":"1.338292698s","remote":"127.0.0.1:60350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-05T06:50:47.651964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.498843299s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-05T06:50:47.652017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.326522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T06:50:47.652022Z","caller":"traceutil/trace.go:171","msg":"trace[611762859] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1848; }","duration":"1.498953821s","start":"2026-05-05T06:50:46.153053Z","end":"2026-05-05T06:50:47.652006Z","steps":["trace[611762859] 'agreement among raft nodes before linearized reading' (duration: 1.498709865s)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:50:47.65204Z","caller":"traceutil/trace.go:171","msg":"trace[459760899] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1848; }","duration":"643.404895ms","start":"2026-05-05T06:50:47.00863Z","end":"2026-05-05T06:50:47.652035Z","steps":["trace[459760899] 'agreement among raft nodes before linearized reading' (duration: 643.365794ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:47.65205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:50:46.153032Z","time spent":"1.499010813s","remote":"127.0.0.1:33122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-05T06:50:47.652047Z","caller":"traceutil/trace.go:171","msg":"trace[54993011] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"768.153675ms","start":"2026-05-05T06:50:46.883879Z","end":"2026-05-05T06:50:47.652032Z","steps":["trace[54993011] 'process raft request' (duration: 767.522549ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:47.652141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:50:46.883851Z","time spent":"768.234487ms","remote":"127.0.0.1:33122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T06:50:47.652155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.729419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-05T06:50:47.652178Z","caller":"traceutil/trace.go:171","msg":"trace[1555039212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1848; }","duration":"679.773639ms","start":"2026-05-05T06:50:46.972399Z","end":"2026-05-05T06:50:47.652173Z","steps":["trace[1555039212] 'agreement among raft nodes before linearized reading' (duration: 679.675577ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:47.652194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:50:46.972385Z","time spent":"679.805791ms","remote":"127.0.0.1:33122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-05T06:50:47.652061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:50:47.008592Z","time spent":"643.464966ms","remote":"127.0.0.1:32860","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-05-05T06:50:47.652273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"683.87525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-05T06:50:47.65229Z","caller":"traceutil/trace.go:171","msg":"trace[1348448657] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1848; }","duration":"683.923462ms","start":"2026-05-05T06:50:46.968362Z","end":"2026-05-05T06:50:47.652285Z","steps":["trace[1348448657] 'agreement among raft nodes before linearized reading' (duration: 683.874881ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:47.652306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:50:46.968347Z","time spent":"683.956023ms","remote":"127.0.0.1:33122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-05T06:50:47.652395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.26206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T06:50:47.65242Z","caller":"traceutil/trace.go:171","msg":"trace[747190765] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1848; }","duration":"749.343832ms","start":"2026-05-05T06:50:46.903067Z","end":"2026-05-05T06:50:47.652411Z","steps":["trace[747190765] 'agreement among raft nodes before linearized reading' (duration: 749.27727ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:47.652425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.119531492s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-05T06:50:47.652439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:50:46.903044Z","time spent":"749.389562ms","remote":"127.0.0.1:32916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":31,"response size":30,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"info","ts":"2026-05-05T06:50:47.652449Z","caller":"traceutil/trace.go:171","msg":"trace[194391265] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1848; }","duration":"1.119592184s","start":"2026-05-05T06:50:46.53285Z","end":"2026-05-05T06:50:47.652443Z","steps":["trace[194391265] 'agreement among raft nodes before linearized reading' (duration: 1.119524172s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:47.65247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:50:46.532828Z","time spent":"1.119636785s","remote":"127.0.0.1:33122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-05T06:50:47.65258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.079518608s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-05-05T06:50:47.652599Z","caller":"traceutil/trace.go:171","msg":"trace[739810453] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1848; }","duration":"1.079563559s","start":"2026-05-05T06:50:46.573027Z","end":"2026-05-05T06:50:47.652591Z","steps":["trace[739810453] 'agreement among raft nodes before linearized reading' (duration: 1.079508088s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:50:47.652615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:50:46.573011Z","time spent":"1.07960042s","remote":"127.0.0.1:33122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-05-05T06:52:18.395143Z","caller":"traceutil/trace.go:171","msg":"trace[925255198] transaction","detail":"{read_only:false; response_revision:2295; number_of_response:1; }","duration":"428.625783ms","start":"2026-05-05T06:52:17.966497Z","end":"2026-05-05T06:52:18.395123Z","steps":["trace[925255198] 'process raft request' (duration: 427.934876ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:18.395303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.565748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-05-05T06:52:18.395358Z","caller":"traceutil/trace.go:171","msg":"trace[583632722] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2295; }","duration":"328.660911ms","start":"2026-05-05T06:52:18.066684Z","end":"2026-05-05T06:52:18.395345Z","steps":["trace[583632722] 'agreement among raft nodes before linearized reading' (duration: 328.514037ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:18.395351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:52:17.96647Z","time spent":"428.771617ms","remote":"127.0.0.1:33122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T06:52:18.395381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T06:52:18.066667Z","time spent":"328.708842ms","remote":"127.0.0.1:33122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-05-05T06:52:18.395011Z","caller":"traceutil/trace.go:171","msg":"trace[1759433222] linearizableReadLoop","detail":"{readStateIndex:2387; appliedIndex:2386; }","duration":"328.26031ms","start":"2026-05-05T06:52:18.066721Z","end":"2026-05-05T06:52:18.394981Z","steps":["trace[1759433222] 'read index received' (duration: 327.595174ms)","trace[1759433222] 'applied index is now lower than readState.Index' (duration: 664.126µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T06:52:18.396317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.132439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:3015"} {"level":"warn","ts":"2026-05-05T06:52:18.396338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.118315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-05T06:52:18.396356Z","caller":"traceutil/trace.go:171","msg":"trace[1059712884] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:2295; }","duration":"168.20444ms","start":"2026-05-05T06:52:18.228143Z","end":"2026-05-05T06:52:18.396347Z","steps":["trace[1059712884] 'agreement among raft nodes before linearized reading' (duration: 168.090198ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:52:18.396394Z","caller":"traceutil/trace.go:171","msg":"trace[143535608] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2295; }","duration":"279.193107ms","start":"2026-05-05T06:52:18.117187Z","end":"2026-05-05T06:52:18.39638Z","steps":["trace[143535608] 'agreement among raft nodes before linearized reading' (duration: 279.036783ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:18.396458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.485703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-05T06:52:18.396465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.17642ms","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-05-05T06:52:18.396525Z","caller":"traceutil/trace.go:171","msg":"trace[2032610444] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2295; }","duration":"222.608156ms","start":"2026-05-05T06:52:18.173893Z","end":"2026-05-05T06:52:18.396501Z","steps":["trace[2032610444] 'agreement among raft nodes before linearized reading' (duration: 222.3382ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T06:52:18.396544Z","caller":"traceutil/trace.go:171","msg":"trace[1202024230] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2295; }","duration":"227.310733ms","start":"2026-05-05T06:52:18.169213Z","end":"2026-05-05T06:52:18.396524Z","steps":["trace[1202024230] 'agreement among raft nodes before linearized reading' (duration: 227.064257ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T06:52:18.396609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.982418ms","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-05-05T06:52:18.396647Z","caller":"traceutil/trace.go:171","msg":"trace[779918791] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2295; }","duration":"255.053059ms","start":"2026-05-05T06:52:18.141579Z","end":"2026-05-05T06:52:18.396633Z","steps":["trace[779918791] 'agreement among raft nodes before linearized reading' (duration: 254.976928ms)"],"step_count":1}