{"level":"warn","ts":"2026-02-25T02:01:49.922579Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-25T02:01:49.922735Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.129: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.129:2380","--initial-cluster=instance=https://199.204.45.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.129: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-02-25T02:01:49.922823Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-25T02:01:49.922872Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-02-25T02:01:49.922898Z","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-02-25T02:01:49.923831Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"]} {"level":"info","ts":"2026-02-25T02:01:49.924226Z","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.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.129: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-02-25T02:01:49.930547Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.027487ms"} {"level":"info","ts":"2026-02-25T02:01:49.938789Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cec112083e8d3ff","cluster-id":"3f68255a3b440659"} {"level":"info","ts":"2026-02-25T02:01:49.938894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=()"} {"level":"info","ts":"2026-02-25T02:01:49.938921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 0"} {"level":"info","ts":"2026-02-25T02:01:49.93894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cec112083e8d3ff [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-25T02:01:49.938953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 1"} {"level":"info","ts":"2026-02-25T02:01:49.938995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"warn","ts":"2026-02-25T02:01:49.94531Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-25T02:01:49.947114Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-25T02:01:49.950413Z","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-02-25T02:01:49.952565Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cec112083e8d3ff","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-25T02:01:49.952894Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cec112083e8d3ff","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-25T02:01:49.953044Z","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-02-25T02:01:49.953134Z","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-02-25T02:01:49.953145Z","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-02-25T02:01:49.954995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"info","ts":"2026-02-25T02:01:49.955459Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","added-peer-id":"3cec112083e8d3ff","added-peer-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-02-25T02:01:49.956906Z","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-02-25T02:01:49.957154Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cec112083e8d3ff","initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-25T02:01:49.957199Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-25T02:01:49.957443Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-02-25T02:01:49.957476Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-02-25T02:01:50.939883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff is starting a new election at term 1"} {"level":"info","ts":"2026-02-25T02:01:50.939959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became pre-candidate at term 1"} {"level":"info","ts":"2026-02-25T02:01:50.940001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgPreVoteResp from 3cec112083e8d3ff at term 1"} {"level":"info","ts":"2026-02-25T02:01:50.940021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became candidate at term 2"} {"level":"info","ts":"2026-02-25T02:01:50.940032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgVoteResp from 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-02-25T02:01:50.94006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became leader at term 2"} {"level":"info","ts":"2026-02-25T02:01:50.940082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cec112083e8d3ff elected leader 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-02-25T02:01:50.940788Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T02:01:50.941635Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cec112083e8d3ff","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.129:2379]}","request-path":"/0/members/3cec112083e8d3ff/attributes","cluster-id":"3f68255a3b440659","publish-timeout":"7s"} {"level":"info","ts":"2026-02-25T02:01:50.941655Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T02:01:50.941704Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T02:01:50.941969Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-25T02:01:50.942034Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-25T02:01:50.942487Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T02:01:50.942756Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T02:01:50.942818Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T02:01:50.944531Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.129:2379"} {"level":"info","ts":"2026-02-25T02:01:50.946064Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-02-25T02:02:06.685271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.717719ms","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-02-25T02:02:06.685394Z","caller":"traceutil/trace.go:171","msg":"trace[933653579] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:409; }","duration":"160.85169ms","start":"2026-02-25T02:02:06.524498Z","end":"2026-02-25T02:02:06.68535Z","steps":["trace[933653579] 'range keys from in-memory index tree' (duration: 160.612699ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:08.290842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.176755ms","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-02-25T02:02:08.290958Z","caller":"traceutil/trace.go:171","msg":"trace[19544377] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:411; }","duration":"681.339366ms","start":"2026-02-25T02:02:07.609594Z","end":"2026-02-25T02:02:08.290933Z","steps":["trace[19544377] 'range keys from in-memory index tree' (duration: 681.022394ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:08.291018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:07.609569Z","time spent":"681.432466ms","remote":"127.0.0.1:53654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-25T02:02:08.291095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.450680959s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5270"} {"level":"info","ts":"2026-02-25T02:02:08.291174Z","caller":"traceutil/trace.go:171","msg":"trace[1026787150] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:411; }","duration":"1.45080077s","start":"2026-02-25T02:02:06.840353Z","end":"2026-02-25T02:02:08.291154Z","steps":["trace[1026787150] 'range keys from in-memory index tree' (duration: 1.450566409s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:08.291224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:06.840328Z","time spent":"1.45088367s","remote":"127.0.0.1:53566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5292,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"warn","ts":"2026-02-25T02:02:08.291499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"985.64078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:02:08.291575Z","caller":"traceutil/trace.go:171","msg":"trace[126313180] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:411; }","duration":"985.75742ms","start":"2026-02-25T02:02:07.305798Z","end":"2026-02-25T02:02:08.291555Z","steps":["trace[126313180] 'range keys from in-memory index tree' (duration: 985.516819ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:08.291613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:07.305781Z","time spent":"985.82459ms","remote":"127.0.0.1:53376","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-02-25T02:02:08.291676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"831.370175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4034"} {"level":"info","ts":"2026-02-25T02:02:08.291711Z","caller":"traceutil/trace.go:171","msg":"trace[35000297] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:411; }","duration":"831.405616ms","start":"2026-02-25T02:02:07.460294Z","end":"2026-02-25T02:02:08.2917Z","steps":["trace[35000297] 'range keys from in-memory index tree' (duration: 831.254604ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:08.291732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:07.460234Z","time spent":"831.492856ms","remote":"127.0.0.1:53834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4056,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"info","ts":"2026-02-25T02:02:08.826172Z","caller":"traceutil/trace.go:171","msg":"trace[1921504769] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"530.684703ms","start":"2026-02-25T02:02:08.295469Z","end":"2026-02-25T02:02:08.826154Z","steps":["trace[1921504769] 'process raft request' (duration: 530.442092ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:08.826589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:08.295449Z","time spent":"530.779153ms","remote":"127.0.0.1:53654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T02:02:09.641459Z","caller":"traceutil/trace.go:171","msg":"trace[120633833] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"1.34434009s","start":"2026-02-25T02:02:08.297082Z","end":"2026-02-25T02:02:09.641422Z","steps":["trace[120633833] 'process raft request' (duration: 1.251532228s)","trace[120633833] 'compare' (duration: 92.48274ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:02:09.641659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:08.297068Z","time spent":"1.34447558s","remote":"127.0.0.1:53566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5083,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T02:02:09.641819Z","caller":"traceutil/trace.go:171","msg":"trace[236647963] linearizableReadLoop","detail":"{readStateIndex:425; appliedIndex:422; }","duration":"1.143923602s","start":"2026-02-25T02:02:08.497873Z","end":"2026-02-25T02:02:09.641797Z","steps":["trace[236647963] 'read index received' (duration: 328.204777ms)","trace[236647963] 'applied index is now lower than readState.Index' (duration: 815.717765ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:02:09.641846Z","caller":"traceutil/trace.go:171","msg":"trace[566647501] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"1.339442269s","start":"2026-02-25T02:02:08.30237Z","end":"2026-02-25T02:02:09.641812Z","steps":["trace[566647501] 'process raft request' (duration: 1.339234518s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:09.642014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:08.302362Z","time spent":"1.33956742s","remote":"127.0.0.1:53834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4158,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T02:02:09.648458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.30923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-25T02:02:09.648534Z","caller":"traceutil/trace.go:171","msg":"trace[693276515] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:414; }","duration":"892.497161ms","start":"2026-02-25T02:02:08.756023Z","end":"2026-02-25T02:02:09.64852Z","steps":["trace[693276515] 'agreement among raft nodes before linearized reading' (duration: 892.32356ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:09.648546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"913.593467ms","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-02-25T02:02:09.648563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.150682643s","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-02-25T02:02:09.648623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:08.755983Z","time spent":"892.628752ms","remote":"127.0.0.1:53654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-25T02:02:09.648618Z","caller":"traceutil/trace.go:171","msg":"trace[123337880] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:414; }","duration":"1.150760704s","start":"2026-02-25T02:02:08.497835Z","end":"2026-02-25T02:02:09.648596Z","steps":["trace[123337880] 'agreement among raft nodes before linearized reading' (duration: 1.144078123s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:09.648459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.79216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:02:09.64877Z","caller":"traceutil/trace.go:171","msg":"trace[1162756787] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:414; }","duration":"341.232002ms","start":"2026-02-25T02:02:09.307528Z","end":"2026-02-25T02:02:09.64876Z","steps":["trace[1162756787] 'agreement among raft nodes before linearized reading' (duration: 340.80469ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:09.648775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:08.497825Z","time spent":"1.150889374s","remote":"127.0.0.1:53654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-25T02:02:09.648911Z","caller":"traceutil/trace.go:171","msg":"trace[1969955593] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:414; }","duration":"913.898859ms","start":"2026-02-25T02:02:08.734876Z","end":"2026-02-25T02:02:09.648775Z","steps":["trace[1969955593] 'agreement among raft nodes before linearized reading' (duration: 913.602488ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:09.648984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:08.734838Z","time spent":"914.12872ms","remote":"127.0.0.1:53654","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-02-25T02:02:09.648822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:09.307495Z","time spent":"341.318253ms","remote":"127.0.0.1:53376","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-02-25T02:02:23.236972Z","caller":"traceutil/trace.go:171","msg":"trace[1337177101] linearizableReadLoop","detail":"{readStateIndex:525; appliedIndex:524; }","duration":"352.673471ms","start":"2026-02-25T02:02:22.884274Z","end":"2026-02-25T02:02:23.236947Z","steps":["trace[1337177101] 'read index received' (duration: 352.489769ms)","trace[1337177101] 'applied index is now lower than readState.Index' (duration: 182.792µs)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:02:23.237116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.823352ms","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-02-25T02:02:23.237148Z","caller":"traceutil/trace.go:171","msg":"trace[1119485848] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:509; }","duration":"352.905633ms","start":"2026-02-25T02:02:22.884232Z","end":"2026-02-25T02:02:23.237138Z","steps":["trace[1119485848] 'agreement among raft nodes before linearized reading' (duration: 352.823542ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:23.23718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:22.884206Z","time spent":"352.967274ms","remote":"127.0.0.1:53654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-25T02:02:23.23723Z","caller":"traceutil/trace.go:171","msg":"trace[370581261] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"480.68675ms","start":"2026-02-25T02:02:22.756524Z","end":"2026-02-25T02:02:23.237211Z","steps":["trace[370581261] 'process raft request' (duration: 480.297906ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:23.237329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:22.756506Z","time spent":"480.76384ms","remote":"127.0.0.1:53654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T02:02:23.806787Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276100614224246608,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-25T02:02:23.824525Z","caller":"traceutil/trace.go:171","msg":"trace[1226921632] linearizableReadLoop","detail":"{readStateIndex:526; appliedIndex:525; }","duration":"518.348878ms","start":"2026-02-25T02:02:23.306148Z","end":"2026-02-25T02:02:23.824497Z","steps":["trace[1226921632] 'read index received' (duration: 518.123056ms)","trace[1226921632] 'applied index is now lower than readState.Index' (duration: 224.762µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:02:23.824657Z","caller":"traceutil/trace.go:171","msg":"trace[969655293] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"583.829833ms","start":"2026-02-25T02:02:23.240816Z","end":"2026-02-25T02:02:23.824646Z","steps":["trace[969655293] 'process raft request' (duration: 583.52958ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:23.824816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:23.240795Z","time spent":"583.893423ms","remote":"127.0.0.1:53654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T02:02:23.824829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.849977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-25T02:02:23.824926Z","caller":"traceutil/trace.go:171","msg":"trace[270463630] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:510; }","duration":"106.992688ms","start":"2026-02-25T02:02:23.717908Z","end":"2026-02-25T02:02:23.824901Z","steps":["trace[270463630] 'agreement among raft nodes before linearized reading' (duration: 106.839497ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:23.825118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.182229ms","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-02-25T02:02:23.825163Z","caller":"traceutil/trace.go:171","msg":"trace[1648921460] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:510; }","duration":"103.240769ms","start":"2026-02-25T02:02:23.72191Z","end":"2026-02-25T02:02:23.825151Z","steps":["trace[1648921460] 'agreement among raft nodes before linearized reading' (duration: 103.105408ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:23.825056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.892195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:02:23.82532Z","caller":"traceutil/trace.go:171","msg":"trace[1261749462] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:510; }","duration":"519.194797ms","start":"2026-02-25T02:02:23.306103Z","end":"2026-02-25T02:02:23.825298Z","steps":["trace[1261749462] 'agreement among raft nodes before linearized reading' (duration: 518.878294ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:23.825361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:23.306078Z","time spent":"519.271408ms","remote":"127.0.0.1:53376","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-02-25T02:02:30.919954Z","caller":"traceutil/trace.go:171","msg":"trace[1735551774] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:566; }","duration":"1.035645324s","start":"2026-02-25T02:02:29.884285Z","end":"2026-02-25T02:02:30.91993Z","steps":["trace[1735551774] 'read index received' (duration: 73.975964ms)","trace[1735551774] 'applied index is now lower than readState.Index' (duration: 961.66839ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:02:30.920079Z","caller":"traceutil/trace.go:171","msg":"trace[1611163290] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"1.03764828s","start":"2026-02-25T02:02:29.88242Z","end":"2026-02-25T02:02:30.920069Z","steps":["trace[1611163290] 'process raft request' (duration: 1.037387047s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:30.920186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:29.882396Z","time spent":"1.037711451s","remote":"127.0.0.1:53654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T02:02:30.920261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.030423719s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-25T02:02:30.92033Z","caller":"traceutil/trace.go:171","msg":"trace[124107446] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:550; }","duration":"1.03055576s","start":"2026-02-25T02:02:29.889754Z","end":"2026-02-25T02:02:30.92031Z","steps":["trace[124107446] 'agreement among raft nodes before linearized reading' (duration: 1.030341747s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:30.920368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:29.889745Z","time spent":"1.030615821s","remote":"127.0.0.1:53654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-25T02:02:30.92052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.036232302s","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-02-25T02:02:30.920545Z","caller":"traceutil/trace.go:171","msg":"trace[1986534117] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:550; }","duration":"1.036256032s","start":"2026-02-25T02:02:29.884281Z","end":"2026-02-25T02:02:30.920537Z","steps":["trace[1986534117] 'agreement among raft nodes before linearized reading' (duration: 1.036172301s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:30.920569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:29.884251Z","time spent":"1.036312342s","remote":"127.0.0.1:53654","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-02-25T02:02:30.920748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.020877817s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-lm69x\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-25T02:02:30.920828Z","caller":"traceutil/trace.go:171","msg":"trace[446351870] range","detail":"{range_begin:/registry/pods/kube-system/cilium-lm69x; range_end:; response_count:1; response_revision:550; }","duration":"1.020991058s","start":"2026-02-25T02:02:29.899817Z","end":"2026-02-25T02:02:30.920808Z","steps":["trace[446351870] 'agreement among raft nodes before linearized reading' (duration: 1.020736685s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:30.920909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:29.899808Z","time spent":"1.021077919s","remote":"127.0.0.1:53566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16678,"request content":"key:\"/registry/pods/kube-system/cilium-lm69x\" "} {"level":"warn","ts":"2026-02-25T02:02:31.807318Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276100614224246694,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-25T02:02:31.811915Z","caller":"traceutil/trace.go:171","msg":"trace[1376271250] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:570; }","duration":"505.088342ms","start":"2026-02-25T02:02:31.306801Z","end":"2026-02-25T02:02:31.81189Z","steps":["trace[1376271250] 'read index received' (duration: 505.046511ms)","trace[1376271250] 'applied index is now lower than readState.Index' (duration: 40.771µs)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:02:31.812045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.210833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:02:31.812146Z","caller":"traceutil/trace.go:171","msg":"trace[1211774510] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:553; }","duration":"505.396515ms","start":"2026-02-25T02:02:31.306734Z","end":"2026-02-25T02:02:31.81213Z","steps":["trace[1211774510] 'agreement among raft nodes before linearized reading' (duration: 505.232533ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:02:31.812179Z","caller":"traceutil/trace.go:171","msg":"trace[2131473010] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"886.846787ms","start":"2026-02-25T02:02:30.925314Z","end":"2026-02-25T02:02:31.812161Z","steps":["trace[2131473010] 'process raft request' (duration: 886.378701ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:31.812192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:31.306711Z","time spent":"505.471776ms","remote":"127.0.0.1:53376","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-02-25T02:02:31.812274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:30.925286Z","time spent":"886.935588ms","remote":"127.0.0.1:53654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T02:02:31.812296Z","caller":"traceutil/trace.go:171","msg":"trace[1718416920] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"878.722161ms","start":"2026-02-25T02:02:30.933535Z","end":"2026-02-25T02:02:31.812257Z","steps":["trace[1718416920] 'process raft request' (duration: 878.299566ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:31.812433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:30.933524Z","time spent":"878.839333ms","remote":"127.0.0.1:53566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T02:02:33.81438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"853.796199ms","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-02-25T02:02:33.814463Z","caller":"traceutil/trace.go:171","msg":"trace[664170889] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:554; }","duration":"853.905451ms","start":"2026-02-25T02:02:32.960539Z","end":"2026-02-25T02:02:33.814444Z","steps":["trace[664170889] 'range keys from in-memory index tree' (duration: 853.647827ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:33.814515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:32.960532Z","time spent":"853.968721ms","remote":"127.0.0.1:53654","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-02-25T02:02:33.814743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.243585ms","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-02-25T02:02:33.81449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:32.150907Z","time spent":"1.663575546s","remote":"127.0.0.1:49108","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-25T02:02:33.814794Z","caller":"traceutil/trace.go:171","msg":"trace[961305764] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:554; }","duration":"890.300366ms","start":"2026-02-25T02:02:32.924475Z","end":"2026-02-25T02:02:33.814776Z","steps":["trace[961305764] 'range keys from in-memory index tree' (duration: 890.054803ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:33.814836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:32.924433Z","time spent":"890.395168ms","remote":"127.0.0.1:53654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-25T02:02:33.815138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.968315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T02:02:33.815374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.723021ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T02:02:33.815432Z","caller":"traceutil/trace.go:171","msg":"trace[1542498083] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"436.83088ms","start":"2026-02-25T02:02:33.37859Z","end":"2026-02-25T02:02:33.815421Z","steps":["trace[1542498083] 'process raft request' (duration: 300.914326ms)","trace[1542498083] 'compare' (duration: 134.670507ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:02:33.815471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:33.378573Z","time spent":"436.88406ms","remote":"127.0.0.1:53654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T02:02:33.815994Z","caller":"traceutil/trace.go:171","msg":"trace[2001512940] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:554; }","duration":"509.041486ms","start":"2026-02-25T02:02:33.306125Z","end":"2026-02-25T02:02:33.815166Z","steps":["trace[2001512940] 'range keys from in-memory index tree' (duration: 508.901235ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:33.816051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:33.306104Z","time spent":"509.934979ms","remote":"127.0.0.1:53376","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-02-25T02:02:34.42853Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276100614224246707,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-25T02:02:34.878894Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.060610727s","expected-duration":"1s"} {"level":"info","ts":"2026-02-25T02:02:34.879467Z","caller":"traceutil/trace.go:171","msg":"trace[713595029] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"1.061247946s","start":"2026-02-25T02:02:33.818195Z","end":"2026-02-25T02:02:34.879443Z","steps":["trace[713595029] 'process raft request' (duration: 1.061103274s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:34.879617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:33.818178Z","time spent":"1.061362098s","remote":"127.0.0.1:53654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T02:02:34.881843Z","caller":"traceutil/trace.go:171","msg":"trace[916264010] linearizableReadLoop","detail":"{readStateIndex:576; appliedIndex:573; }","duration":"954.016341ms","start":"2026-02-25T02:02:33.927797Z","end":"2026-02-25T02:02:34.881813Z","steps":["trace[916264010] 'read index received' (duration: 951.523405ms)","trace[916264010] 'applied index is now lower than readState.Index' (duration: 2.491156ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:02:34.881886Z","caller":"traceutil/trace.go:171","msg":"trace[888470811] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"1.062699506s","start":"2026-02-25T02:02:33.819166Z","end":"2026-02-25T02:02:34.881865Z","steps":["trace[888470811] 'process raft request' (duration: 1.062498114s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:34.882023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"954.225204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.129\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-02-25T02:02:34.882055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:33.819156Z","time spent":"1.062791318s","remote":"127.0.0.1:53654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T02:02:34.882079Z","caller":"traceutil/trace.go:171","msg":"trace[294219467] range","detail":"{range_begin:/registry/masterleases/199.204.45.129; range_end:; response_count:1; response_revision:558; }","duration":"954.312085ms","start":"2026-02-25T02:02:33.927752Z","end":"2026-02-25T02:02:34.882064Z","steps":["trace[294219467] 'agreement among raft nodes before linearized reading' (duration: 954.163053ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:34.882114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:33.927735Z","time spent":"954.371426ms","remote":"127.0.0.1:53422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.129\" "} {"level":"warn","ts":"2026-02-25T02:02:34.882142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"808.620392ms","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-02-25T02:02:34.882189Z","caller":"traceutil/trace.go:171","msg":"trace[214052607] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:558; }","duration":"808.717063ms","start":"2026-02-25T02:02:34.07346Z","end":"2026-02-25T02:02:34.882178Z","steps":["trace[214052607] 'agreement among raft nodes before linearized reading' (duration: 808.52189ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:02:34.88175Z","caller":"traceutil/trace.go:171","msg":"trace[573994183] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"1.062779917s","start":"2026-02-25T02:02:33.818938Z","end":"2026-02-25T02:02:34.881718Z","steps":["trace[573994183] 'process raft request' (duration: 1.062528084s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:34.882224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:34.073442Z","time spent":"808.773614ms","remote":"127.0.0.1:53654","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-02-25T02:02:34.882365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:33.818916Z","time spent":"1.063338836s","remote":"127.0.0.1:53654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T02:02:37.522642Z","caller":"traceutil/trace.go:171","msg":"trace[383668700] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"458.962202ms","start":"2026-02-25T02:02:37.063659Z","end":"2026-02-25T02:02:37.522621Z","steps":["trace[383668700] 'process raft request' (duration: 458.80229ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:02:37.52278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:02:37.063634Z","time spent":"459.083254ms","remote":"127.0.0.1:53434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T02:02:37.526975Z","caller":"traceutil/trace.go:171","msg":"trace[1376634849] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"263.154107ms","start":"2026-02-25T02:02:37.263804Z","end":"2026-02-25T02:02:37.526958Z","steps":["trace[1376634849] 'process raft request' (duration: 263.056806ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:02:47.255528Z","caller":"traceutil/trace.go:171","msg":"trace[699329386] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"108.89027ms","start":"2026-02-25T02:02:47.146621Z","end":"2026-02-25T02:02:47.255511Z","steps":["trace[699329386] 'process raft request' (duration: 108.783488ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:04:03.682914Z","caller":"traceutil/trace.go:171","msg":"trace[234592357] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"198.639018ms","start":"2026-02-25T02:04:03.484244Z","end":"2026-02-25T02:04:03.682883Z","steps":["trace[234592357] 'process raft request' (duration: 198.460523ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:04:03.687655Z","caller":"traceutil/trace.go:171","msg":"trace[1438460178] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"203.077309ms","start":"2026-02-25T02:04:03.484552Z","end":"2026-02-25T02:04:03.68763Z","steps":["trace[1438460178] 'process raft request' (duration: 202.966726ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T02:04:04.737468Z","caller":"traceutil/trace.go:171","msg":"trace[2034509789] linearizableReadLoop","detail":"{readStateIndex:1040; appliedIndex:1039; }","duration":"429.88848ms","start":"2026-02-25T02:04:04.307556Z","end":"2026-02-25T02:04:04.737444Z","steps":["trace[2034509789] 'read index received' (duration: 354.720851ms)","trace[2034509789] 'applied index is now lower than readState.Index' (duration: 75.166889ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T02:04:04.73749Z","caller":"traceutil/trace.go:171","msg":"trace[1697466799] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"740.58715ms","start":"2026-02-25T02:04:03.996874Z","end":"2026-02-25T02:04:04.737461Z","steps":["trace[1697466799] 'process raft request' (duration: 665.511263ms)","trace[1697466799] 'compare' (duration: 74.920362ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T02:04:04.737595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.029134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T02:04:04.73763Z","caller":"traceutil/trace.go:171","msg":"trace[2069628329] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:998; }","duration":"430.113446ms","start":"2026-02-25T02:04:04.307508Z","end":"2026-02-25T02:04:04.737621Z","steps":["trace[2069628329] 'agreement among raft nodes before linearized reading' (duration: 430.021094ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T02:04:04.737615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:04:03.996846Z","time spent":"740.699473ms","remote":"127.0.0.1:53422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T02:04:04.737658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:04:04.30749Z","time spent":"430.162157ms","remote":"127.0.0.1:53376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}