{"level":"warn","ts":"2026-02-05T05:21:26.37574Z","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-05T05:21:26.375827Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.110: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://162.253.55.110:2380","--initial-cluster=instance=https://162.253.55.110:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.110:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.110: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-05T05:21:26.375912Z","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-05T05:21:26.375925Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.110:2380"]} {"level":"info","ts":"2026-02-05T05:21:26.376152Z","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-05T05:21:26.376797Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.110:2379"]} {"level":"info","ts":"2026-02-05T05:21:26.376886Z","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":2,"max-cpu-available":2,"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://162.253.55.110:2380"],"listen-peer-urls":["https://162.253.55.110:2380"],"advertise-client-urls":["https://162.253.55.110:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.110:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.110: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-05T05:21:26.418269Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"41.133693ms"} {"level":"info","ts":"2026-02-05T05:21:26.442674Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f52f30d5714009d5","cluster-id":"650981a7a383c714"} {"level":"info","ts":"2026-02-05T05:21:26.442849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 switched to configuration voters=()"} {"level":"info","ts":"2026-02-05T05:21:26.443007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became follower at term 0"} {"level":"info","ts":"2026-02-05T05:21:26.443077Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f52f30d5714009d5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-05T05:21:26.443125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became follower at term 1"} {"level":"info","ts":"2026-02-05T05:21:26.443241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 switched to configuration voters=(17667393556483934677)"} {"level":"warn","ts":"2026-02-05T05:21:26.469215Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-05T05:21:26.477471Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-05T05:21:26.498995Z","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-05T05:21:26.508337Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f52f30d5714009d5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-05T05:21:26.508967Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f52f30d5714009d5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-05T05:21:26.509133Z","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-05T05:21:26.509173Z","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-05T05:21:26.509228Z","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-05T05:21:26.509471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 switched to configuration voters=(17667393556483934677)"} {"level":"info","ts":"2026-02-05T05:21:26.50965Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"650981a7a383c714","local-member-id":"f52f30d5714009d5","added-peer-id":"f52f30d5714009d5","added-peer-peer-urls":["https://162.253.55.110:2380"]} {"level":"info","ts":"2026-02-05T05:21:26.527832Z","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-05T05:21:26.52798Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.110:2380"} {"level":"info","ts":"2026-02-05T05:21:26.528021Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.110:2380"} {"level":"info","ts":"2026-02-05T05:21:26.528566Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f52f30d5714009d5","initial-advertise-peer-urls":["https://162.253.55.110:2380"],"listen-peer-urls":["https://162.253.55.110:2380"],"advertise-client-urls":["https://162.253.55.110:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.110:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-05T05:21:26.529853Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-05T05:21:26.74521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 is starting a new election at term 1"} {"level":"info","ts":"2026-02-05T05:21:26.74535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-05T05:21:26.74545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 received MsgPreVoteResp from f52f30d5714009d5 at term 1"} {"level":"info","ts":"2026-02-05T05:21:26.745533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became candidate at term 2"} {"level":"info","ts":"2026-02-05T05:21:26.745574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 received MsgVoteResp from f52f30d5714009d5 at term 2"} {"level":"info","ts":"2026-02-05T05:21:26.745632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became leader at term 2"} {"level":"info","ts":"2026-02-05T05:21:26.745675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f52f30d5714009d5 elected leader f52f30d5714009d5 at term 2"} {"level":"info","ts":"2026-02-05T05:21:26.793866Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-05T05:21:26.796188Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f52f30d5714009d5","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.110:2379]}","request-path":"/0/members/f52f30d5714009d5/attributes","cluster-id":"650981a7a383c714","publish-timeout":"7s"} {"level":"info","ts":"2026-02-05T05:21:26.796274Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-05T05:21:26.796549Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-05T05:21:26.799147Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-05T05:21:26.802257Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"650981a7a383c714","local-member-id":"f52f30d5714009d5","cluster-version":"3.5"} {"level":"info","ts":"2026-02-05T05:21:26.822604Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-05T05:21:26.822645Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-05T05:21:26.803407Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.110:2379"} {"level":"info","ts":"2026-02-05T05:21:26.81645Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-05T05:21:26.849239Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-05T05:21:31.31231Z","caller":"traceutil/trace.go:171","msg":"trace[2025438858] transaction","detail":"{read_only:false; response_revision:252; number_of_response:1; }","duration":"125.716364ms","start":"2026-02-05T05:21:31.18657Z","end":"2026-02-05T05:21:31.312286Z","steps":["trace[2025438858] 'process raft request' (duration: 28.885452ms)","trace[2025438858] 'compare' (duration: 96.239472ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:21:32.071873Z","caller":"traceutil/trace.go:171","msg":"trace[2007441167] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"218.953187ms","start":"2026-02-05T05:21:31.852894Z","end":"2026-02-05T05:21:32.071848Z","steps":["trace[2007441167] 'process raft request' (duration: 218.817945ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:32.280214Z","caller":"traceutil/trace.go:171","msg":"trace[2125857961] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"201.432415ms","start":"2026-02-05T05:21:32.078756Z","end":"2026-02-05T05:21:32.280189Z","steps":["trace[2125857961] 'process raft request' (duration: 119.698214ms)","trace[2125857961] 'compare' (duration: 81.426986ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:21:32.558443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.170944ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-05T05:21:32.559442Z","caller":"traceutil/trace.go:171","msg":"trace[1205766123] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"200.360858ms","start":"2026-02-05T05:21:32.359058Z","end":"2026-02-05T05:21:32.559419Z","steps":["trace[1205766123] 'process raft request' (duration: 55.72302ms)","trace[1205766123] 'compare' (duration: 142.930661ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:21:32.898811Z","caller":"traceutil/trace.go:171","msg":"trace[89903610] transaction","detail":"{read_only:false; response_revision:261; number_of_response:1; }","duration":"290.069596ms","start":"2026-02-05T05:21:32.608691Z","end":"2026-02-05T05:21:32.898761Z","steps":["trace[89903610] 'process raft request' (duration: 196.625347ms)","trace[89903610] 'compare' (duration: 93.245876ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:21:32.976778Z","caller":"traceutil/trace.go:171","msg":"trace[946593779] linearizableReadLoop","detail":"{readStateIndex:268; appliedIndex:266; }","duration":"311.650153ms","start":"2026-02-05T05:21:32.665108Z","end":"2026-02-05T05:21:32.976758Z","steps":["trace[946593779] 'read index received' (duration: 140.305116ms)","trace[946593779] 'applied index is now lower than readState.Index' (duration: 171.344027ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:21:32.97738Z","caller":"traceutil/trace.go:171","msg":"trace[183024532] transaction","detail":"{read_only:false; response_revision:262; number_of_response:1; }","duration":"368.35546ms","start":"2026-02-05T05:21:32.60901Z","end":"2026-02-05T05:21:32.977365Z","steps":["trace[183024532] 'process raft request' (duration: 367.661919ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:32.977507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:32.608999Z","time spent":"368.422881ms","remote":"127.0.0.1:38484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-05T05:21:32.977825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.704601ms","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-02-05T05:21:32.97787Z","caller":"traceutil/trace.go:171","msg":"trace[1330947994] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:262; }","duration":"312.789632ms","start":"2026-02-05T05:21:32.665068Z","end":"2026-02-05T05:21:32.977858Z","steps":["trace[1330947994] 'agreement among raft nodes before linearized reading' (duration: 312.66694ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:32.9779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:32.665048Z","time spent":"312.845112ms","remote":"127.0.0.1:38484","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-05T05:21:33.136414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.150775ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-05T05:21:33.136812Z","caller":"traceutil/trace.go:171","msg":"trace[1750692088] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"152.113815ms","start":"2026-02-05T05:21:32.984682Z","end":"2026-02-05T05:21:33.136796Z","steps":["trace[1750692088] 'process raft request' (duration: 152.065244ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:33.137237Z","caller":"traceutil/trace.go:171","msg":"trace[922741774] transaction","detail":"{read_only:false; response_revision:263; number_of_response:1; }","duration":"234.388774ms","start":"2026-02-05T05:21:32.902817Z","end":"2026-02-05T05:21:33.137206Z","steps":["trace[922741774] 'process raft request' (duration: 109.386906ms)","trace[922741774] 'compare' (duration: 123.852619ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:21:33.137635Z","caller":"traceutil/trace.go:171","msg":"trace[672827765] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"154.91814ms","start":"2026-02-05T05:21:32.9827Z","end":"2026-02-05T05:21:33.137618Z","steps":["trace[672827765] 'process raft request' (duration: 153.993896ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:33.137959Z","caller":"traceutil/trace.go:171","msg":"trace[1822987276] linearizableReadLoop","detail":"{readStateIndex:269; appliedIndex:268; }","duration":"161.109101ms","start":"2026-02-05T05:21:32.976837Z","end":"2026-02-05T05:21:33.137946Z","steps":["trace[1822987276] 'read index received' (duration: 35.372881ms)","trace[1822987276] 'applied index is now lower than readState.Index' (duration: 125.73496ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:21:33.138269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.675519ms","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-02-05T05:21:33.138469Z","caller":"traceutil/trace.go:171","msg":"trace[327954193] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:265; }","duration":"431.900844ms","start":"2026-02-05T05:21:32.706555Z","end":"2026-02-05T05:21:33.138456Z","steps":["trace[327954193] 'agreement among raft nodes before linearized reading' (duration: 431.6371ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:33.138623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:32.706528Z","time spent":"432.054086ms","remote":"127.0.0.1:38484","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-05T05:21:33.138939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.136499ms","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-05T05:21:33.139106Z","caller":"traceutil/trace.go:171","msg":"trace[85551585] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:265; }","duration":"156.296892ms","start":"2026-02-05T05:21:32.982768Z","end":"2026-02-05T05:21:33.139065Z","steps":["trace[85551585] 'agreement among raft nodes before linearized reading' (duration: 156.13319ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:33.141942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.018226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:21:33.145265Z","caller":"traceutil/trace.go:171","msg":"trace[905244357] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:265; }","duration":"162.354569ms","start":"2026-02-05T05:21:32.982889Z","end":"2026-02-05T05:21:33.145244Z","steps":["trace[905244357] 'agreement among raft nodes before linearized reading' (duration: 159.005036ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:33.429812Z","caller":"traceutil/trace.go:171","msg":"trace[560361397] linearizableReadLoop","detail":"{readStateIndex:274; appliedIndex:271; }","duration":"276.232937ms","start":"2026-02-05T05:21:33.153558Z","end":"2026-02-05T05:21:33.429791Z","steps":["trace[560361397] 'read index received' (duration: 204.386399ms)","trace[560361397] 'applied index is now lower than readState.Index' (duration: 71.845628ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:21:33.429932Z","caller":"traceutil/trace.go:171","msg":"trace[690163621] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"286.660344ms","start":"2026-02-05T05:21:33.143242Z","end":"2026-02-05T05:21:33.429902Z","steps":["trace[690163621] 'process raft request' (duration: 214.691763ms)","trace[690163621] 'compare' (duration: 71.530324ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:21:33.430015Z","caller":"traceutil/trace.go:171","msg":"trace[1961302623] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"282.497627ms","start":"2026-02-05T05:21:33.147511Z","end":"2026-02-05T05:21:33.430009Z","steps":["trace[1961302623] 'process raft request' (duration: 282.184272ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:33.430043Z","caller":"traceutil/trace.go:171","msg":"trace[146539773] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"281.40382ms","start":"2026-02-05T05:21:33.148635Z","end":"2026-02-05T05:21:33.430038Z","steps":["trace[146539773] 'process raft request' (duration: 281.121075ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:33.430102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.526281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:21:33.430813Z","caller":"traceutil/trace.go:171","msg":"trace[1698585109] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:0; response_revision:268; }","duration":"277.263373ms","start":"2026-02-05T05:21:33.15354Z","end":"2026-02-05T05:21:33.430803Z","steps":["trace[1698585109] 'agreement among raft nodes before linearized reading' (duration: 276.520121ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:33.433225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.321542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:21:33.433265Z","caller":"traceutil/trace.go:171","msg":"trace[142302366] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:268; }","duration":"235.393864ms","start":"2026-02-05T05:21:33.197863Z","end":"2026-02-05T05:21:33.433257Z","steps":["trace[142302366] 'agreement among raft nodes before linearized reading' (duration: 232.750172ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:33.995333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.153948ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-05T05:21:33.996151Z","caller":"traceutil/trace.go:171","msg":"trace[425838352] transaction","detail":"{read_only:false; response_revision:271; number_of_response:1; }","duration":"558.135585ms","start":"2026-02-05T05:21:33.437997Z","end":"2026-02-05T05:21:33.996133Z","steps":["trace[425838352] 'process raft request' (duration: 558.054383ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:33.996296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:33.437992Z","time spent":"558.205186ms","remote":"127.0.0.1:38484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-05T05:21:33.996571Z","caller":"traceutil/trace.go:171","msg":"trace[665116533] transaction","detail":"{read_only:false; response_revision:270; number_of_response:1; }","duration":"558.847056ms","start":"2026-02-05T05:21:33.437647Z","end":"2026-02-05T05:21:33.996494Z","steps":["trace[665116533] 'process raft request' (duration: 147.450468ms)","trace[665116533] 'compare' (duration: 409.828093ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:21:33.996816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:33.437639Z","time spent":"559.08789ms","remote":"127.0.0.1:38424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-05T05:21:34.053663Z","caller":"traceutil/trace.go:171","msg":"trace[299949120] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"527.75535ms","start":"2026-02-05T05:21:33.525891Z","end":"2026-02-05T05:21:34.053646Z","steps":["trace[299949120] 'process raft request' (duration: 527.664248ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:34.053988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:33.525877Z","time spent":"528.020764ms","remote":"127.0.0.1:38546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":481,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-05T05:21:34.311626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.382861ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-05T05:21:34.311739Z","caller":"traceutil/trace.go:171","msg":"trace[1905422171] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"250.615485ms","start":"2026-02-05T05:21:34.061112Z","end":"2026-02-05T05:21:34.311728Z","steps":["trace[1905422171] 'process raft request' (duration: 250.578554ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:34.311746Z","caller":"traceutil/trace.go:171","msg":"trace[1836539426] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"308.455079ms","start":"2026-02-05T05:21:34.003248Z","end":"2026-02-05T05:21:34.311703Z","steps":["trace[1836539426] 'process raft request' (duration: 100.956337ms)","trace[1836539426] 'compare' (duration: 207.299199ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:21:34.311856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:34.003207Z","time spent":"308.595371ms","remote":"127.0.0.1:38302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":705,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-05T05:21:34.311899Z","caller":"traceutil/trace.go:171","msg":"trace[1644426294] linearizableReadLoop","detail":"{readStateIndex:279; appliedIndex:278; }","duration":"257.31365ms","start":"2026-02-05T05:21:34.05458Z","end":"2026-02-05T05:21:34.311894Z","steps":["trace[1644426294] 'read index received' (duration: 49.741127ms)","trace[1644426294] 'applied index is now lower than readState.Index' (duration: 207.571863ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:21:34.311968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.644351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:21:34.311981Z","caller":"traceutil/trace.go:171","msg":"trace[1647354438] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:0; response_revision:274; }","duration":"306.682271ms","start":"2026-02-05T05:21:34.005293Z","end":"2026-02-05T05:21:34.311976Z","steps":["trace[1647354438] 'agreement among raft nodes before linearized reading' (duration: 306.61912ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:34.311996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:34.005285Z","time spent":"306.706541ms","remote":"127.0.0.1:38424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"info","ts":"2026-02-05T05:21:34.501859Z","caller":"traceutil/trace.go:171","msg":"trace[678109408] linearizableReadLoop","detail":"{readStateIndex:284; appliedIndex:283; }","duration":"113.058708ms","start":"2026-02-05T05:21:34.388783Z","end":"2026-02-05T05:21:34.501841Z","steps":["trace[678109408] 'read index received' (duration: 91.656019ms)","trace[678109408] 'applied index is now lower than readState.Index' (duration: 21.402209ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:21:34.502021Z","caller":"traceutil/trace.go:171","msg":"trace[1536523986] transaction","detail":"{read_only:false; response_revision:278; number_of_response:1; }","duration":"114.220657ms","start":"2026-02-05T05:21:34.387792Z","end":"2026-02-05T05:21:34.502013Z","steps":["trace[1536523986] 'process raft request' (duration: 92.640045ms)","trace[1536523986] 'compare' (duration: 21.320997ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:21:34.502196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.438034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:21:34.502218Z","caller":"traceutil/trace.go:171","msg":"trace[1011371472] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:0; response_revision:278; }","duration":"113.480755ms","start":"2026-02-05T05:21:34.388731Z","end":"2026-02-05T05:21:34.502212Z","steps":["trace[1011371472] 'agreement among raft nodes before linearized reading' (duration: 113.401353ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:34.691478Z","caller":"traceutil/trace.go:171","msg":"trace[1634900025] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"113.352943ms","start":"2026-02-05T05:21:34.578101Z","end":"2026-02-05T05:21:34.691454Z","steps":["trace[1634900025] 'process raft request' (duration: 113.311322ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:34.691598Z","caller":"traceutil/trace.go:171","msg":"trace[2036109241] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"128.109796ms","start":"2026-02-05T05:21:34.563452Z","end":"2026-02-05T05:21:34.691562Z","steps":["trace[2036109241] 'process raft request' (duration: 127.841702ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:34.691748Z","caller":"traceutil/trace.go:171","msg":"trace[1094449093] transaction","detail":"{read_only:false; number_of_response:0; response_revision:283; }","duration":"119.849925ms","start":"2026-02-05T05:21:34.571889Z","end":"2026-02-05T05:21:34.691739Z","steps":["trace[1094449093] 'process raft request' (duration: 119.454769ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:34.691813Z","caller":"traceutil/trace.go:171","msg":"trace[1611818909] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"128.954539ms","start":"2026-02-05T05:21:34.562846Z","end":"2026-02-05T05:21:34.691801Z","steps":["trace[1611818909] 'process raft request' (duration: 101.430864ms)","trace[1611818909] 'compare' (duration: 26.899115ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:21:34.691929Z","caller":"traceutil/trace.go:171","msg":"trace[2114065443] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"115.045839ms","start":"2026-02-05T05:21:34.576874Z","end":"2026-02-05T05:21:34.69192Z","steps":["trace[2114065443] 'process raft request' (duration: 114.502331ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:35.104937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.193744ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-05T05:21:35.105533Z","caller":"traceutil/trace.go:171","msg":"trace[793571502] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"318.40388ms","start":"2026-02-05T05:21:34.787092Z","end":"2026-02-05T05:21:35.105495Z","steps":["trace[793571502] 'process raft request' (duration: 318.361179ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:35.105626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:34.787079Z","time spent":"318.506992ms","remote":"127.0.0.1:38408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3431,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-05T05:21:35.10593Z","caller":"traceutil/trace.go:171","msg":"trace[1722763847] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"401.718298ms","start":"2026-02-05T05:21:34.704194Z","end":"2026-02-05T05:21:35.105912Z","steps":["trace[1722763847] 'process raft request' (duration: 196.460688ms)","trace[1722763847] 'compare' (duration: 204.019571ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:21:35.105995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:34.704178Z","time spent":"401.786119ms","remote":"127.0.0.1:38302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-05T05:21:35.106157Z","caller":"traceutil/trace.go:171","msg":"trace[2020397300] linearizableReadLoop","detail":"{readStateIndex:293; appliedIndex:292; }","duration":"401.776449ms","start":"2026-02-05T05:21:34.704367Z","end":"2026-02-05T05:21:35.106143Z","steps":["trace[2020397300] 'read index received' (duration: 196.306506ms)","trace[2020397300] 'applied index is now lower than readState.Index' (duration: 205.468273ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:21:35.106353Z","caller":"traceutil/trace.go:171","msg":"trace[1603822059] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"401.925481ms","start":"2026-02-05T05:21:34.704415Z","end":"2026-02-05T05:21:35.106341Z","steps":["trace[1603822059] 'process raft request' (duration: 400.680392ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:35.106408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:34.70441Z","time spent":"401.971032ms","remote":"127.0.0.1:38424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":164,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-05T05:21:35.106609Z","caller":"traceutil/trace.go:171","msg":"trace[791978737] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"323.076564ms","start":"2026-02-05T05:21:34.783522Z","end":"2026-02-05T05:21:35.106598Z","steps":["trace[791978737] 'process raft request' (duration: 321.712513ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:35.106675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:34.7835Z","time spent":"323.152335ms","remote":"127.0.0.1:38408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3943,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-05T05:21:35.106888Z","caller":"traceutil/trace.go:171","msg":"trace[656023013] transaction","detail":"{read_only:false; number_of_response:0; response_revision:288; }","duration":"322.23851ms","start":"2026-02-05T05:21:34.784639Z","end":"2026-02-05T05:21:35.106878Z","steps":["trace[656023013] 'process raft request' (duration: 320.678806ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:35.106936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:34.784626Z","time spent":"322.287151ms","remote":"127.0.0.1:38408","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-05T05:21:35.107076Z","caller":"traceutil/trace.go:171","msg":"trace[988931643] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"322.20116ms","start":"2026-02-05T05:21:34.784853Z","end":"2026-02-05T05:21:35.107054Z","steps":["trace[988931643] 'process raft request' (duration: 320.500434ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:35.107114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:34.784841Z","time spent":"322.256351ms","remote":"127.0.0.1:38408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5476,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-05T05:21:35.107192Z","caller":"traceutil/trace.go:171","msg":"trace[1314292543] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"320.29069ms","start":"2026-02-05T05:21:34.786895Z","end":"2026-02-05T05:21:35.107186Z","steps":["trace[1314292543] 'process raft request' (duration: 318.520183ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:35.107221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:34.786863Z","time spent":"320.343551ms","remote":"127.0.0.1:38408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5860,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-05T05:21:35.107377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.001508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3705"} {"level":"info","ts":"2026-02-05T05:21:35.107398Z","caller":"traceutil/trace.go:171","msg":"trace[1854152337] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:291; }","duration":"403.041918ms","start":"2026-02-05T05:21:34.704349Z","end":"2026-02-05T05:21:35.107391Z","steps":["trace[1854152337] 'agreement among raft nodes before linearized reading' (duration: 402.977207ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:35.10742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:34.704343Z","time spent":"403.072319ms","remote":"127.0.0.1:38404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3728,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-05T05:21:35.10753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.45325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:21:35.107548Z","caller":"traceutil/trace.go:171","msg":"trace[924722528] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/disruption-controller; range_end:; response_count:0; response_revision:291; }","duration":"402.48068ms","start":"2026-02-05T05:21:34.705062Z","end":"2026-02-05T05:21:35.107543Z","steps":["trace[924722528] 'agreement among raft nodes before linearized reading' (duration: 402.449089ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:35.107566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:34.705058Z","time spent":"402.50433ms","remote":"127.0.0.1:38424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" "} {"level":"info","ts":"2026-02-05T05:21:35.473744Z","caller":"traceutil/trace.go:171","msg":"trace[1892338459] linearizableReadLoop","detail":"{readStateIndex:303; appliedIndex:300; }","duration":"332.214244ms","start":"2026-02-05T05:21:35.141512Z","end":"2026-02-05T05:21:35.473726Z","steps":["trace[1892338459] 'read index received' (duration: 35.079049ms)","trace[1892338459] 'applied index is now lower than readState.Index' (duration: 297.134035ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:21:35.47412Z","caller":"traceutil/trace.go:171","msg":"trace[1311573500] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"344.628698ms","start":"2026-02-05T05:21:35.129481Z","end":"2026-02-05T05:21:35.47411Z","steps":["trace[1311573500] 'process raft request' (duration: 268.625527ms)","trace[1311573500] 'compare' (duration: 75.437042ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:21:35.474352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:35.129458Z","time spent":"344.691029ms","remote":"127.0.0.1:38404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3827,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T05:21:35.474673Z","caller":"traceutil/trace.go:171","msg":"trace[1240542070] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"344.886062ms","start":"2026-02-05T05:21:35.12978Z","end":"2026-02-05T05:21:35.474666Z","steps":["trace[1240542070] 'process raft request' (duration: 343.876106ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:35.474736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:35.129774Z","time spent":"344.942422ms","remote":"127.0.0.1:38424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-05T05:21:35.474906Z","caller":"traceutil/trace.go:171","msg":"trace[1972053312] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"343.665043ms","start":"2026-02-05T05:21:35.131232Z","end":"2026-02-05T05:21:35.474897Z","steps":["trace[1972053312] 'process raft request' (duration: 342.463814ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:35.474938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:35.131224Z","time spent":"343.699274ms","remote":"127.0.0.1:38680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3178,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-05T05:21:35.475102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.597575ms","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-02-05T05:21:35.47519Z","caller":"traceutil/trace.go:171","msg":"trace[2091954793] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:295; }","duration":"333.689257ms","start":"2026-02-05T05:21:35.141493Z","end":"2026-02-05T05:21:35.475182Z","steps":["trace[2091954793] 'agreement among raft nodes before linearized reading' (duration: 333.575595ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:35.475234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:35.141371Z","time spent":"333.855589ms","remote":"127.0.0.1:38484","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-05T05:21:35.706843Z","caller":"traceutil/trace.go:171","msg":"trace[93433643] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"159.909123ms","start":"2026-02-05T05:21:35.546879Z","end":"2026-02-05T05:21:35.706788Z","steps":["trace[93433643] 'process raft request' (duration: 159.784321ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:35.707157Z","caller":"traceutil/trace.go:171","msg":"trace[788300205] transaction","detail":"{read_only:false; number_of_response:0; response_revision:298; }","duration":"173.386244ms","start":"2026-02-05T05:21:35.533757Z","end":"2026-02-05T05:21:35.707143Z","steps":["trace[788300205] 'process raft request' (duration: 92.203683ms)","trace[788300205] 'compare' (duration: 80.382408ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:21:35.707202Z","caller":"traceutil/trace.go:171","msg":"trace[1600923876] transaction","detail":"{read_only:false; number_of_response:0; response_revision:298; }","duration":"172.745524ms","start":"2026-02-05T05:21:35.534444Z","end":"2026-02-05T05:21:35.707189Z","steps":["trace[1600923876] 'process raft request' (duration: 172.112414ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:35.707233Z","caller":"traceutil/trace.go:171","msg":"trace[879992000] transaction","detail":"{read_only:false; number_of_response:0; response_revision:298; }","duration":"172.361728ms","start":"2026-02-05T05:21:35.534862Z","end":"2026-02-05T05:21:35.707224Z","steps":["trace[879992000] 'process raft request' (duration: 171.752109ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:35.707266Z","caller":"traceutil/trace.go:171","msg":"trace[331415060] linearizableReadLoop","detail":"{readStateIndex:309; appliedIndex:306; }","duration":"162.373982ms","start":"2026-02-05T05:21:35.54488Z","end":"2026-02-05T05:21:35.707254Z","steps":["trace[331415060] 'read index received' (duration: 81.020978ms)","trace[331415060] 'applied index is now lower than readState.Index' (duration: 81.351824ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:21:35.707391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.90526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:21:35.710308Z","caller":"traceutil/trace.go:171","msg":"trace[1608675027] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/statefulset-controller; range_end:; response_count:0; response_revision:299; }","duration":"220.857386ms","start":"2026-02-05T05:21:35.489432Z","end":"2026-02-05T05:21:35.710289Z","steps":["trace[1608675027] 'agreement among raft nodes before linearized reading' (duration: 217.856539ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:35.707448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.807256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5875"} {"level":"info","ts":"2026-02-05T05:21:35.710898Z","caller":"traceutil/trace.go:171","msg":"trace[1538234655] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:299; }","duration":"178.2814ms","start":"2026-02-05T05:21:35.532602Z","end":"2026-02-05T05:21:35.710883Z","steps":["trace[1538234655] 'agreement among raft nodes before linearized reading' (duration: 174.815306ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:35.857733Z","caller":"traceutil/trace.go:171","msg":"trace[462763401] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"107.799989ms","start":"2026-02-05T05:21:35.749908Z","end":"2026-02-05T05:21:35.857708Z","steps":["trace[462763401] 'process raft request' (duration: 107.760138ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:35.858817Z","caller":"traceutil/trace.go:171","msg":"trace[300908994] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"134.925113ms","start":"2026-02-05T05:21:35.723875Z","end":"2026-02-05T05:21:35.8588Z","steps":["trace[300908994] 'process raft request' (duration: 87.067613ms)","trace[300908994] 'compare' (duration: 46.522509ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:21:35.860082Z","caller":"traceutil/trace.go:171","msg":"trace[639950165] linearizableReadLoop","detail":"{readStateIndex:313; appliedIndex:311; }","duration":"120.840213ms","start":"2026-02-05T05:21:35.737971Z","end":"2026-02-05T05:21:35.858811Z","steps":["trace[639950165] 'read index received' (duration: 73.665974ms)","trace[639950165] 'applied index is now lower than readState.Index' (duration: 47.169379ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:21:35.860502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.695406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3958"} {"level":"info","ts":"2026-02-05T05:21:35.860593Z","caller":"traceutil/trace.go:171","msg":"trace[13475824] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:303; }","duration":"137.821878ms","start":"2026-02-05T05:21:35.722756Z","end":"2026-02-05T05:21:35.860578Z","steps":["trace[13475824] 'agreement among raft nodes before linearized reading' (duration: 137.476113ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:35.861223Z","caller":"traceutil/trace.go:171","msg":"trace[1983333132] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"128.754716ms","start":"2026-02-05T05:21:35.732452Z","end":"2026-02-05T05:21:35.861207Z","steps":["trace[1983333132] 'process raft request' (duration: 125.15095ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:36.238547Z","caller":"traceutil/trace.go:171","msg":"trace[1164116683] linearizableReadLoop","detail":"{readStateIndex:325; appliedIndex:324; }","duration":"109.743791ms","start":"2026-02-05T05:21:36.128785Z","end":"2026-02-05T05:21:36.238529Z","steps":["trace[1164116683] 'read index received' (duration: 85.604907ms)","trace[1164116683] 'applied index is now lower than readState.Index' (duration: 24.138204ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:21:36.238699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.891023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:21:36.238722Z","caller":"traceutil/trace.go:171","msg":"trace[1596826109] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:0; response_revision:314; }","duration":"109.938674ms","start":"2026-02-05T05:21:36.128773Z","end":"2026-02-05T05:21:36.238712Z","steps":["trace[1596826109] 'agreement among raft nodes before linearized reading' (duration: 109.830102ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:36.238909Z","caller":"traceutil/trace.go:171","msg":"trace[3152521] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"115.48656ms","start":"2026-02-05T05:21:36.123415Z","end":"2026-02-05T05:21:36.238902Z","steps":["trace[3152521] 'process raft request' (duration: 91.029021ms)","trace[3152521] 'compare' (duration: 23.971761ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:21:36.542227Z","caller":"traceutil/trace.go:171","msg":"trace[760984867] linearizableReadLoop","detail":"{readStateIndex:328; appliedIndex:327; }","duration":"245.916839ms","start":"2026-02-05T05:21:36.296283Z","end":"2026-02-05T05:21:36.5422Z","steps":["trace[760984867] 'read index received' (duration: 161.97646ms)","trace[760984867] 'applied index is now lower than readState.Index' (duration: 83.938649ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:21:36.542355Z","caller":"traceutil/trace.go:171","msg":"trace[2056855474] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"246.382837ms","start":"2026-02-05T05:21:36.295942Z","end":"2026-02-05T05:21:36.542325Z","steps":["trace[2056855474] 'process raft request' (duration: 162.311566ms)","trace[2056855474] 'compare' (duration: 83.407401ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:21:36.542442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.115282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:21:36.542483Z","caller":"traceutil/trace.go:171","msg":"trace[828798117] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-controller; range_end:; response_count:0; response_revision:317; }","duration":"246.199374ms","start":"2026-02-05T05:21:36.296272Z","end":"2026-02-05T05:21:36.542471Z","steps":["trace[828798117] 'agreement among raft nodes before linearized reading' (duration: 246.096593ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:36.542666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.705065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-05T05:21:36.542692Z","caller":"traceutil/trace.go:171","msg":"trace[1157966150] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:317; }","duration":"223.748366ms","start":"2026-02-05T05:21:36.318937Z","end":"2026-02-05T05:21:36.542685Z","steps":["trace[1157966150] 'agreement among raft nodes before linearized reading' (duration: 223.657034ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:36.692153Z","caller":"traceutil/trace.go:171","msg":"trace[1901517406] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"125.465534ms","start":"2026-02-05T05:21:36.566659Z","end":"2026-02-05T05:21:36.692124Z","steps":["trace[1901517406] 'process raft request' (duration: 95.118524ms)","trace[1901517406] 'compare' (duration: 29.732171ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:21:39.191393Z","caller":"traceutil/trace.go:171","msg":"trace[1076282195] linearizableReadLoop","detail":"{readStateIndex:365; appliedIndex:364; }","duration":"171.4709ms","start":"2026-02-05T05:21:39.019883Z","end":"2026-02-05T05:21:39.191354Z","steps":["trace[1076282195] 'read index received' (duration: 73.635498ms)","trace[1076282195] 'applied index is now lower than readState.Index' (duration: 97.834702ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:21:39.191545Z","caller":"traceutil/trace.go:171","msg":"trace[500230359] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"188.548278ms","start":"2026-02-05T05:21:39.002917Z","end":"2026-02-05T05:21:39.191465Z","steps":["trace[500230359] 'process raft request' (duration: 90.544013ms)","trace[500230359] 'compare' (duration: 97.811242ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:21:39.192045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.152471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-02-05T05:21:39.192074Z","caller":"traceutil/trace.go:171","msg":"trace[703451005] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:354; }","duration":"172.212281ms","start":"2026-02-05T05:21:39.019852Z","end":"2026-02-05T05:21:39.192064Z","steps":["trace[703451005] 'agreement among raft nodes before linearized reading' (duration: 172.168671ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:39.192551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.326281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-02-05T05:21:39.192623Z","caller":"traceutil/trace.go:171","msg":"trace[1265321603] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:354; }","duration":"122.421972ms","start":"2026-02-05T05:21:39.070188Z","end":"2026-02-05T05:21:39.19261Z","steps":["trace[1265321603] 'agreement among raft nodes before linearized reading' (duration: 121.656761ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:21:47.995701Z","caller":"traceutil/trace.go:171","msg":"trace[1200830079] linearizableReadLoop","detail":"{readStateIndex:464; appliedIndex:463; }","duration":"409.032953ms","start":"2026-02-05T05:21:47.586645Z","end":"2026-02-05T05:21:47.995678Z","steps":["trace[1200830079] 'read index received' (duration: 384.632271ms)","trace[1200830079] 'applied index is now lower than readState.Index' (duration: 24.399782ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:21:47.995995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.331607ms","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-05T05:21:47.996159Z","caller":"traceutil/trace.go:171","msg":"trace[1435905551] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:450; }","duration":"409.556761ms","start":"2026-02-05T05:21:47.586592Z","end":"2026-02-05T05:21:47.996149Z","steps":["trace[1435905551] 'agreement among raft nodes before linearized reading' (duration: 409.316508ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:47.99632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:47.586573Z","time spent":"409.736373ms","remote":"127.0.0.1:38484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-05T05:21:47.996687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.048534ms","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-02-05T05:21:47.996714Z","caller":"traceutil/trace.go:171","msg":"trace[1896592735] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:450; }","duration":"377.115235ms","start":"2026-02-05T05:21:47.619593Z","end":"2026-02-05T05:21:47.996708Z","steps":["trace[1896592735] 'agreement among raft nodes before linearized reading' (duration: 377.069484ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:47.996733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:47.619573Z","time spent":"377.156426ms","remote":"127.0.0.1:38484","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-05T05:21:47.996074Z","caller":"traceutil/trace.go:171","msg":"trace[499827616] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"439.044135ms","start":"2026-02-05T05:21:47.557011Z","end":"2026-02-05T05:21:47.996055Z","steps":["trace[499827616] 'process raft request' (duration: 414.323068ms)","trace[499827616] 'compare' (duration: 24.2412ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:21:47.997067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:47.556998Z","time spent":"439.919407ms","remote":"127.0.0.1:38680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4158,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T05:21:47.997362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.909706ms","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-02-05T05:21:47.99739Z","caller":"traceutil/trace.go:171","msg":"trace[1519548688] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:450; }","duration":"372.954127ms","start":"2026-02-05T05:21:47.624429Z","end":"2026-02-05T05:21:47.997383Z","steps":["trace[1519548688] 'agreement among raft nodes before linearized reading' (duration: 372.888306ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:21:47.997562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:21:47.624422Z","time spent":"373.079299ms","remote":"127.0.0.1:38484","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-05T05:22:00.57003Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":708644230238941009,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-05T05:22:01.070336Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":708644230238941009,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-05T05:22:01.153628Z","caller":"traceutil/trace.go:171","msg":"trace[1300818247] linearizableReadLoop","detail":"{readStateIndex:529; appliedIndex:528; }","duration":"1.084514814s","start":"2026-02-05T05:22:00.069098Z","end":"2026-02-05T05:22:01.153613Z","steps":["trace[1300818247] 'read index received' (duration: 1.084376962s)","trace[1300818247] 'applied index is now lower than readState.Index' (duration: 136.952µs)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:22:01.15375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.084636185s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-05T05:22:01.153741Z","caller":"traceutil/trace.go:171","msg":"trace[1095368190] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"1.086310357s","start":"2026-02-05T05:22:00.067404Z","end":"2026-02-05T05:22:01.153714Z","steps":["trace[1095368190] 'process raft request' (duration: 1.086123885s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:01.153796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.084075398s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-05T05:22:01.15381Z","caller":"traceutil/trace.go:171","msg":"trace[1244259883] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:513; }","duration":"1.084114208s","start":"2026-02-05T05:22:00.069693Z","end":"2026-02-05T05:22:01.153807Z","steps":["trace[1244259883] 'agreement among raft nodes before linearized reading' (duration: 1.084089378s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:01.153829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:00.06968Z","time spent":"1.084144759s","remote":"127.0.0.1:38484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-05T05:22:01.153869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:00.067385Z","time spent":"1.086414678s","remote":"127.0.0.1:38484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T05:22:01.153994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.54867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:22:01.154036Z","caller":"traceutil/trace.go:171","msg":"trace[220976373] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:513; }","duration":"158.60798ms","start":"2026-02-05T05:22:00.995406Z","end":"2026-02-05T05:22:01.154014Z","steps":["trace[220976373] 'agreement among raft nodes before linearized reading' (duration: 158.57607ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:01.153769Z","caller":"traceutil/trace.go:171","msg":"trace[1596257681] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:513; }","duration":"1.084712836s","start":"2026-02-05T05:22:00.06905Z","end":"2026-02-05T05:22:01.153762Z","steps":["trace[1596257681] 'agreement among raft nodes before linearized reading' (duration: 1.084649695s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:01.154128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.921155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-02-05T05:22:01.154126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:00.069039Z","time spent":"1.085079581s","remote":"127.0.0.1:38484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-05T05:22:01.154143Z","caller":"traceutil/trace.go:171","msg":"trace[795415933] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:513; }","duration":"493.973006ms","start":"2026-02-05T05:22:00.660165Z","end":"2026-02-05T05:22:01.154138Z","steps":["trace[795415933] 'agreement among raft nodes before linearized reading' (duration: 493.946495ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:01.154158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:00.660147Z","time spent":"494.007846ms","remote":"127.0.0.1:38484","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-05T05:22:01.154202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.496995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.110\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-05T05:22:01.154212Z","caller":"traceutil/trace.go:171","msg":"trace[1267041737] range","detail":"{range_begin:/registry/masterleases/162.253.55.110; range_end:; response_count:1; response_revision:513; }","duration":"736.540237ms","start":"2026-02-05T05:22:00.417668Z","end":"2026-02-05T05:22:01.154209Z","steps":["trace[1267041737] 'agreement among raft nodes before linearized reading' (duration: 736.519406ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:01.154223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:00.417653Z","time spent":"736.568297ms","remote":"127.0.0.1:38250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.110\" "} {"level":"warn","ts":"2026-02-05T05:22:01.154292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"857.632875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4019"} {"level":"info","ts":"2026-02-05T05:22:01.154303Z","caller":"traceutil/trace.go:171","msg":"trace[791320056] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:513; }","duration":"857.678165ms","start":"2026-02-05T05:22:00.296622Z","end":"2026-02-05T05:22:01.1543Z","steps":["trace[791320056] 'agreement among raft nodes before linearized reading' (duration: 857.654924ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:01.154315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:00.296604Z","time spent":"857.707265ms","remote":"127.0.0.1:38404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4042,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-05T05:22:01.6606Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":708644230238941012,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-05T05:22:02.095879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:01.158082Z","time spent":"937.793284ms","remote":"127.0.0.1:38250","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-05T05:22:02.133727Z","caller":"traceutil/trace.go:171","msg":"trace[596137182] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"974.007945ms","start":"2026-02-05T05:22:01.159698Z","end":"2026-02-05T05:22:02.133706Z","steps":["trace[596137182] 'process raft request' (duration: 973.738672ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:02.133909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"974.137258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:22:02.133955Z","caller":"traceutil/trace.go:171","msg":"trace[1036563354] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:517; }","duration":"974.213238ms","start":"2026-02-05T05:22:01.159731Z","end":"2026-02-05T05:22:02.133944Z","steps":["trace[1036563354] 'agreement among raft nodes before linearized reading' (duration: 974.067356ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:02.133917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:01.159688Z","time spent":"974.135247ms","remote":"127.0.0.1:38484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T05:22:02.134029Z","caller":"traceutil/trace.go:171","msg":"trace[1778433355] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"972.770549ms","start":"2026-02-05T05:22:01.161249Z","end":"2026-02-05T05:22:02.134019Z","steps":["trace[1778433355] 'process raft request' (duration: 972.359424ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:02.134106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:01.16124Z","time spent":"972.81617ms","remote":"127.0.0.1:38484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T05:22:02.134362Z","caller":"traceutil/trace.go:171","msg":"trace[194210860] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"973.064824ms","start":"2026-02-05T05:22:01.161288Z","end":"2026-02-05T05:22:02.134353Z","steps":["trace[194210860] 'process raft request' (duration: 972.360185ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:02.134423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:01.161284Z","time spent":"973.109354ms","remote":"127.0.0.1:38404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4211,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T05:22:02.134554Z","caller":"traceutil/trace.go:171","msg":"trace[1949876377] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"972.678118ms","start":"2026-02-05T05:22:01.161865Z","end":"2026-02-05T05:22:02.134543Z","steps":["trace[1949876377] 'process raft request' (duration: 971.818227ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:02.134607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:01.161858Z","time spent":"972.724349ms","remote":"127.0.0.1:38484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T05:22:02.133994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:01.159725Z","time spent":"974.260719ms","remote":"127.0.0.1:38222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-05T05:22:02.133741Z","caller":"traceutil/trace.go:171","msg":"trace[1252599764] linearizableReadLoop","detail":"{readStateIndex:534; appliedIndex:529; }","duration":"973.970764ms","start":"2026-02-05T05:22:01.159747Z","end":"2026-02-05T05:22:02.133718Z","steps":["trace[1252599764] 'read index received' (duration: 891.456894ms)","trace[1252599764] 'applied index is now lower than readState.Index' (duration: 82.51279ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:22:02.165225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.561455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:22:02.165351Z","caller":"traceutil/trace.go:171","msg":"trace[174562810] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:518; }","duration":"124.724488ms","start":"2026-02-05T05:22:02.040615Z","end":"2026-02-05T05:22:02.16534Z","steps":["trace[174562810] 'agreement among raft nodes before linearized reading' (duration: 124.530745ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:05.01866Z","caller":"traceutil/trace.go:171","msg":"trace[871316346] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"117.610201ms","start":"2026-02-05T05:22:04.901034Z","end":"2026-02-05T05:22:05.018644Z","steps":["trace[871316346] 'process raft request' (duration: 117.499709ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:05.032706Z","caller":"traceutil/trace.go:171","msg":"trace[290734216] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"103.989837ms","start":"2026-02-05T05:22:04.928702Z","end":"2026-02-05T05:22:05.032692Z","steps":["trace[290734216] 'process raft request' (duration: 103.707624ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:05.191256Z","caller":"traceutil/trace.go:171","msg":"trace[1338664291] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"160.625312ms","start":"2026-02-05T05:22:05.030601Z","end":"2026-02-05T05:22:05.191227Z","steps":["trace[1338664291] 'process raft request' (duration: 160.533981ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:05.191649Z","caller":"traceutil/trace.go:171","msg":"trace[1949522945] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"161.135128ms","start":"2026-02-05T05:22:05.030476Z","end":"2026-02-05T05:22:05.191611Z","steps":["trace[1949522945] 'process raft request' (duration: 102.859759ms)","trace[1949522945] 'compare' (duration: 57.640691ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:22:05.250576Z","caller":"traceutil/trace.go:171","msg":"trace[641977016] linearizableReadLoop","detail":"{readStateIndex:544; appliedIndex:541; }","duration":"216.172587ms","start":"2026-02-05T05:22:05.034377Z","end":"2026-02-05T05:22:05.25055Z","steps":["trace[641977016] 'read index received' (duration: 98.914069ms)","trace[641977016] 'applied index is now lower than readState.Index' (duration: 117.257578ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:22:05.250845Z","caller":"traceutil/trace.go:171","msg":"trace[62304976] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"216.617654ms","start":"2026-02-05T05:22:05.034215Z","end":"2026-02-05T05:22:05.250833Z","steps":["trace[62304976] 'process raft request' (duration: 216.205539ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:05.259253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.1739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:22:05.259331Z","caller":"traceutil/trace.go:171","msg":"trace[1006204525] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:527; }","duration":"224.961318ms","start":"2026-02-05T05:22:05.034357Z","end":"2026-02-05T05:22:05.259318Z","steps":["trace[1006204525] 'agreement among raft nodes before linearized reading' (duration: 217.15995ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:05.364384Z","caller":"traceutil/trace.go:171","msg":"trace[1037862883] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"105.233008ms","start":"2026-02-05T05:22:05.259125Z","end":"2026-02-05T05:22:05.364358Z","steps":["trace[1037862883] 'process raft request' (duration: 36.014711ms)","trace[1037862883] 'compare' (duration: 68.808242ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:22:05.593825Z","caller":"traceutil/trace.go:171","msg":"trace[378205754] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"334.194028ms","start":"2026-02-05T05:22:05.259571Z","end":"2026-02-05T05:22:05.593765Z","steps":["trace[378205754] 'process raft request' (duration: 255.694754ms)","trace[378205754] 'compare' (duration: 78.098139ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:22:05.595386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:05.259541Z","time spent":"335.699086ms","remote":"127.0.0.1:38484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T05:22:05.596867Z","caller":"traceutil/trace.go:171","msg":"trace[1038256128] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"227.947366ms","start":"2026-02-05T05:22:05.368902Z","end":"2026-02-05T05:22:05.59685Z","steps":["trace[1038256128] 'process raft request' (duration: 224.621565ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:05.710405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.677952ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-05T05:22:05.710575Z","caller":"traceutil/trace.go:171","msg":"trace[764510518] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"108.302247ms","start":"2026-02-05T05:22:05.602262Z","end":"2026-02-05T05:22:05.710564Z","steps":["trace[764510518] 'process raft request' (duration: 108.211636ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:05.956118Z","caller":"traceutil/trace.go:171","msg":"trace[73413265] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"240.255631ms","start":"2026-02-05T05:22:05.715845Z","end":"2026-02-05T05:22:05.9561Z","steps":["trace[73413265] 'process raft request' (duration: 240.140299ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:06.320591Z","caller":"traceutil/trace.go:171","msg":"trace[703573844] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"172.848855ms","start":"2026-02-05T05:22:06.147729Z","end":"2026-02-05T05:22:06.320578Z","steps":["trace[703573844] 'process raft request' (duration: 172.574712ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:06.320706Z","caller":"traceutil/trace.go:171","msg":"trace[2108000404] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"172.940987ms","start":"2026-02-05T05:22:06.14776Z","end":"2026-02-05T05:22:06.320701Z","steps":["trace[2108000404] 'process raft request' (duration: 172.613073ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:06.320812Z","caller":"traceutil/trace.go:171","msg":"trace[1115568643] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"173.020467ms","start":"2026-02-05T05:22:06.147787Z","end":"2026-02-05T05:22:06.320808Z","steps":["trace[1115568643] 'process raft request' (duration: 172.612272ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:06.320922Z","caller":"traceutil/trace.go:171","msg":"trace[1034181796] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"172.794374ms","start":"2026-02-05T05:22:06.148124Z","end":"2026-02-05T05:22:06.320918Z","steps":["trace[1034181796] 'process raft request' (duration: 172.298188ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:06.321026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.596371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-05T05:22:06.321047Z","caller":"traceutil/trace.go:171","msg":"trace[575205833] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:544; }","duration":"159.625601ms","start":"2026-02-05T05:22:06.161416Z","end":"2026-02-05T05:22:06.321042Z","steps":["trace[575205833] 'agreement among raft nodes before linearized reading' (duration: 159.55506ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:06.321128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.16426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-05T05:22:06.321143Z","caller":"traceutil/trace.go:171","msg":"trace[1569234185] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:544; }","duration":"165.17897ms","start":"2026-02-05T05:22:06.15596Z","end":"2026-02-05T05:22:06.321139Z","steps":["trace[1569234185] 'agreement among raft nodes before linearized reading' (duration: 165.13923ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:06.321226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.339612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-05T05:22:06.321242Z","caller":"traceutil/trace.go:171","msg":"trace[1086606515] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:544; }","duration":"165.379302ms","start":"2026-02-05T05:22:06.155859Z","end":"2026-02-05T05:22:06.321238Z","steps":["trace[1086606515] 'agreement among raft nodes before linearized reading' (duration: 165.337812ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:06.493459Z","caller":"traceutil/trace.go:171","msg":"trace[941584823] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"152.730244ms","start":"2026-02-05T05:22:06.340712Z","end":"2026-02-05T05:22:06.493442Z","steps":["trace[941584823] 'process raft request' (duration: 152.701744ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:06.493984Z","caller":"traceutil/trace.go:171","msg":"trace[1283108417] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"158.874141ms","start":"2026-02-05T05:22:06.3351Z","end":"2026-02-05T05:22:06.493974Z","steps":["trace[1283108417] 'process raft request' (duration: 156.691044ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:06.494141Z","caller":"traceutil/trace.go:171","msg":"trace[1464419236] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"157.652956ms","start":"2026-02-05T05:22:06.336481Z","end":"2026-02-05T05:22:06.494134Z","steps":["trace[1464419236] 'process raft request' (duration: 156.899846ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:06.634979Z","caller":"traceutil/trace.go:171","msg":"trace[1584463447] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"130.537557ms","start":"2026-02-05T05:22:06.504418Z","end":"2026-02-05T05:22:06.634956Z","steps":["trace[1584463447] 'process raft request' (duration: 129.94063ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:08.540821Z","caller":"traceutil/trace.go:171","msg":"trace[1194941590] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"164.045866ms","start":"2026-02-05T05:22:08.376753Z","end":"2026-02-05T05:22:08.540799Z","steps":["trace[1194941590] 'process raft request' (duration: 163.715502ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:08.734161Z","caller":"traceutil/trace.go:171","msg":"trace[609048187] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"187.435424ms","start":"2026-02-05T05:22:08.546703Z","end":"2026-02-05T05:22:08.734138Z","steps":["trace[609048187] 'process raft request' (duration: 187.371673ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:08.734527Z","caller":"traceutil/trace.go:171","msg":"trace[517432507] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"187.987531ms","start":"2026-02-05T05:22:08.546527Z","end":"2026-02-05T05:22:08.734515Z","steps":["trace[517432507] 'process raft request' (duration: 105.929149ms)","trace[517432507] 'compare' (duration: 81.501135ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:22:10.010971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.016056033s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:22:10.011048Z","caller":"traceutil/trace.go:171","msg":"trace[997554240] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:553; }","duration":"1.016153265s","start":"2026-02-05T05:22:08.994877Z","end":"2026-02-05T05:22:10.011031Z","steps":["trace[997554240] 'range keys from in-memory index tree' (duration: 1.015998932s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:10.011087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:08.994839Z","time spent":"1.016241745s","remote":"127.0.0.1:38232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-05T05:22:10.016045Z","caller":"traceutil/trace.go:171","msg":"trace[1307432751] linearizableReadLoop","detail":"{readStateIndex:572; appliedIndex:571; }","duration":"339.428203ms","start":"2026-02-05T05:22:09.676606Z","end":"2026-02-05T05:22:10.016035Z","steps":["trace[1307432751] 'read index received' (duration: 339.21198ms)","trace[1307432751] 'applied index is now lower than readState.Index' (duration: 215.383µs)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:22:10.016244Z","caller":"traceutil/trace.go:171","msg":"trace[271385537] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"361.548684ms","start":"2026-02-05T05:22:09.654685Z","end":"2026-02-05T05:22:10.016234Z","steps":["trace[271385537] 'process raft request' (duration: 361.22807ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:10.016345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:09.654662Z","time spent":"361.607596ms","remote":"127.0.0.1:38484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T05:22:10.016551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.947889ms","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-05T05:22:10.016571Z","caller":"traceutil/trace.go:171","msg":"trace[814435508] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:554; }","duration":"339.992399ms","start":"2026-02-05T05:22:09.676571Z","end":"2026-02-05T05:22:10.016563Z","steps":["trace[814435508] 'agreement among raft nodes before linearized reading' (duration: 339.880328ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:10.016589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:09.676556Z","time spent":"340.02814ms","remote":"127.0.0.1:38484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-05T05:22:13.123823Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":708644230238941120,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-05T05:22:13.150056Z","caller":"traceutil/trace.go:171","msg":"trace[185050699] linearizableReadLoop","detail":"{readStateIndex:583; appliedIndex:582; }","duration":"526.915438ms","start":"2026-02-05T05:22:12.623125Z","end":"2026-02-05T05:22:13.15004Z","steps":["trace[185050699] 'read index received' (duration: 526.798357ms)","trace[185050699] 'applied index is now lower than readState.Index' (duration: 116.381µs)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:22:13.150252Z","caller":"traceutil/trace.go:171","msg":"trace[1596704988] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"591.327111ms","start":"2026-02-05T05:22:12.558917Z","end":"2026-02-05T05:22:13.150244Z","steps":["trace[1596704988] 'process raft request' (duration: 591.018677ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:13.150326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:12.5589Z","time spent":"591.377651ms","remote":"127.0.0.1:38484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T05:22:13.15051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.385224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dcqd8\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-05T05:22:13.150536Z","caller":"traceutil/trace.go:171","msg":"trace[1561183599] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dcqd8; range_end:; response_count:1; response_revision:564; }","duration":"527.436495ms","start":"2026-02-05T05:22:12.623092Z","end":"2026-02-05T05:22:13.150529Z","steps":["trace[1561183599] 'agreement among raft nodes before linearized reading' (duration: 527.340024ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:13.150555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:12.623079Z","time spent":"527.471436ms","remote":"127.0.0.1:38408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16679,"request content":"key:\"/registry/pods/kube-system/cilium-dcqd8\" "} {"level":"warn","ts":"2026-02-05T05:22:13.150649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.367683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-05T05:22:13.150695Z","caller":"traceutil/trace.go:171","msg":"trace[683032560] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:564; }","duration":"405.456744ms","start":"2026-02-05T05:22:12.745226Z","end":"2026-02-05T05:22:13.150683Z","steps":["trace[683032560] 'agreement among raft nodes before linearized reading' (duration: 405.289702ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:13.15072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:12.745203Z","time spent":"405.512906ms","remote":"127.0.0.1:38484","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-05T05:22:13.15082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.531446ms","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-02-05T05:22:13.150842Z","caller":"traceutil/trace.go:171","msg":"trace[1267985220] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:564; }","duration":"405.561946ms","start":"2026-02-05T05:22:12.745274Z","end":"2026-02-05T05:22:13.150836Z","steps":["trace[1267985220] 'agreement among raft nodes before linearized reading' (duration: 405.503575ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:13.15086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:12.74527Z","time spent":"405.585606ms","remote":"127.0.0.1:38484","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-05T05:22:14.144991Z","caller":"traceutil/trace.go:171","msg":"trace[1140329297] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"988.350292ms","start":"2026-02-05T05:22:13.156616Z","end":"2026-02-05T05:22:14.144967Z","steps":["trace[1140329297] 'process raft request' (duration: 988.20724ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:14.14621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:13.156592Z","time spent":"988.471153ms","remote":"127.0.0.1:38484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T05:22:14.246685Z","caller":"traceutil/trace.go:171","msg":"trace[1620684059] linearizableReadLoop","detail":"{readStateIndex:586; appliedIndex:583; }","duration":"253.955849ms","start":"2026-02-05T05:22:13.992675Z","end":"2026-02-05T05:22:14.246631Z","steps":["trace[1620684059] 'read index received' (duration: 152.078522ms)","trace[1620684059] 'applied index is now lower than readState.Index' (duration: 101.876267ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:22:14.246858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.162431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:22:14.246887Z","caller":"traceutil/trace.go:171","msg":"trace[371983210] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:567; }","duration":"254.249532ms","start":"2026-02-05T05:22:13.992629Z","end":"2026-02-05T05:22:14.246878Z","steps":["trace[371983210] 'agreement among raft nodes before linearized reading' (duration: 254.13187ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:14.247151Z","caller":"traceutil/trace.go:171","msg":"trace[511053249] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"1.090504532s","start":"2026-02-05T05:22:13.156639Z","end":"2026-02-05T05:22:14.247143Z","steps":["trace[511053249] 'process raft request' (duration: 1.089738073s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:14.247243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:13.156622Z","time spent":"1.090553262s","remote":"127.0.0.1:38484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T05:22:14.247422Z","caller":"traceutil/trace.go:171","msg":"trace[1622590024] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"1.079260916s","start":"2026-02-05T05:22:13.168154Z","end":"2026-02-05T05:22:14.247415Z","steps":["trace[1622590024] 'process raft request' (duration: 1.078424236s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:14.24746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:13.168141Z","time spent":"1.079299367s","remote":"127.0.0.1:38408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T05:22:14.247617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.209041ms","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-02-05T05:22:14.247653Z","caller":"traceutil/trace.go:171","msg":"trace[656647844] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:567; }","duration":"200.265362ms","start":"2026-02-05T05:22:14.047366Z","end":"2026-02-05T05:22:14.247631Z","steps":["trace[656647844] 'agreement among raft nodes before linearized reading' (duration: 200.176191ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:16.016766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.126399155s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-05T05:22:16.016938Z","caller":"traceutil/trace.go:171","msg":"trace[497012542] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"722.217591ms","start":"2026-02-05T05:22:15.294709Z","end":"2026-02-05T05:22:16.016926Z","steps":["trace[497012542] 'process raft request' (duration: 722.15508ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:16.017005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:15.294684Z","time spent":"722.299933ms","remote":"127.0.0.1:38484","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-02-05T05:22:16.017314Z","caller":"traceutil/trace.go:171","msg":"trace[736796766] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"1.755746453s","start":"2026-02-05T05:22:14.261559Z","end":"2026-02-05T05:22:16.017306Z","steps":["trace[736796766] 'process raft request' (duration: 628.71382ms)","trace[736796766] 'compare' (duration: 1.125794528s)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:22:16.017352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:14.261535Z","time spent":"1.755796324s","remote":"127.0.0.1:38484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T05:22:16.017492Z","caller":"traceutil/trace.go:171","msg":"trace[1102512151] linearizableReadLoop","detail":"{readStateIndex:587; appliedIndex:586; }","duration":"1.022790408s","start":"2026-02-05T05:22:14.994694Z","end":"2026-02-05T05:22:16.017484Z","steps":["trace[1102512151] 'read index received' (duration: 28.051µs)","trace[1102512151] 'applied index is now lower than readState.Index' (duration: 1.022761197s)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:22:16.017605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.022909909s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:22:16.01764Z","caller":"traceutil/trace.go:171","msg":"trace[1597527412] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:569; }","duration":"1.02297196s","start":"2026-02-05T05:22:14.994662Z","end":"2026-02-05T05:22:16.017634Z","steps":["trace[1597527412] 'agreement among raft nodes before linearized reading' (duration: 1.022924759s)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:16.017656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:14.994647Z","time spent":"1.02300556s","remote":"127.0.0.1:38232","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-02-05T05:22:16.017847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"862.12856ms","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-02-05T05:22:16.017878Z","caller":"traceutil/trace.go:171","msg":"trace[1993002264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:569; }","duration":"862.196261ms","start":"2026-02-05T05:22:15.155675Z","end":"2026-02-05T05:22:16.017871Z","steps":["trace[1993002264] 'agreement among raft nodes before linearized reading' (duration: 862.088259ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:16.017904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:15.155655Z","time spent":"862.242151ms","remote":"127.0.0.1:38484","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-05T05:22:16.768391Z","caller":"traceutil/trace.go:171","msg":"trace[1736344431] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"126.191978ms","start":"2026-02-05T05:22:16.642176Z","end":"2026-02-05T05:22:16.768368Z","steps":["trace[1736344431] 'process raft request' (duration: 126.004136ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:16.782489Z","caller":"traceutil/trace.go:171","msg":"trace[1016090932] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"134.481297ms","start":"2026-02-05T05:22:16.64799Z","end":"2026-02-05T05:22:16.782471Z","steps":["trace[1016090932] 'process raft request' (duration: 134.318165ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:17.88857Z","caller":"traceutil/trace.go:171","msg":"trace[2025047097] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"207.061015ms","start":"2026-02-05T05:22:17.681489Z","end":"2026-02-05T05:22:17.88855Z","steps":["trace[2025047097] 'process raft request' (duration: 174.482297ms)","trace[2025047097] 'compare' (duration: 32.485357ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:22:18.284707Z","caller":"traceutil/trace.go:171","msg":"trace[1113515684] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"118.856721ms","start":"2026-02-05T05:22:18.165835Z","end":"2026-02-05T05:22:18.284691Z","steps":["trace[1113515684] 'read index received' (duration: 41.539903ms)","trace[1113515684] 'applied index is now lower than readState.Index' (duration: 77.316208ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:22:18.28486Z","caller":"traceutil/trace.go:171","msg":"trace[2047975281] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"213.876988ms","start":"2026-02-05T05:22:18.070976Z","end":"2026-02-05T05:22:18.284852Z","steps":["trace[2047975281] 'process raft request' (duration: 136.434178ms)","trace[2047975281] 'compare' (duration: 77.220727ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:22:18.285025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.179914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-05T05:22:18.28505Z","caller":"traceutil/trace.go:171","msg":"trace[1545886450] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:580; }","duration":"119.241875ms","start":"2026-02-05T05:22:18.165802Z","end":"2026-02-05T05:22:18.285044Z","steps":["trace[1545886450] 'agreement among raft nodes before linearized reading' (duration: 119.156504ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:18.983732Z","caller":"traceutil/trace.go:171","msg":"trace[1535386135] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"359.912751ms","start":"2026-02-05T05:22:18.623796Z","end":"2026-02-05T05:22:18.983709Z","steps":["trace[1535386135] 'process raft request' (duration: 359.80427ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:22:18.983857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:22:18.623786Z","time spent":"360.010572ms","remote":"127.0.0.1:38484","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-02-05T05:22:21.398246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.8116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-02-05T05:22:21.398322Z","caller":"traceutil/trace.go:171","msg":"trace[592648645] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:641; }","duration":"195.929581ms","start":"2026-02-05T05:22:21.202374Z","end":"2026-02-05T05:22:21.398304Z","steps":["trace[592648645] 'range keys from in-memory index tree' (duration: 195.552587ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:34.502765Z","caller":"traceutil/trace.go:171","msg":"trace[408295311] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"192.593422ms","start":"2026-02-05T05:22:34.310162Z","end":"2026-02-05T05:22:34.502756Z","steps":["trace[408295311] 'process raft request' (duration: 192.330783ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:34.502605Z","caller":"traceutil/trace.go:171","msg":"trace[1522711288] linearizableReadLoop","detail":"{readStateIndex:793; appliedIndex:792; }","duration":"112.527905ms","start":"2026-02-05T05:22:34.390062Z","end":"2026-02-05T05:22:34.50259Z","steps":["trace[1522711288] 'read index received' (duration: 112.37784ms)","trace[1522711288] 'applied index is now lower than readState.Index' (duration: 149.345µs)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:22:34.503314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.25872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-05T05:22:34.503344Z","caller":"traceutil/trace.go:171","msg":"trace[1492919125] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:768; }","duration":"113.291221ms","start":"2026-02-05T05:22:34.390037Z","end":"2026-02-05T05:22:34.503328Z","steps":["trace[1492919125] 'agreement among raft nodes before linearized reading' (duration: 112.94933ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:22:40.832099Z","caller":"traceutil/trace.go:171","msg":"trace[771073607] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"110.742084ms","start":"2026-02-05T05:22:40.721337Z","end":"2026-02-05T05:22:40.832079Z","steps":["trace[771073607] 'process raft request' (duration: 101.921286ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:23:06.94902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.568412ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-05T05:23:06.949349Z","caller":"traceutil/trace.go:171","msg":"trace[256054666] transaction","detail":"{read_only:false; response_revision:864; number_of_response:1; }","duration":"161.994593ms","start":"2026-02-05T05:23:06.787343Z","end":"2026-02-05T05:23:06.949337Z","steps":["trace[256054666] 'process raft request' (duration: 49.048891ms)","trace[256054666] 'compare' (duration: 112.430448ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:23:07.343589Z","caller":"traceutil/trace.go:171","msg":"trace[360563588] transaction","detail":"{read_only:false; response_revision:867; number_of_response:1; }","duration":"134.436736ms","start":"2026-02-05T05:23:07.209135Z","end":"2026-02-05T05:23:07.343572Z","steps":["trace[360563588] 'process raft request' (duration: 133.989194ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:23:13.140723Z","caller":"traceutil/trace.go:171","msg":"trace[2006304180] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"113.292751ms","start":"2026-02-05T05:23:13.027396Z","end":"2026-02-05T05:23:13.140689Z","steps":["trace[2006304180] 'process raft request' (duration: 104.653997ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:23:32.027955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.03985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-05T05:23:32.028077Z","caller":"traceutil/trace.go:171","msg":"trace[255531720] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:967; }","duration":"156.176083ms","start":"2026-02-05T05:23:31.871885Z","end":"2026-02-05T05:23:32.028061Z","steps":["trace[255531720] 'range keys from in-memory index tree' (duration: 155.830415ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:23:39.678093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.092902ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-05T05:23:39.678386Z","caller":"traceutil/trace.go:171","msg":"trace[1918130868] linearizableReadLoop","detail":"{readStateIndex:1031; appliedIndex:1030; }","duration":"395.558003ms","start":"2026-02-05T05:23:39.28265Z","end":"2026-02-05T05:23:39.678208Z","steps":["trace[1918130868] 'read index received' (duration: 51.212365ms)","trace[1918130868] 'applied index is now lower than readState.Index' (duration: 344.343878ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:23:39.678846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.199037ms","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-02-05T05:23:39.678893Z","caller":"traceutil/trace.go:171","msg":"trace[1038123802] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:992; }","duration":"396.289738ms","start":"2026-02-05T05:23:39.28259Z","end":"2026-02-05T05:23:39.67888Z","steps":["trace[1038123802] 'agreement among raft nodes before linearized reading' (duration: 395.845188ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:23:39.678975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:23:39.282567Z","time spent":"396.39695ms","remote":"127.0.0.1:38484","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-05T05:23:39.679299Z","caller":"traceutil/trace.go:171","msg":"trace[1028753890] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"461.605159ms","start":"2026-02-05T05:23:39.217678Z","end":"2026-02-05T05:23:39.679283Z","steps":["trace[1028753890] 'process raft request' (duration: 116.192439ms)","trace[1028753890] 'compare' (duration: 343.415448ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:23:39.679481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:23:39.217658Z","time spent":"461.68129ms","remote":"127.0.0.1:38484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T05:23:40.174148Z","caller":"traceutil/trace.go:171","msg":"trace[409178654] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"101.365086ms","start":"2026-02-05T05:23:40.072753Z","end":"2026-02-05T05:23:40.174118Z","steps":["trace[409178654] 'process raft request' (duration: 101.214163ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:23:41.299522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.788562ms","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-05T05:23:41.300293Z","caller":"traceutil/trace.go:171","msg":"trace[346729585] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:997; }","duration":"346.607249ms","start":"2026-02-05T05:23:40.953667Z","end":"2026-02-05T05:23:41.300274Z","steps":["trace[346729585] 'range keys from in-memory index tree' (duration: 345.65162ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:23:41.300516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:23:40.953648Z","time spent":"346.851535ms","remote":"127.0.0.1:38484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-05T05:23:41.301005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.117494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:23:41.301243Z","caller":"traceutil/trace.go:171","msg":"trace[1279472007] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:997; }","duration":"306.311059ms","start":"2026-02-05T05:23:40.994858Z","end":"2026-02-05T05:23:41.301169Z","steps":["trace[1279472007] 'range keys from in-memory index tree' (duration: 306.021632ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:23:41.301391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:23:40.994846Z","time spent":"306.531053ms","remote":"127.0.0.1:38232","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-02-05T05:23:41.823482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.802306ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-05T05:23:41.823568Z","caller":"traceutil/trace.go:171","msg":"trace[1982221144] linearizableReadLoop","detail":"{readStateIndex:1039; appliedIndex:1038; }","duration":"139.108487ms","start":"2026-02-05T05:23:41.684446Z","end":"2026-02-05T05:23:41.823554Z","steps":["trace[1982221144] 'read index received' (duration: 32.501µs)","trace[1982221144] 'applied index is now lower than readState.Index' (duration: 139.074856ms)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:23:41.824543Z","caller":"traceutil/trace.go:171","msg":"trace[2068039029] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"516.122162ms","start":"2026-02-05T05:23:41.308404Z","end":"2026-02-05T05:23:41.824526Z","steps":["trace[2068039029] 'process raft request' (duration: 105.205154ms)","trace[2068039029] 'compare' (duration: 409.708943ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:23:41.824998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:23:41.308388Z","time spent":"516.259374ms","remote":"127.0.0.1:38484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-05T05:23:41.825826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.371804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-05T05:23:41.825872Z","caller":"traceutil/trace.go:171","msg":"trace[1770993827] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:999; }","duration":"141.455796ms","start":"2026-02-05T05:23:41.684404Z","end":"2026-02-05T05:23:41.82586Z","steps":["trace[1770993827] 'agreement among raft nodes before linearized reading' (duration: 141.326393ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:23:42.502284Z","caller":"traceutil/trace.go:171","msg":"trace[329194056] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"318.096156ms","start":"2026-02-05T05:23:42.184158Z","end":"2026-02-05T05:23:42.502254Z","steps":["trace[329194056] 'process raft request' (duration: 317.948233ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:23:42.503428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T05:23:42.184142Z","time spent":"318.346661ms","remote":"127.0.0.1:38484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-05T05:23:54.107437Z","caller":"traceutil/trace.go:171","msg":"trace[1017155157] linearizableReadLoop","detail":"{readStateIndex:1081; appliedIndex:1080; }","duration":"169.800901ms","start":"2026-02-05T05:23:53.937614Z","end":"2026-02-05T05:23:54.107415Z","steps":["trace[1017155157] 'read index received' (duration: 127.861117ms)","trace[1017155157] 'applied index is now lower than readState.Index' (duration: 41.938644ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:23:54.107905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.260609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:kube-aggregator\" ","response":"range_response_count:1 size:597"} {"level":"info","ts":"2026-02-05T05:23:54.107987Z","caller":"traceutil/trace.go:171","msg":"trace[1617298604] range","detail":"{range_begin:/registry/clusterroles/system:kube-aggregator; range_end:; response_count:1; response_revision:1039; }","duration":"170.425663ms","start":"2026-02-05T05:23:53.937541Z","end":"2026-02-05T05:23:54.107967Z","steps":["trace[1617298604] 'agreement among raft nodes before linearized reading' (duration: 170.169078ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:23:54.108098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.490059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:generic-garbage-collector\" ","response":"range_response_count:1 size:775"} {"level":"info","ts":"2026-02-05T05:23:54.108632Z","caller":"traceutil/trace.go:171","msg":"trace[726418382] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:generic-garbage-collector; range_end:; response_count:1; response_revision:1039; }","duration":"121.171073ms","start":"2026-02-05T05:23:53.987441Z","end":"2026-02-05T05:23:54.108612Z","steps":["trace[726418382] 'agreement among raft nodes before linearized reading' (duration: 120.474579ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:23:54.108912Z","caller":"traceutil/trace.go:171","msg":"trace[774305267] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"186.876343ms","start":"2026-02-05T05:23:53.922015Z","end":"2026-02-05T05:23:54.108891Z","steps":["trace[774305267] 'process raft request' (duration: 143.541472ms)","trace[774305267] 'compare' (duration: 41.766531ms)"],"step_count":2} {"level":"warn","ts":"2026-02-05T05:23:54.109813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.060601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:23:54.109858Z","caller":"traceutil/trace.go:171","msg":"trace[491954885] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1039; }","duration":"119.115792ms","start":"2026-02-05T05:23:53.990731Z","end":"2026-02-05T05:23:54.109847Z","steps":["trace[491954885] 'agreement among raft nodes before linearized reading' (duration: 119.0479ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:23:54.854654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.89645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:775"} {"level":"info","ts":"2026-02-05T05:23:54.854732Z","caller":"traceutil/trace.go:171","msg":"trace[1834956662] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:1040; }","duration":"182.006402ms","start":"2026-02-05T05:23:54.672704Z","end":"2026-02-05T05:23:54.854711Z","steps":["trace[1834956662] 'range keys from in-memory index tree' (duration: 181.806158ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:23:54.854948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.155729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:monitoring\" ","response":"range_response_count:1 size:634"} {"level":"info","ts":"2026-02-05T05:23:54.854979Z","caller":"traceutil/trace.go:171","msg":"trace[605319238] range","detail":"{range_begin:/registry/clusterroles/system:monitoring; range_end:; response_count:1; response_revision:1040; }","duration":"158.20919ms","start":"2026-02-05T05:23:54.696761Z","end":"2026-02-05T05:23:54.85497Z","steps":["trace[605319238] 'range keys from in-memory index tree' (duration: 158.104598ms)"],"step_count":1} {"level":"info","ts":"2026-02-05T05:24:04.925518Z","caller":"traceutil/trace.go:171","msg":"trace[1362803135] linearizableReadLoop","detail":"{readStateIndex:1112; appliedIndex:1111; }","duration":"204.960429ms","start":"2026-02-05T05:24:04.720539Z","end":"2026-02-05T05:24:04.9255Z","steps":["trace[1362803135] 'read index received' (duration: 204.755315ms)","trace[1362803135] 'applied index is now lower than readState.Index' (duration: 204.494µs)"],"step_count":2} {"level":"info","ts":"2026-02-05T05:24:04.925741Z","caller":"traceutil/trace.go:171","msg":"trace[2125707584] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"230.434362ms","start":"2026-02-05T05:24:04.695297Z","end":"2026-02-05T05:24:04.925732Z","steps":["trace[2125707584] 'process raft request' (duration: 230.067425ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:24:04.92589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.335276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5098"} {"level":"info","ts":"2026-02-05T05:24:04.925912Z","caller":"traceutil/trace.go:171","msg":"trace[1145704851] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:1068; }","duration":"205.387477ms","start":"2026-02-05T05:24:04.720517Z","end":"2026-02-05T05:24:04.925905Z","steps":["trace[1145704851] 'agreement among raft nodes before linearized reading' (duration: 205.334036ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:24:04.925982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.095389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/local-path-storage/\" range_end:\"/registry/daemonsets/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:24:04.926056Z","caller":"traceutil/trace.go:171","msg":"trace[443873965] range","detail":"{range_begin:/registry/daemonsets/local-path-storage/; range_end:/registry/daemonsets/local-path-storage0; response_count:0; response_revision:1068; }","duration":"159.208211ms","start":"2026-02-05T05:24:04.766832Z","end":"2026-02-05T05:24:04.92604Z","steps":["trace[443873965] 'agreement among raft nodes before linearized reading' (duration: 159.065359ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:24:04.926223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.417985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-xrff7\" ","response":"range_response_count:1 size:4848"} {"level":"info","ts":"2026-02-05T05:24:04.926245Z","caller":"traceutil/trace.go:171","msg":"trace[178942770] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-xrff7; range_end:; response_count:1; response_revision:1068; }","duration":"125.481506ms","start":"2026-02-05T05:24:04.800757Z","end":"2026-02-05T05:24:04.926239Z","steps":["trace[178942770] 'agreement among raft nodes before linearized reading' (duration: 125.389144ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:24:04.92627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.304801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/local-path-storage/\" range_end:\"/registry/cronjobs/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:24:04.926294Z","caller":"traceutil/trace.go:171","msg":"trace[1699085581] range","detail":"{range_begin:/registry/cronjobs/local-path-storage/; range_end:/registry/cronjobs/local-path-storage0; response_count:0; response_revision:1068; }","duration":"126.363562ms","start":"2026-02-05T05:24:04.799924Z","end":"2026-02-05T05:24:04.926287Z","steps":["trace[1699085581] 'agreement among raft nodes before linearized reading' (duration: 126.312551ms)"],"step_count":1} {"level":"warn","ts":"2026-02-05T05:24:05.098421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.220869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-05T05:24:05.098471Z","caller":"traceutil/trace.go:171","msg":"trace[1188061000] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1068; }","duration":"107.297621ms","start":"2026-02-05T05:24:04.991162Z","end":"2026-02-05T05:24:05.09846Z","steps":["trace[1188061000] 'range keys from in-memory index tree' (duration: 107.175359ms)"],"step_count":1}