{"level":"warn","ts":"2026-02-11T01:44:51.12883Z","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-11T01:44:51.12894Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38: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-11T01:44:51.128998Z","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-11T01:44:51.129006Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-02-11T01:44:51.129024Z","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-11T01:44:51.129569Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]} {"level":"info","ts":"2026-02-11T01:44:51.129633Z","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://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38: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-11T01:44:51.133226Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.419169ms"} {"level":"info","ts":"2026-02-11T01:44:51.140948Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"} {"level":"info","ts":"2026-02-11T01:44:51.141007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"} {"level":"info","ts":"2026-02-11T01:44:51.141028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"} {"level":"info","ts":"2026-02-11T01:44:51.141099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-11T01:44:51.141143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"} {"level":"info","ts":"2026-02-11T01:44:51.141224Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"warn","ts":"2026-02-11T01:44:51.148414Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-11T01:44:51.14947Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-11T01:44:51.151215Z","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-11T01:44:51.153694Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-11T01:44:51.157108Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-11T01:44:51.160108Z","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-11T01:44:51.160146Z","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-11T01:44:51.160154Z","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-11T01:44:51.160396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"info","ts":"2026-02-11T01:44:51.162618Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-02-11T01:44:51.172242Z","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-11T01:44:51.173613Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-02-11T01:44:51.173628Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-02-11T01:44:51.17422Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-11T01:44:51.174243Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-11T01:44:51.642275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"} {"level":"info","ts":"2026-02-11T01:44:51.642367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-11T01:44:51.642398Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"} {"level":"info","ts":"2026-02-11T01:44:51.64244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"} {"level":"info","ts":"2026-02-11T01:44:51.642466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-02-11T01:44:51.642488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"} {"level":"info","ts":"2026-02-11T01:44:51.642508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-02-11T01:44:51.645612Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"} {"level":"info","ts":"2026-02-11T01:44:51.64567Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-11T01:44:51.646012Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T01:44:51.646356Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-11T01:44:51.653146Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-11T01:44:51.653235Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-11T01:44:51.653247Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-11T01:44:51.665815Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"info","ts":"2026-02-11T01:44:51.689466Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T01:44:51.689676Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-11T01:44:51.69156Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-02-11T01:44:57.506266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.705968ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-11T01:44:57.506477Z","caller":"traceutil/trace.go:171","msg":"trace[1035848559] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"237.023093ms","start":"2026-02-11T01:44:57.269431Z","end":"2026-02-11T01:44:57.506454Z","steps":["trace[1035848559] 'process raft request' (duration: 53.285626ms)","trace[1035848559] 'compare' (duration: 182.013823ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:44:57.506503Z","caller":"traceutil/trace.go:171","msg":"trace[1467647504] linearizableReadLoop","detail":"{readStateIndex:295; appliedIndex:293; }","duration":"223.268953ms","start":"2026-02-11T01:44:57.283218Z","end":"2026-02-11T01:44:57.506487Z","steps":["trace[1467647504] 'read index received' (duration: 39.505456ms)","trace[1467647504] 'applied index is now lower than readState.Index' (duration: 183.762707ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:44:57.507102Z","caller":"traceutil/trace.go:171","msg":"trace[195472194] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"233.612206ms","start":"2026-02-11T01:44:57.273112Z","end":"2026-02-11T01:44:57.506725Z","steps":["trace[195472194] 'process raft request' (duration: 233.287543ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:44:57.508678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.44706ms","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-11T01:44:57.508918Z","caller":"traceutil/trace.go:171","msg":"trace[74482185] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:288; }","duration":"225.722122ms","start":"2026-02-11T01:44:57.283181Z","end":"2026-02-11T01:44:57.508903Z","steps":["trace[74482185] 'agreement among raft nodes before linearized reading' (duration: 223.374824ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:44:57.623702Z","caller":"traceutil/trace.go:171","msg":"trace[882579543] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"110.777215ms","start":"2026-02-11T01:44:57.512912Z","end":"2026-02-11T01:44:57.623689Z","steps":["trace[882579543] 'process raft request' (duration: 109.564145ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:44:57.625106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.972704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-11T01:44:57.625361Z","caller":"traceutil/trace.go:171","msg":"trace[1889624301] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:289; }","duration":"112.225016ms","start":"2026-02-11T01:44:57.513098Z","end":"2026-02-11T01:44:57.625323Z","steps":["trace[1889624301] 'agreement among raft nodes before linearized reading' (duration: 111.910563ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:44:57.623616Z","caller":"traceutil/trace.go:171","msg":"trace[758697474] linearizableReadLoop","detail":"{readStateIndex:296; appliedIndex:295; }","duration":"110.474582ms","start":"2026-02-11T01:44:57.513121Z","end":"2026-02-11T01:44:57.623596Z","steps":["trace[758697474] 'read index received' (duration: 109.303842ms)","trace[758697474] 'applied index is now lower than readState.Index' (duration: 1.16896ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:44:57.629534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.354251ms","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-11T01:44:57.644635Z","caller":"traceutil/trace.go:171","msg":"trace[1243022285] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:289; }","duration":"130.495152ms","start":"2026-02-11T01:44:57.514122Z","end":"2026-02-11T01:44:57.644617Z","steps":["trace[1243022285] 'agreement among raft nodes before linearized reading' (duration: 115.25854ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:45:00.665187Z","caller":"traceutil/trace.go:171","msg":"trace[1324238081] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"220.318198ms","start":"2026-02-11T01:45:00.444845Z","end":"2026-02-11T01:45:00.665163Z","steps":["trace[1324238081] 'process raft request' (duration: 220.188787ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:02.786876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.453567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-11T01:45:02.786969Z","caller":"traceutil/trace.go:171","msg":"trace[1468125743] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:380; }","duration":"107.606909ms","start":"2026-02-11T01:45:02.679347Z","end":"2026-02-11T01:45:02.786954Z","steps":["trace[1468125743] 'range keys from in-memory index tree' (duration: 107.341657ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:45:03.417169Z","caller":"traceutil/trace.go:171","msg":"trace[1953608055] linearizableReadLoop","detail":"{readStateIndex:388; appliedIndex:387; }","duration":"135.104368ms","start":"2026-02-11T01:45:03.282046Z","end":"2026-02-11T01:45:03.41715Z","steps":["trace[1953608055] 'read index received' (duration: 134.944617ms)","trace[1953608055] 'applied index is now lower than readState.Index' (duration: 159.141µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:45:03.417282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.217399ms","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-11T01:45:03.417302Z","caller":"traceutil/trace.go:171","msg":"trace[297435669] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:381; }","duration":"135.283111ms","start":"2026-02-11T01:45:03.282013Z","end":"2026-02-11T01:45:03.417296Z","steps":["trace[297435669] 'agreement among raft nodes before linearized reading' (duration: 135.20354ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:45:03.417516Z","caller":"traceutil/trace.go:171","msg":"trace[846864825] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"622.96732ms","start":"2026-02-11T01:45:02.794543Z","end":"2026-02-11T01:45:03.41751Z","steps":["trace[846864825] 'process raft request' (duration: 622.510787ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:03.417562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:02.794522Z","time spent":"623.00853ms","remote":"127.0.0.1:41816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3505,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-11T01:45:04.49519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.762953ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-11T01:45:04.495486Z","caller":"traceutil/trace.go:171","msg":"trace[2111704321] linearizableReadLoop","detail":"{readStateIndex:393; appliedIndex:388; }","duration":"927.347848ms","start":"2026-02-11T01:45:03.568123Z","end":"2026-02-11T01:45:04.495471Z","steps":["trace[2111704321] 'read index received' (duration: 219.209302ms)","trace[2111704321] 'applied index is now lower than readState.Index' (duration: 708.137746ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:45:04.495551Z","caller":"traceutil/trace.go:171","msg":"trace[738250563] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"1.069249469s","start":"2026-02-11T01:45:03.426292Z","end":"2026-02-11T01:45:04.495542Z","steps":["trace[738250563] 'process raft request' (duration: 361.078553ms)","trace[738250563] 'compare' (duration: 707.35498ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:45:04.4956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:03.426276Z","time spent":"1.069298229s","remote":"127.0.0.1:41718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T01:45:04.495884Z","caller":"traceutil/trace.go:171","msg":"trace[105607042] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"1.06942487s","start":"2026-02-11T01:45:03.42645Z","end":"2026-02-11T01:45:04.495875Z","steps":["trace[105607042] 'process raft request' (duration: 1.068835696s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:04.495929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:03.426445Z","time spent":"1.06946359s","remote":"127.0.0.1:41816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3505,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T01:45:04.496057Z","caller":"traceutil/trace.go:171","msg":"trace[326249230] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"1.065990484s","start":"2026-02-11T01:45:03.430057Z","end":"2026-02-11T01:45:04.496048Z","steps":["trace[326249230] 'process raft request' (duration: 1.065301338s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:04.496099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:03.430052Z","time spent":"1.066026955s","remote":"127.0.0.1:41718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T01:45:04.496202Z","caller":"traceutil/trace.go:171","msg":"trace[364872541] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"1.066094045s","start":"2026-02-11T01:45:03.430101Z","end":"2026-02-11T01:45:04.496195Z","steps":["trace[364872541] 'process raft request' (duration: 1.065286209s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:04.49643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:03.430097Z","time spent":"1.066127735s","remote":"127.0.0.1:41816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3979,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:45:04.497848Z","caller":"traceutil/trace.go:171","msg":"trace[1007067370] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"1.067704787s","start":"2026-02-11T01:45:03.430128Z","end":"2026-02-11T01:45:04.497833Z","steps":["trace[1007067370] 'process raft request' (duration: 1.065301879s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:04.49792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:03.430124Z","time spent":"1.067760067s","remote":"127.0.0.1:41884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:45:04.49805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"929.924858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:45:04.498078Z","caller":"traceutil/trace.go:171","msg":"trace[689881817] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:386; }","duration":"929.951749ms","start":"2026-02-11T01:45:03.568117Z","end":"2026-02-11T01:45:04.498069Z","steps":["trace[689881817] 'agreement among raft nodes before linearized reading' (duration: 929.906558ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:04.498115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:03.568041Z","time spent":"930.069209ms","remote":"127.0.0.1:41656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-11T01:45:04.542533Z","caller":"traceutil/trace.go:171","msg":"trace[279609406] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"712.798378ms","start":"2026-02-11T01:45:03.829713Z","end":"2026-02-11T01:45:04.542511Z","steps":["trace[279609406] 'process raft request' (duration: 712.671387ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:04.542884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.165927ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:45:04.544345Z","caller":"traceutil/trace.go:171","msg":"trace[1060984286] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:387; }","duration":"434.636678ms","start":"2026-02-11T01:45:04.109692Z","end":"2026-02-11T01:45:04.544329Z","steps":["trace[1060984286] 'agreement among raft nodes before linearized reading' (duration: 433.125667ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:04.542996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.014347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6894"} {"level":"info","ts":"2026-02-11T01:45:04.544782Z","caller":"traceutil/trace.go:171","msg":"trace[1911206533] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:387; }","duration":"477.79706ms","start":"2026-02-11T01:45:04.066945Z","end":"2026-02-11T01:45:04.544742Z","steps":["trace[1911206533] 'agreement among raft nodes before linearized reading' (duration: 476.003507ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:04.544923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:04.066931Z","time spent":"477.973342ms","remote":"127.0.0.1:41816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6916,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"warn","ts":"2026-02-11T01:45:04.543003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"849.229466ms","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-11T01:45:04.546107Z","caller":"traceutil/trace.go:171","msg":"trace[1737150158] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:387; }","duration":"852.364319ms","start":"2026-02-11T01:45:03.693729Z","end":"2026-02-11T01:45:04.546093Z","steps":["trace[1737150158] 'agreement among raft nodes before linearized reading' (duration: 849.251086ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:04.546305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:03.693709Z","time spent":"852.580522ms","remote":"127.0.0.1:41884","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-11T01:45:04.543026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.618195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-11T01:45:04.546837Z","caller":"traceutil/trace.go:171","msg":"trace[395762083] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:387; }","duration":"587.455743ms","start":"2026-02-11T01:45:03.959374Z","end":"2026-02-11T01:45:04.54683Z","steps":["trace[395762083] 'agreement among raft nodes before linearized reading' (duration: 583.640715ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:04.546861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:03.959356Z","time spent":"587.498933ms","remote":"127.0.0.1:41884","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-11T01:45:04.543033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"857.018046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-11T01:45:04.546918Z","caller":"traceutil/trace.go:171","msg":"trace[1736149723] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:387; }","duration":"860.930575ms","start":"2026-02-11T01:45:03.685983Z","end":"2026-02-11T01:45:04.546914Z","steps":["trace[1736149723] 'agreement among raft nodes before linearized reading' (duration: 857.029446ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:04.546933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:03.685967Z","time spent":"860.961585ms","remote":"127.0.0.1:41884","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-11T01:45:04.546847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:03.829696Z","time spent":"713.423342ms","remote":"127.0.0.1:41884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:45:05.034295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.179832ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T01:45:05.034556Z","caller":"traceutil/trace.go:171","msg":"trace[1361867039] linearizableReadLoop","detail":"{readStateIndex:398; appliedIndex:394; }","duration":"491.765113ms","start":"2026-02-11T01:45:04.542776Z","end":"2026-02-11T01:45:05.034541Z","steps":["trace[1361867039] 'read index received' (duration: 282.276779ms)","trace[1361867039] 'applied index is now lower than readState.Index' (duration: 209.487414ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:45:05.034817Z","caller":"traceutil/trace.go:171","msg":"trace[127681998] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"527.614411ms","start":"2026-02-11T01:45:04.50719Z","end":"2026-02-11T01:45:05.034805Z","steps":["trace[127681998] 'process raft request' (duration: 317.853275ms)","trace[127681998] 'compare' (duration: 209.080441ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:45:05.034883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:04.507177Z","time spent":"527.672561ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3737,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:45:05.035076Z","caller":"traceutil/trace.go:171","msg":"trace[1310863408] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"527.836383ms","start":"2026-02-11T01:45:04.50723Z","end":"2026-02-11T01:45:05.035066Z","steps":["trace[1310863408] 'process raft request' (duration: 527.161678ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:05.035137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:04.50722Z","time spent":"527.884233ms","remote":"127.0.0.1:41718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-11T01:45:05.035337Z","caller":"traceutil/trace.go:171","msg":"trace[1092351940] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"528.046664ms","start":"2026-02-11T01:45:04.507281Z","end":"2026-02-11T01:45:05.035328Z","steps":["trace[1092351940] 'process raft request' (duration: 527.181218ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:05.035393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:04.507277Z","time spent":"528.089884ms","remote":"127.0.0.1:41816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3979,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:45:05.035502Z","caller":"traceutil/trace.go:171","msg":"trace[1890796024] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"528.184675ms","start":"2026-02-11T01:45:04.507307Z","end":"2026-02-11T01:45:05.035492Z","steps":["trace[1890796024] 'process raft request' (duration: 527.191618ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:05.035548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:04.507302Z","time spent":"528.226855ms","remote":"127.0.0.1:41718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-11T01:45:05.035775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.089774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:45:05.03582Z","caller":"traceutil/trace.go:171","msg":"trace[1896721727] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:391; }","duration":"532.158714ms","start":"2026-02-11T01:45:04.503649Z","end":"2026-02-11T01:45:05.035808Z","steps":["trace[1896721727] 'agreement among raft nodes before linearized reading' (duration: 532.086694ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:05.035858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:04.503635Z","time spent":"532.215935ms","remote":"127.0.0.1:41666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-11T01:45:05.044385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.86246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.38\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-11T01:45:05.044433Z","caller":"traceutil/trace.go:171","msg":"trace[804047228] range","detail":"{range_begin:/registry/masterleases/199.204.45.38; range_end:; response_count:1; response_revision:395; }","duration":"160.944461ms","start":"2026-02-11T01:45:04.883478Z","end":"2026-02-11T01:45:05.044423Z","steps":["trace[804047228] 'agreement among raft nodes before linearized reading' (duration: 160.85832ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:45:05.046191Z","caller":"traceutil/trace.go:171","msg":"trace[1819809757] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"491.643682ms","start":"2026-02-11T01:45:04.554537Z","end":"2026-02-11T01:45:05.04618Z","steps":["trace[1819809757] 'process raft request' (duration: 489.638497ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:05.046385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:04.554521Z","time spent":"491.694422ms","remote":"127.0.0.1:41816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6879,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:45:05.047107Z","caller":"traceutil/trace.go:171","msg":"trace[441295454] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"490.578554ms","start":"2026-02-11T01:45:04.556049Z","end":"2026-02-11T01:45:05.046627Z","steps":["trace[441295454] 'process raft request' (duration: 488.219386ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:45:05.047349Z","caller":"traceutil/trace.go:171","msg":"trace[252076760] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"489.726998ms","start":"2026-02-11T01:45:04.55761Z","end":"2026-02-11T01:45:05.047337Z","steps":["trace[252076760] 'process raft request' (duration: 486.684546ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:05.047785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:04.556041Z","time spent":"491.206778ms","remote":"127.0.0.1:41884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:45:05.048573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:04.5576Z","time spent":"490.950617ms","remote":"127.0.0.1:41884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:45:05.049033Z","caller":"traceutil/trace.go:171","msg":"trace[630283801] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"490.015709ms","start":"2026-02-11T01:45:04.558956Z","end":"2026-02-11T01:45:05.048972Z","steps":["trace[630283801] 'process raft request' (duration: 485.358195ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:05.049405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:04.558947Z","time spent":"490.431762ms","remote":"127.0.0.1:41884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:45:05.554605Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757018357398947950,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-11T01:45:05.758198Z","caller":"traceutil/trace.go:171","msg":"trace[1435751668] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"707.025629ms","start":"2026-02-11T01:45:05.051152Z","end":"2026-02-11T01:45:05.758178Z","steps":["trace[1435751668] 'process raft request' (duration: 686.412316ms)","trace[1435751668] 'compare' (duration: 20.522542ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:45:05.758308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:05.051142Z","time spent":"707.108089ms","remote":"127.0.0.1:42108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3782,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:45:05.765593Z","caller":"traceutil/trace.go:171","msg":"trace[496777452] linearizableReadLoop","detail":"{readStateIndex:404; appliedIndex:402; }","duration":"711.19468ms","start":"2026-02-11T01:45:05.054384Z","end":"2026-02-11T01:45:05.765579Z","steps":["trace[496777452] 'read index received' (duration: 683.189222ms)","trace[496777452] 'applied index is now lower than readState.Index' (duration: 28.003908ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:45:05.765662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:05.0541Z","time spent":"711.559332ms","remote":"127.0.0.1:41684","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-11T01:45:05.765822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.427211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6894"} {"level":"info","ts":"2026-02-11T01:45:05.76584Z","caller":"traceutil/trace.go:171","msg":"trace[298809739] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:396; }","duration":"711.470291ms","start":"2026-02-11T01:45:05.054365Z","end":"2026-02-11T01:45:05.765835Z","steps":["trace[298809739] 'agreement among raft nodes before linearized reading' (duration: 711.417711ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:05.765855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:05.054357Z","time spent":"711.495372ms","remote":"127.0.0.1:41816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6916,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"warn","ts":"2026-02-11T01:45:05.765931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.008002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:45:05.765943Z","caller":"traceutil/trace.go:171","msg":"trace[1992794336] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:396; }","duration":"196.060802ms","start":"2026-02-11T01:45:05.569878Z","end":"2026-02-11T01:45:05.765939Z","steps":["trace[1992794336] 'agreement among raft nodes before linearized reading' (duration: 196.040762ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:45:06.205187Z","caller":"traceutil/trace.go:171","msg":"trace[195863852] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"437.220556ms","start":"2026-02-11T01:45:05.767942Z","end":"2026-02-11T01:45:06.205162Z","steps":["trace[195863852] 'process raft request' (duration: 420.359012ms)","trace[195863852] 'compare' (duration: 16.742584ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:45:06.205347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:05.767928Z","time spent":"437.346877ms","remote":"127.0.0.1:41684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:45:06.238119Z","caller":"traceutil/trace.go:171","msg":"trace[2146057103] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"465.172901ms","start":"2026-02-11T01:45:05.772931Z","end":"2026-02-11T01:45:06.238104Z","steps":["trace[2146057103] 'process raft request' (duration: 464.787039ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:06.23821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:05.772918Z","time spent":"465.238942ms","remote":"127.0.0.1:42090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4019,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:45:06.238327Z","caller":"traceutil/trace.go:171","msg":"trace[310167144] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"465.177982ms","start":"2026-02-11T01:45:05.773144Z","end":"2026-02-11T01:45:06.238322Z","steps":["trace[310167144] 'process raft request' (duration: 464.654868ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:06.238352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:05.773135Z","time spent":"465.203402ms","remote":"127.0.0.1:41816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6669,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:45:10.887334Z","caller":"traceutil/trace.go:171","msg":"trace[1148828214] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"194.823516ms","start":"2026-02-11T01:45:10.692202Z","end":"2026-02-11T01:45:10.887026Z","steps":["trace[1148828214] 'process raft request' (duration: 129.060808ms)","trace[1148828214] 'compare' (duration: 65.632338ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:45:10.891997Z","caller":"traceutil/trace.go:171","msg":"trace[1970792454] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"196.323277ms","start":"2026-02-11T01:45:10.69565Z","end":"2026-02-11T01:45:10.891974Z","steps":["trace[1970792454] 'process raft request' (duration: 195.686303ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:45:10.892372Z","caller":"traceutil/trace.go:171","msg":"trace[1982135488] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"196.672679ms","start":"2026-02-11T01:45:10.695693Z","end":"2026-02-11T01:45:10.892366Z","steps":["trace[1982135488] 'process raft request' (duration: 195.865123ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:45:10.892578Z","caller":"traceutil/trace.go:171","msg":"trace[1128028172] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"196.826441ms","start":"2026-02-11T01:45:10.695744Z","end":"2026-02-11T01:45:10.89257Z","steps":["trace[1128028172] 'process raft request' (duration: 195.997545ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:45:10.89644Z","caller":"traceutil/trace.go:171","msg":"trace[1200339123] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"199.982833ms","start":"2026-02-11T01:45:10.696439Z","end":"2026-02-11T01:45:10.896421Z","steps":["trace[1200339123] 'process raft request' (duration: 195.36965ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:45:23.357802Z","caller":"traceutil/trace.go:171","msg":"trace[1731557633] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"148.24712ms","start":"2026-02-11T01:45:23.209532Z","end":"2026-02-11T01:45:23.357779Z","steps":["trace[1731557633] 'process raft request' (duration: 147.832187ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:45:23.495557Z","caller":"traceutil/trace.go:171","msg":"trace[1403968050] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"131.011597ms","start":"2026-02-11T01:45:23.364525Z","end":"2026-02-11T01:45:23.495536Z","steps":["trace[1403968050] 'process raft request' (duration: 130.667974ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:45:23.497784Z","caller":"traceutil/trace.go:171","msg":"trace[1162918896] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"130.589464ms","start":"2026-02-11T01:45:23.367183Z","end":"2026-02-11T01:45:23.497773Z","steps":["trace[1162918896] 'process raft request' (duration: 130.339113ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:45:26.92119Z","caller":"traceutil/trace.go:171","msg":"trace[1115181953] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"252.539806ms","start":"2026-02-11T01:45:26.668632Z","end":"2026-02-11T01:45:26.921172Z","steps":["trace[1115181953] 'process raft request' (duration: 252.430675ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:45:27.284739Z","caller":"traceutil/trace.go:171","msg":"trace[1364905980] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"208.734958ms","start":"2026-02-11T01:45:27.075977Z","end":"2026-02-11T01:45:27.284712Z","steps":["trace[1364905980] 'process raft request' (duration: 197.110683ms)","trace[1364905980] 'compare' (duration: 11.486064ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:45:31.182717Z","caller":"traceutil/trace.go:171","msg":"trace[363724861] linearizableReadLoop","detail":"{readStateIndex:570; appliedIndex:569; }","duration":"254.01607ms","start":"2026-02-11T01:45:30.928683Z","end":"2026-02-11T01:45:31.182699Z","steps":["trace[363724861] 'read index received' (duration: 253.772968ms)","trace[363724861] 'applied index is now lower than readState.Index' (duration: 242.422µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:45:31.182879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.170451ms","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-11T01:45:31.182904Z","caller":"traceutil/trace.go:171","msg":"trace[849200850] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:555; }","duration":"254.239672ms","start":"2026-02-11T01:45:30.928653Z","end":"2026-02-11T01:45:31.182893Z","steps":["trace[849200850] 'agreement among raft nodes before linearized reading' (duration: 254.115261ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:45:31.183107Z","caller":"traceutil/trace.go:171","msg":"trace[2066222501] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"491.59943ms","start":"2026-02-11T01:45:30.691502Z","end":"2026-02-11T01:45:31.183102Z","steps":["trace[2066222501] 'process raft request' (duration: 491.014397ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:31.183167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:30.691486Z","time spent":"491.63563ms","remote":"127.0.0.1:41816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:45:31.67199Z","caller":"traceutil/trace.go:171","msg":"trace[1701431399] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:570; }","duration":"284.950492ms","start":"2026-02-11T01:45:31.387015Z","end":"2026-02-11T01:45:31.671966Z","steps":["trace[1701431399] 'read index received' (duration: 227.565161ms)","trace[1701431399] 'applied index is now lower than readState.Index' (duration: 57.384161ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:45:31.672116Z","caller":"traceutil/trace.go:171","msg":"trace[876786977] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"476.114765ms","start":"2026-02-11T01:45:31.195989Z","end":"2026-02-11T01:45:31.672104Z","steps":["trace[876786977] 'process raft request' (duration: 418.647043ms)","trace[876786977] 'compare' (duration: 57.19621ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:45:31.672201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:31.195968Z","time spent":"476.173795ms","remote":"127.0.0.1:41884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:45:31.672296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.272024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-11T01:45:31.67233Z","caller":"traceutil/trace.go:171","msg":"trace[1302215315] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:556; }","duration":"285.343595ms","start":"2026-02-11T01:45:31.386975Z","end":"2026-02-11T01:45:31.672319Z","steps":["trace[1302215315] 'agreement among raft nodes before linearized reading' (duration: 285.157434ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:31.672458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.362588ms","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-11T01:45:31.672473Z","caller":"traceutil/trace.go:171","msg":"trace[1733315578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:556; }","duration":"152.377389ms","start":"2026-02-11T01:45:31.52009Z","end":"2026-02-11T01:45:31.672468Z","steps":["trace[1733315578] 'agreement among raft nodes before linearized reading' (duration: 152.336379ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:31.672523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.445779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:45:31.672534Z","caller":"traceutil/trace.go:171","msg":"trace[1764989123] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:556; }","duration":"106.489839ms","start":"2026-02-11T01:45:31.566041Z","end":"2026-02-11T01:45:31.672531Z","steps":["trace[1764989123] 'agreement among raft nodes before linearized reading' (duration: 106.473139ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:31.672606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.980567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-11T01:45:31.672619Z","caller":"traceutil/trace.go:171","msg":"trace[1184461401] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:556; }","duration":"149.014287ms","start":"2026-02-11T01:45:31.523601Z","end":"2026-02-11T01:45:31.672615Z","steps":["trace[1184461401] 'agreement among raft nodes before linearized reading' (duration: 148.991817ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:45:32.465782Z","caller":"traceutil/trace.go:171","msg":"trace[1553968139] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"787.968522ms","start":"2026-02-11T01:45:31.677796Z","end":"2026-02-11T01:45:32.465764Z","steps":["trace[1553968139] 'process raft request' (duration: 787.934832ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:32.465898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:31.67779Z","time spent":"788.047202ms","remote":"127.0.0.1:41884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:45:32.466136Z","caller":"traceutil/trace.go:171","msg":"trace[1303647639] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"789.075399ms","start":"2026-02-11T01:45:31.677052Z","end":"2026-02-11T01:45:32.466127Z","steps":["trace[1303647639] 'process raft request' (duration: 788.589166ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:32.466176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:31.677045Z","time spent":"789.107489ms","remote":"127.0.0.1:41884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-11T01:45:33.864162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.297325911s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:45:33.864223Z","caller":"traceutil/trace.go:171","msg":"trace[1006809856] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:559; }","duration":"1.297434312s","start":"2026-02-11T01:45:32.566774Z","end":"2026-02-11T01:45:33.864208Z","steps":["trace[1006809856] 'range keys from in-memory index tree' (duration: 1.297263891s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:33.864248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:45:32.566756Z","time spent":"1.297486892s","remote":"127.0.0.1:41656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-11T01:45:33.864945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.760488ms","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-11T01:45:33.864966Z","caller":"traceutil/trace.go:171","msg":"trace[1361478409] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:559; }","duration":"188.818358ms","start":"2026-02-11T01:45:33.676141Z","end":"2026-02-11T01:45:33.86496Z","steps":["trace[1361478409] 'range keys from in-memory index tree' (duration: 188.622586ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:33.865061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.156593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-11T01:45:33.865077Z","caller":"traceutil/trace.go:171","msg":"trace[1450939221] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:559; }","duration":"172.196573ms","start":"2026-02-11T01:45:33.692876Z","end":"2026-02-11T01:45:33.865072Z","steps":["trace[1450939221] 'range keys from in-memory index tree' (duration: 172.103713ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:45:34.911032Z","caller":"traceutil/trace.go:171","msg":"trace[1065686992] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:578; }","duration":"220.772151ms","start":"2026-02-11T01:45:34.690242Z","end":"2026-02-11T01:45:34.911015Z","steps":["trace[1065686992] 'read index received' (duration: 220.63432ms)","trace[1065686992] 'applied index is now lower than readState.Index' (duration: 136.691µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:45:34.911125Z","caller":"traceutil/trace.go:171","msg":"trace[1517607543] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"221.052793ms","start":"2026-02-11T01:45:34.690064Z","end":"2026-02-11T01:45:34.911117Z","steps":["trace[1517607543] 'process raft request' (duration: 220.833032ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:34.911455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.198844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-pkv9b\" ","response":"range_response_count:1 size:16814"} {"level":"info","ts":"2026-02-11T01:45:34.911487Z","caller":"traceutil/trace.go:171","msg":"trace[508158555] range","detail":"{range_begin:/registry/pods/kube-system/cilium-pkv9b; range_end:; response_count:1; response_revision:564; }","duration":"221.254034ms","start":"2026-02-11T01:45:34.690225Z","end":"2026-02-11T01:45:34.911479Z","steps":["trace[508158555] 'agreement among raft nodes before linearized reading' (duration: 221.115143ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:45:54.256876Z","caller":"traceutil/trace.go:171","msg":"trace[234063379] linearizableReadLoop","detail":"{readStateIndex:784; appliedIndex:783; }","duration":"230.17162ms","start":"2026-02-11T01:45:54.026658Z","end":"2026-02-11T01:45:54.256829Z","steps":["trace[234063379] 'read index received' (duration: 229.898298ms)","trace[234063379] 'applied index is now lower than readState.Index' (duration: 272.272µs)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:45:54.257312Z","caller":"traceutil/trace.go:171","msg":"trace[1254866838] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"233.69966ms","start":"2026-02-11T01:45:54.023592Z","end":"2026-02-11T01:45:54.257292Z","steps":["trace[1254866838] 'process raft request' (duration: 233.072701ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:54.257664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.988807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-11T01:45:54.257724Z","caller":"traceutil/trace.go:171","msg":"trace[453129025] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:764; }","duration":"231.068601ms","start":"2026-02-11T01:45:54.026643Z","end":"2026-02-11T01:45:54.257711Z","steps":["trace[453129025] 'agreement among raft nodes before linearized reading' (duration: 230.900283ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:45:54.257963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.963018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T01:45:54.257994Z","caller":"traceutil/trace.go:171","msg":"trace[759988292] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:764; }","duration":"224.01819ms","start":"2026-02-11T01:45:54.033967Z","end":"2026-02-11T01:45:54.257985Z","steps":["trace[759988292] 'agreement among raft nodes before linearized reading' (duration: 223.945427ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:46:44.196995Z","caller":"traceutil/trace.go:171","msg":"trace[1792423337] linearizableReadLoop","detail":"{readStateIndex:949; appliedIndex:948; }","duration":"145.14494ms","start":"2026-02-11T01:46:44.051828Z","end":"2026-02-11T01:46:44.196973Z","steps":["trace[1792423337] 'read index received' (duration: 71.197563ms)","trace[1792423337] 'applied index is now lower than readState.Index' (duration: 73.946457ms)"],"step_count":2} {"level":"info","ts":"2026-02-11T01:46:44.197108Z","caller":"traceutil/trace.go:171","msg":"trace[2069665477] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"162.865174ms","start":"2026-02-11T01:46:44.034214Z","end":"2026-02-11T01:46:44.197079Z","steps":["trace[2069665477] 'process raft request' (duration: 88.846175ms)","trace[2069665477] 'compare' (duration: 73.850745ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:46:44.197824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.080579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b256237e-356f-42f8-9916-8d06d4101cb0\" ","response":"range_response_count:1 size:2491"} {"level":"info","ts":"2026-02-11T01:46:44.197872Z","caller":"traceutil/trace.go:171","msg":"trace[93703973] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b256237e-356f-42f8-9916-8d06d4101cb0; range_end:; response_count:1; response_revision:917; }","duration":"127.14444ms","start":"2026-02-11T01:46:44.070716Z","end":"2026-02-11T01:46:44.19786Z","steps":["trace[93703973] 'agreement among raft nodes before linearized reading' (duration: 126.877963ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:46:44.197327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.48121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b256237e-356f-42f8-9916-8d06d4101cb0\" ","response":"range_response_count:1 size:2491"} {"level":"info","ts":"2026-02-11T01:46:44.198134Z","caller":"traceutil/trace.go:171","msg":"trace[1608797275] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b256237e-356f-42f8-9916-8d06d4101cb0; range_end:; response_count:1; response_revision:917; }","duration":"146.324832ms","start":"2026-02-11T01:46:44.051795Z","end":"2026-02-11T01:46:44.19812Z","steps":["trace[1608797275] 'agreement among raft nodes before linearized reading' (duration: 145.373866ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:46:58.834469Z","caller":"traceutil/trace.go:171","msg":"trace[740240627] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"166.354464ms","start":"2026-02-11T01:46:58.668099Z","end":"2026-02-11T01:46:58.834454Z","steps":["trace[740240627] 'process raft request' (duration: 166.240051ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:46:58.834842Z","caller":"traceutil/trace.go:171","msg":"trace[89652039] linearizableReadLoop","detail":"{readStateIndex:1021; appliedIndex:1021; }","duration":"165.883923ms","start":"2026-02-11T01:46:58.66895Z","end":"2026-02-11T01:46:58.834834Z","steps":["trace[89652039] 'read index received' (duration: 165.880553ms)","trace[89652039] 'applied index is now lower than readState.Index' (duration: 2.8µs)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:46:58.834963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.998035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-11T01:46:58.834989Z","caller":"traceutil/trace.go:171","msg":"trace[925739015] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:986; }","duration":"166.060886ms","start":"2026-02-11T01:46:58.668922Z","end":"2026-02-11T01:46:58.834983Z","steps":["trace[925739015] 'agreement among raft nodes before linearized reading' (duration: 165.950894ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:46:59.071764Z","caller":"traceutil/trace.go:171","msg":"trace[1118195740] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"124.337737ms","start":"2026-02-11T01:46:58.94741Z","end":"2026-02-11T01:46:59.071748Z","steps":["trace[1118195740] 'process raft request' (duration: 124.224454ms)"],"step_count":1} {"level":"info","ts":"2026-02-11T01:46:59.238352Z","caller":"traceutil/trace.go:171","msg":"trace[1312620137] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"135.719313ms","start":"2026-02-11T01:46:59.102606Z","end":"2026-02-11T01:46:59.238326Z","steps":["trace[1312620137] 'process raft request' (duration: 69.996322ms)","trace[1312620137] 'compare' (duration: 65.523746ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:46:59.904681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.48611ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-11T01:46:59.904793Z","caller":"traceutil/trace.go:171","msg":"trace[1969947290] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"303.61425ms","start":"2026-02-11T01:46:59.601151Z","end":"2026-02-11T01:46:59.904765Z","steps":["trace[1969947290] 'process raft request' (duration: 53.970306ms)","trace[1969947290] 'compare' (duration: 249.334406ms)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:46:59.904832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:46:59.601142Z","time spent":"303.673811ms","remote":"127.0.0.1:41718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":705,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-11T01:47:01.883161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.858356199s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-11T01:47:01.884278Z","caller":"traceutil/trace.go:171","msg":"trace[1322026085] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"2.280949084s","start":"2026-02-11T01:46:59.603287Z","end":"2026-02-11T01:47:01.884236Z","steps":["trace[1322026085] 'process raft request' (duration: 420.010365ms)","trace[1322026085] 'compare' (duration: 1.857645423s)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:47:01.884409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:46:59.603279Z","time spent":"2.281057387s","remote":"127.0.0.1:41884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-11T01:47:01.88463Z","caller":"traceutil/trace.go:171","msg":"trace[280423496] linearizableReadLoop","detail":"{readStateIndex:1029; appliedIndex:1027; }","duration":"2.259157623s","start":"2026-02-11T01:46:59.625465Z","end":"2026-02-11T01:47:01.884623Z","steps":["trace[280423496] 'read index received' (duration: 29.635144ms)","trace[280423496] 'applied index is now lower than readState.Index' (duration: 2.229521419s)"],"step_count":2} {"level":"warn","ts":"2026-02-11T01:47:01.888725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.554026861s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:47:01.888761Z","caller":"traceutil/trace.go:171","msg":"trace[1541128532] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:994; }","duration":"1.554064902s","start":"2026-02-11T01:47:00.334688Z","end":"2026-02-11T01:47:01.888753Z","steps":["trace[1541128532] 'agreement among raft nodes before linearized reading' (duration: 1.554009211s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:47:01.888782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:47:00.334657Z","time spent":"1.554119344s","remote":"127.0.0.1:41786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"warn","ts":"2026-02-11T01:47:01.888902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.263432832s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T01:47:01.888927Z","caller":"traceutil/trace.go:171","msg":"trace[2132173303] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:994; }","duration":"2.263470433s","start":"2026-02-11T01:46:59.625449Z","end":"2026-02-11T01:47:01.888919Z","steps":["trace[2132173303] 'agreement among raft nodes before linearized reading' (duration: 2.259231745s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:47:01.888944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:46:59.625441Z","time spent":"2.263498304s","remote":"127.0.0.1:41874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":29,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"warn","ts":"2026-02-11T01:47:01.889041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.020575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-11T01:47:01.889063Z","caller":"traceutil/trace.go:171","msg":"trace[138943211] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:994; }","duration":"122.173048ms","start":"2026-02-11T01:47:01.766885Z","end":"2026-02-11T01:47:01.889058Z","steps":["trace[138943211] 'agreement among raft nodes before linearized reading' (duration: 122.134667ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:47:01.889152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.832308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:47:01.889173Z","caller":"traceutil/trace.go:171","msg":"trace[273989790] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:994; }","duration":"378.90889ms","start":"2026-02-11T01:47:01.510259Z","end":"2026-02-11T01:47:01.889168Z","steps":["trace[273989790] 'agreement among raft nodes before linearized reading' (duration: 378.877639ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:47:01.889189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:47:01.510205Z","time spent":"378.980281ms","remote":"127.0.0.1:41860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-02-11T01:47:01.889342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.215038ms","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-11T01:47:01.889365Z","caller":"traceutil/trace.go:171","msg":"trace[1976487939] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:994; }","duration":"640.257748ms","start":"2026-02-11T01:47:01.249102Z","end":"2026-02-11T01:47:01.88936Z","steps":["trace[1976487939] 'agreement among raft nodes before linearized reading' (duration: 640.174806ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:47:01.889382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:47:01.249092Z","time spent":"640.284719ms","remote":"127.0.0.1:41884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-11T01:47:01.889478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.180066ms","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-11T01:47:01.889499Z","caller":"traceutil/trace.go:171","msg":"trace[598929464] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:994; }","duration":"643.262257ms","start":"2026-02-11T01:47:01.246232Z","end":"2026-02-11T01:47:01.889494Z","steps":["trace[598929464] 'agreement among raft nodes before linearized reading' (duration: 643.211686ms)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:47:01.889517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:47:01.246206Z","time spent":"643.306449ms","remote":"127.0.0.1:41884","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":"warn","ts":"2026-02-11T01:47:01.889613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.00314223s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-11T01:47:01.889633Z","caller":"traceutil/trace.go:171","msg":"trace[536367663] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:994; }","duration":"1.00319272s","start":"2026-02-11T01:47:00.886436Z","end":"2026-02-11T01:47:01.889628Z","steps":["trace[536367663] 'agreement among raft nodes before linearized reading' (duration: 1.003144029s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:47:01.88965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:47:00.886421Z","time spent":"1.003225462s","remote":"127.0.0.1:41884","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-11T01:47:01.88981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.050764206s","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-11T01:47:01.889832Z","caller":"traceutil/trace.go:171","msg":"trace[912398820] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:994; }","duration":"1.050828328s","start":"2026-02-11T01:47:00.838998Z","end":"2026-02-11T01:47:01.889827Z","steps":["trace[912398820] 'agreement among raft nodes before linearized reading' (duration: 1.050768347s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:47:01.889861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:47:00.83898Z","time spent":"1.050865379s","remote":"127.0.0.1:41884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-11T01:47:01.889938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.315988384s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-11T01:47:01.889959Z","caller":"traceutil/trace.go:171","msg":"trace[1989681583] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:994; }","duration":"1.316008346s","start":"2026-02-11T01:47:00.573945Z","end":"2026-02-11T01:47:01.889954Z","steps":["trace[1989681583] 'agreement among raft nodes before linearized reading' (duration: 1.315980715s)"],"step_count":1} {"level":"warn","ts":"2026-02-11T01:47:01.88998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-11T01:47:00.573901Z","time spent":"1.316075447s","remote":"127.0.0.1:41656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-11T01:47:06.329011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.874005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12727"} {"level":"info","ts":"2026-02-11T01:47:06.329349Z","caller":"traceutil/trace.go:171","msg":"trace[1952199752] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:1013; }","duration":"272.243193ms","start":"2026-02-11T01:47:06.057086Z","end":"2026-02-11T01:47:06.329329Z","steps":["trace[1952199752] 'range keys from in-memory index tree' (duration: 271.750363ms)"],"step_count":1}