{"level":"warn","ts":"2026-08-06T01:02:24.32967Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-06T01:02:24.329763Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.194: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.19.213.194:2380","--initial-cluster=instance=https://199.19.213.194:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.194:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.194: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-08-06T01:02:24.329834Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-06T01:02:24.329841Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.194:2380"]} {"level":"info","ts":"2026-08-06T01:02:24.329858Z","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-08-06T01:02:24.330533Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.194:2379"]} {"level":"info","ts":"2026-08-06T01:02:24.330603Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.194:2380"],"listen-peer-urls":["https://199.19.213.194:2380"],"advertise-client-urls":["https://199.19.213.194:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.194:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.194: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-08-06T01:02:24.333203Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.387527ms"} {"level":"info","ts":"2026-08-06T01:02:24.341659Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1444e0f5dfca45ef","cluster-id":"46f0df2abd5471c9"} {"level":"info","ts":"2026-08-06T01:02:24.341732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef switched to configuration voters=()"} {"level":"info","ts":"2026-08-06T01:02:24.341752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef became follower at term 0"} {"level":"info","ts":"2026-08-06T01:02:24.341764Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1444e0f5dfca45ef [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-06T01:02:24.341775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef became follower at term 1"} {"level":"info","ts":"2026-08-06T01:02:24.341807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef switched to configuration voters=(1460539525801068015)"} {"level":"warn","ts":"2026-08-06T01:02:24.349474Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-06T01:02:24.351311Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-06T01:02:24.353633Z","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-08-06T01:02:24.356294Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1444e0f5dfca45ef","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-06T01:02:24.359392Z","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-08-06T01:02:24.359469Z","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-08-06T01:02:24.359479Z","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-08-06T01:02:24.359564Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1444e0f5dfca45ef","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-06T01:02:24.36131Z","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-08-06T01:02:24.361447Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.194:2380"} {"level":"info","ts":"2026-08-06T01:02:24.361474Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.194:2380"} {"level":"info","ts":"2026-08-06T01:02:24.361562Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1444e0f5dfca45ef","initial-advertise-peer-urls":["https://199.19.213.194:2380"],"listen-peer-urls":["https://199.19.213.194:2380"],"advertise-client-urls":["https://199.19.213.194:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.194:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-06T01:02:24.361612Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-06T01:02:24.362134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef switched to configuration voters=(1460539525801068015)"} {"level":"info","ts":"2026-08-06T01:02:24.362332Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"46f0df2abd5471c9","local-member-id":"1444e0f5dfca45ef","added-peer-id":"1444e0f5dfca45ef","added-peer-peer-urls":["https://199.19.213.194:2380"]} {"level":"info","ts":"2026-08-06T01:02:24.842808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef is starting a new election at term 1"} {"level":"info","ts":"2026-08-06T01:02:24.842898Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef became pre-candidate at term 1"} {"level":"info","ts":"2026-08-06T01:02:24.842928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef received MsgPreVoteResp from 1444e0f5dfca45ef at term 1"} {"level":"info","ts":"2026-08-06T01:02:24.842949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef became candidate at term 2"} {"level":"info","ts":"2026-08-06T01:02:24.842968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef received MsgVoteResp from 1444e0f5dfca45ef at term 2"} {"level":"info","ts":"2026-08-06T01:02:24.842986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1444e0f5dfca45ef became leader at term 2"} {"level":"info","ts":"2026-08-06T01:02:24.843014Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1444e0f5dfca45ef elected leader 1444e0f5dfca45ef at term 2"} {"level":"info","ts":"2026-08-06T01:02:24.843932Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-06T01:02:24.844886Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1444e0f5dfca45ef","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.194:2379]}","request-path":"/0/members/1444e0f5dfca45ef/attributes","cluster-id":"46f0df2abd5471c9","publish-timeout":"7s"} {"level":"info","ts":"2026-08-06T01:02:24.844905Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-06T01:02:24.845112Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-06T01:02:24.845373Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-06T01:02:24.845389Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-06T01:02:24.848037Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-06T01:02:24.848405Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.194:2379"} {"level":"info","ts":"2026-08-06T01:02:24.85571Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"46f0df2abd5471c9","local-member-id":"1444e0f5dfca45ef","cluster-version":"3.5"} {"level":"info","ts":"2026-08-06T01:02:24.855795Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-06T01:02:24.855822Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-08-06T01:02:26.309944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.98284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.194\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-06T01:02:26.31009Z","caller":"traceutil/trace.go:171","msg":"trace[83164693] range","detail":"{range_begin:/registry/masterleases/199.19.213.194; range_end:; response_count:0; response_revision:4; }","duration":"135.217375ms","start":"2026-08-06T01:02:26.174853Z","end":"2026-08-06T01:02:26.310071Z","steps":["trace[83164693] 'range keys from in-memory index tree' (duration: 134.887157ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:02:26.31003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.679316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-06T01:02:26.309912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.080462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-06T01:02:26.310267Z","caller":"traceutil/trace.go:171","msg":"trace[910914972] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"132.630854ms","start":"2026-08-06T01:02:26.177618Z","end":"2026-08-06T01:02:26.310249Z","steps":["trace[910914972] 'process raft request' (duration: 130.990305ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:02:26.310248Z","caller":"traceutil/trace.go:171","msg":"trace[1491495026] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:4; }","duration":"132.940902ms","start":"2026-08-06T01:02:26.177279Z","end":"2026-08-06T01:02:26.310219Z","steps":["trace[1491495026] 'range keys from in-memory index tree' (duration: 132.621334ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:02:26.310407Z","caller":"traceutil/trace.go:171","msg":"trace[961319152] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:4; }","duration":"135.591904ms","start":"2026-08-06T01:02:26.17474Z","end":"2026-08-06T01:02:26.310332Z","steps":["trace[961319152] 'range keys from in-memory index tree' (duration: 135.01379ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:02:26.310153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.504736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-06T01:02:26.310752Z","caller":"traceutil/trace.go:171","msg":"trace[1270953132] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:4; }","duration":"137.192022ms","start":"2026-08-06T01:02:26.173533Z","end":"2026-08-06T01:02:26.310725Z","steps":["trace[1270953132] 'range keys from in-memory index tree' (duration: 136.355063ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:02:26.312765Z","caller":"traceutil/trace.go:171","msg":"trace[1830691916] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"134.959369ms","start":"2026-08-06T01:02:26.177775Z","end":"2026-08-06T01:02:26.312735Z","steps":["trace[1830691916] 'process raft request' (duration: 134.784435ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:02:26.312872Z","caller":"traceutil/trace.go:171","msg":"trace[2080396837] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"134.922699ms","start":"2026-08-06T01:02:26.177844Z","end":"2026-08-06T01:02:26.312767Z","steps":["trace[2080396837] 'process raft request' (duration: 134.806536ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:02:26.313112Z","caller":"traceutil/trace.go:171","msg":"trace[1097792115] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"135.172425ms","start":"2026-08-06T01:02:26.177928Z","end":"2026-08-06T01:02:26.313101Z","steps":["trace[1097792115] 'process raft request' (duration: 134.838497ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:02:26.31327Z","caller":"traceutil/trace.go:171","msg":"trace[505138386] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"135.396419ms","start":"2026-08-06T01:02:26.177864Z","end":"2026-08-06T01:02:26.313261Z","steps":["trace[505138386] 'process raft request' (duration: 134.817106ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:02:26.313488Z","caller":"traceutil/trace.go:171","msg":"trace[458740227] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"135.582503ms","start":"2026-08-06T01:02:26.177893Z","end":"2026-08-06T01:02:26.313476Z","steps":["trace[458740227] 'process raft request' (duration: 134.811835ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:02:26.313918Z","caller":"traceutil/trace.go:171","msg":"trace[1084197008] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"130.978315ms","start":"2026-08-06T01:02:26.1829Z","end":"2026-08-06T01:02:26.313879Z","steps":["trace[1084197008] 'process raft request' (duration: 129.90741ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:02:31.521969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.533473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-06T01:02:31.522007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.436884ms","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-08-06T01:02:31.522096Z","caller":"traceutil/trace.go:171","msg":"trace[430206389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:275; }","duration":"449.584988ms","start":"2026-08-06T01:02:31.072489Z","end":"2026-08-06T01:02:31.522074Z","steps":["trace[430206389] 'range keys from in-memory index tree' (duration: 449.309701ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:02:31.522143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:02:31.072467Z","time spent":"449.665429ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-06T01:02:31.522049Z","caller":"traceutil/trace.go:171","msg":"trace[568836925] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/expand-controller; range_end:; response_count:0; response_revision:275; }","duration":"475.668356ms","start":"2026-08-06T01:02:31.046365Z","end":"2026-08-06T01:02:31.522033Z","steps":["trace[568836925] 'range keys from in-memory index tree' (duration: 475.44797ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:02:31.52275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:02:31.046343Z","time spent":"476.394994ms","remote":"127.0.0.1:42914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" "} {"level":"info","ts":"2026-08-06T01:02:31.731936Z","caller":"traceutil/trace.go:171","msg":"trace[502257607] transaction","detail":"{read_only:false; response_revision:276; number_of_response:1; }","duration":"204.736054ms","start":"2026-08-06T01:02:31.527185Z","end":"2026-08-06T01:02:31.731921Z","steps":["trace[502257607] 'process raft request' (duration: 204.633042ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:02:32.068586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.033946ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T01:02:32.068672Z","caller":"traceutil/trace.go:171","msg":"trace[1342388134] linearizableReadLoop","detail":"{readStateIndex:287; appliedIndex:286; }","duration":"364.240785ms","start":"2026-08-06T01:02:31.70442Z","end":"2026-08-06T01:02:32.06866Z","steps":["trace[1342388134] 'read index received' (duration: 27.83026ms)","trace[1342388134] 'applied index is now lower than readState.Index' (duration: 336.409645ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T01:02:32.068761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.375558ms","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-08-06T01:02:32.069Z","caller":"traceutil/trace.go:171","msg":"trace[1510054541] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:277; }","duration":"364.645636ms","start":"2026-08-06T01:02:31.704339Z","end":"2026-08-06T01:02:32.068985Z","steps":["trace[1510054541] 'agreement among raft nodes before linearized reading' (duration: 364.387979ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:02:32.069038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:02:31.704319Z","time spent":"364.709667ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-06T01:02:32.068768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.914351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T01:02:32.069127Z","caller":"traceutil/trace.go:171","msg":"trace[1348400227] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replication-controller; range_end:; response_count:0; response_revision:277; }","duration":"333.306172ms","start":"2026-08-06T01:02:31.735803Z","end":"2026-08-06T01:02:32.069109Z","steps":["trace[1348400227] 'agreement among raft nodes before linearized reading' (duration: 332.936582ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:02:32.069206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:02:31.735786Z","time spent":"333.383734ms","remote":"127.0.0.1:42914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" "} {"level":"info","ts":"2026-08-06T01:02:32.06874Z","caller":"traceutil/trace.go:171","msg":"trace[944065233] transaction","detail":"{read_only:false; response_revision:277; number_of_response:1; }","duration":"541.512348ms","start":"2026-08-06T01:02:31.527188Z","end":"2026-08-06T01:02:32.0687Z","steps":["trace[944065233] 'process raft request' (duration: 390.792746ms)","trace[944065233] 'compare' (duration: 149.941374ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T01:02:32.069628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:02:31.527172Z","time spent":"542.303117ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T01:02:32.23879Z","caller":"traceutil/trace.go:171","msg":"trace[2099629370] transaction","detail":"{read_only:false; response_revision:278; number_of_response:1; }","duration":"165.746069ms","start":"2026-08-06T01:02:32.073023Z","end":"2026-08-06T01:02:32.238769Z","steps":["trace[2099629370] 'process raft request' (duration: 165.549355ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:02:32.239432Z","caller":"traceutil/trace.go:171","msg":"trace[546661363] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"164.406717ms","start":"2026-08-06T01:02:32.075006Z","end":"2026-08-06T01:02:32.239413Z","steps":["trace[546661363] 'process raft request' (duration: 164.225013ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:03:09.505999Z","caller":"traceutil/trace.go:171","msg":"trace[13083397] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"249.872033ms","start":"2026-08-06T01:03:09.256103Z","end":"2026-08-06T01:03:09.505975Z","steps":["trace[13083397] 'process raft request' (duration: 249.74209ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:03:09.513805Z","caller":"traceutil/trace.go:171","msg":"trace[2100788170] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"256.411587ms","start":"2026-08-06T01:03:09.25737Z","end":"2026-08-06T01:03:09.513781Z","steps":["trace[2100788170] 'process raft request' (duration: 256.212543ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:03:09.514012Z","caller":"traceutil/trace.go:171","msg":"trace[1888807762] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"248.232524ms","start":"2026-08-06T01:03:09.265742Z","end":"2026-08-06T01:03:09.513974Z","steps":["trace[1888807762] 'process raft request' (duration: 247.926387ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:03:09.51407Z","caller":"traceutil/trace.go:171","msg":"trace[977057918] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"240.130872ms","start":"2026-08-06T01:03:09.27393Z","end":"2026-08-06T01:03:09.514061Z","steps":["trace[977057918] 'process raft request' (duration: 239.986729ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:03:09.514155Z","caller":"traceutil/trace.go:171","msg":"trace[1084547180] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"229.89303ms","start":"2026-08-06T01:03:09.284254Z","end":"2026-08-06T01:03:09.514148Z","steps":["trace[1084547180] 'process raft request' (duration: 229.748717ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:03:09.514143Z","caller":"traceutil/trace.go:171","msg":"trace[1814209708] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"233.875804ms","start":"2026-08-06T01:03:09.280235Z","end":"2026-08-06T01:03:09.514111Z","steps":["trace[1814209708] 'process raft request' (duration: 233.729391ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:03:09.514159Z","caller":"traceutil/trace.go:171","msg":"trace[842827173] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"242.539899ms","start":"2026-08-06T01:03:09.27151Z","end":"2026-08-06T01:03:09.51405Z","steps":["trace[842827173] 'process raft request' (duration: 242.272642ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:03:09.514275Z","caller":"traceutil/trace.go:171","msg":"trace[2123383744] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"218.046479ms","start":"2026-08-06T01:03:09.296217Z","end":"2026-08-06T01:03:09.514263Z","steps":["trace[2123383744] 'process raft request' (duration: 217.959707ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:03:09.514242Z","caller":"traceutil/trace.go:171","msg":"trace[899179678] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"226.312804ms","start":"2026-08-06T01:03:09.287922Z","end":"2026-08-06T01:03:09.514235Z","steps":["trace[899179678] 'process raft request' (duration: 226.186961ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:03:09.514376Z","caller":"traceutil/trace.go:171","msg":"trace[210782044] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"218.031607ms","start":"2026-08-06T01:03:09.29631Z","end":"2026-08-06T01:03:09.514341Z","steps":["trace[210782044] 'process raft request' (duration: 217.917225ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:03:09.514415Z","caller":"traceutil/trace.go:171","msg":"trace[556900370] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"188.010187ms","start":"2026-08-06T01:03:09.326395Z","end":"2026-08-06T01:03:09.514405Z","steps":["trace[556900370] 'process raft request' (duration: 187.877274ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:03:12.842101Z","caller":"traceutil/trace.go:171","msg":"trace[284552745] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"111.748042ms","start":"2026-08-06T01:03:12.730306Z","end":"2026-08-06T01:03:12.842054Z","steps":["trace[284552745] 'process raft request' (duration: 111.562368ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:03:16.495737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.012249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-v74dm\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-06T01:03:16.495843Z","caller":"traceutil/trace.go:171","msg":"trace[365063310] range","detail":"{range_begin:/registry/pods/kube-system/cilium-v74dm; range_end:; response_count:1; response_revision:609; }","duration":"545.173585ms","start":"2026-08-06T01:03:15.950648Z","end":"2026-08-06T01:03:16.495821Z","steps":["trace[365063310] 'range keys from in-memory index tree' (duration: 544.726833ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:03:16.495896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:03:15.950623Z","time spent":"545.262346ms","remote":"127.0.0.1:42894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-v74dm\" "} {"level":"info","ts":"2026-08-06T01:03:16.573267Z","caller":"traceutil/trace.go:171","msg":"trace[1730943382] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:631; }","duration":"300.929809ms","start":"2026-08-06T01:03:16.272314Z","end":"2026-08-06T01:03:16.573244Z","steps":["trace[1730943382] 'read index received' (duration: 300.287584ms)","trace[1730943382] 'applied index is now lower than readState.Index' (duration: 641.085µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T01:03:16.573361Z","caller":"traceutil/trace.go:171","msg":"trace[359974651] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"455.122895ms","start":"2026-08-06T01:03:16.118194Z","end":"2026-08-06T01:03:16.573317Z","steps":["trace[359974651] 'process raft request' (duration: 454.529132ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:03:16.573755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.41516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-08-06T01:03:16.573803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:03:16.118159Z","time spent":"455.498803ms","remote":"127.0.0.1:42810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T01:03:16.573893Z","caller":"traceutil/trace.go:171","msg":"trace[756902496] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:610; }","duration":"301.583394ms","start":"2026-08-06T01:03:16.272252Z","end":"2026-08-06T01:03:16.573835Z","steps":["trace[756902496] 'agreement among raft nodes before linearized reading' (duration: 301.184815ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:03:16.573982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:03:16.272222Z","time spent":"301.744947ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-06T01:03:17.068567Z","caller":"traceutil/trace.go:171","msg":"trace[1028670544] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"495.143754ms","start":"2026-08-06T01:03:16.573399Z","end":"2026-08-06T01:03:17.068543Z","steps":["trace[1028670544] 'read index received' (duration: 495.030272ms)","trace[1028670544] 'applied index is now lower than readState.Index' (duration: 111.952µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T01:03:17.068621Z","caller":"traceutil/trace.go:171","msg":"trace[2015621354] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"559.360563ms","start":"2026-08-06T01:03:16.509225Z","end":"2026-08-06T01:03:17.068585Z","steps":["trace[2015621354] 'process raft request' (duration: 559.051846ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:03:17.068787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:03:16.509208Z","time spent":"559.485116ms","remote":"127.0.0.1:42894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T01:03:17.068841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"751.08985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T01:03:17.068947Z","caller":"traceutil/trace.go:171","msg":"trace[1000286911] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:611; }","duration":"751.261924ms","start":"2026-08-06T01:03:16.317662Z","end":"2026-08-06T01:03:17.068924Z","steps":["trace[1000286911] 'agreement among raft nodes before linearized reading' (duration: 751.014838ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:03:17.068958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.651961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-06T01:03:17.069015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:03:16.317637Z","time spent":"751.365216ms","remote":"127.0.0.1:42714","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-08-06T01:03:17.069084Z","caller":"traceutil/trace.go:171","msg":"trace[1669063816] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:611; }","duration":"625.839355ms","start":"2026-08-06T01:03:16.443212Z","end":"2026-08-06T01:03:17.069052Z","steps":["trace[1669063816] 'agreement among raft nodes before linearized reading' (duration: 625.395805ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:03:17.069146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:03:16.44319Z","time spent":"625.943317ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-06T01:03:17.569416Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5039422243479116337,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-06T01:03:18.070206Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5039422243479116337,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-06T01:03:18.120212Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.051887895s","expected-duration":"1s"} {"level":"info","ts":"2026-08-06T01:03:18.120889Z","caller":"traceutil/trace.go:171","msg":"trace[1970630362] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"1.477479647s","start":"2026-08-06T01:03:16.643376Z","end":"2026-08-06T01:03:18.120855Z","steps":["trace[1970630362] 'process raft request' (duration: 1.477423556s)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:03:18.120907Z","caller":"traceutil/trace.go:171","msg":"trace[314849819] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"1.539631949s","start":"2026-08-06T01:03:16.581237Z","end":"2026-08-06T01:03:18.120869Z","steps":["trace[314849819] 'process raft request' (duration: 1.539348491s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:03:18.12112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:03:16.643342Z","time spent":"1.477699393s","remote":"127.0.0.1:42942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-06T01:03:18.121177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:03:16.581216Z","time spent":"1.539887294s","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T01:03:18.188248Z","caller":"traceutil/trace.go:171","msg":"trace[1475934346] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:633; }","duration":"1.119581197s","start":"2026-08-06T01:03:17.068628Z","end":"2026-08-06T01:03:18.188209Z","steps":["trace[1475934346] 'read index received' (duration: 1.051939657s)","trace[1475934346] 'applied index is now lower than readState.Index' (duration: 67.63984ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T01:03:18.188482Z","caller":"traceutil/trace.go:171","msg":"trace[1388798229] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"772.607579ms","start":"2026-08-06T01:03:17.415856Z","end":"2026-08-06T01:03:18.188463Z","steps":["trace[1388798229] 'process raft request' (duration: 772.290592ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:03:18.188282Z","caller":"traceutil/trace.go:171","msg":"trace[1096521402] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"1.113394153s","start":"2026-08-06T01:03:17.074846Z","end":"2026-08-06T01:03:18.18824Z","steps":["trace[1096521402] 'process raft request' (duration: 1.059445211s)","trace[1096521402] 'compare' (duration: 53.703717ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T01:03:18.188689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:03:17.415821Z","time spent":"772.714941ms","remote":"127.0.0.1:42974","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-08-06T01:03:18.188734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:03:17.074775Z","time spent":"1.113825583s","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T01:03:18.188834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.325732338s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-06T01:03:18.188876Z","caller":"traceutil/trace.go:171","msg":"trace[170402061] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:615; }","duration":"1.325777199s","start":"2026-08-06T01:03:16.863089Z","end":"2026-08-06T01:03:18.188866Z","steps":["trace[170402061] 'agreement among raft nodes before linearized reading' (duration: 1.325603335s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:03:18.188901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:03:16.863063Z","time spent":"1.325832939s","remote":"127.0.0.1:42974","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-08-06T01:03:18.188937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.118428689s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T01:03:18.191034Z","caller":"traceutil/trace.go:171","msg":"trace[696544101] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"1.120574359s","start":"2026-08-06T01:03:17.070436Z","end":"2026-08-06T01:03:18.19101Z","steps":["trace[696544101] 'agreement among raft nodes before linearized reading' (duration: 1.118461449s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:03:18.191132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:03:17.070411Z","time spent":"1.120690372s","remote":"127.0.0.1:42700","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-08-06T01:03:18.191532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.603122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.194\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-06T01:03:18.191667Z","caller":"traceutil/trace.go:171","msg":"trace[2053251765] range","detail":"{range_begin:/registry/masterleases/199.19.213.194; range_end:; response_count:1; response_revision:615; }","duration":"369.675524ms","start":"2026-08-06T01:03:17.821888Z","end":"2026-08-06T01:03:18.191563Z","steps":["trace[2053251765] 'agreement among raft nodes before linearized reading' (duration: 369.572672ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:03:18.191695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.338573935s","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-08-06T01:03:18.191803Z","caller":"traceutil/trace.go:171","msg":"trace[1594163307] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:615; }","duration":"1.338731589s","start":"2026-08-06T01:03:16.853044Z","end":"2026-08-06T01:03:18.191776Z","steps":["trace[1594163307] 'agreement among raft nodes before linearized reading' (duration: 1.335894333s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:03:18.191736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:03:17.821869Z","time spent":"369.853198ms","remote":"127.0.0.1:42748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.194\" "} {"level":"warn","ts":"2026-08-06T01:03:18.191861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:03:16.853024Z","time spent":"1.338825111s","remote":"127.0.0.1:42974","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":"info","ts":"2026-08-06T01:03:34.254331Z","caller":"traceutil/trace.go:171","msg":"trace[354040561] linearizableReadLoop","detail":"{readStateIndex:806; appliedIndex:805; }","duration":"133.532468ms","start":"2026-08-06T01:03:34.120773Z","end":"2026-08-06T01:03:34.254306Z","steps":["trace[354040561] 'read index received' (duration: 133.367964ms)","trace[354040561] 'applied index is now lower than readState.Index' (duration: 163.534µs)"],"step_count":2} {"level":"warn","ts":"2026-08-06T01:03:34.254513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.651169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T01:03:34.254591Z","caller":"traceutil/trace.go:171","msg":"trace[1035316450] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:778; }","duration":"133.747262ms","start":"2026-08-06T01:03:34.120794Z","end":"2026-08-06T01:03:34.254541Z","steps":["trace[1035316450] 'agreement among raft nodes before linearized reading' (duration: 133.65817ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:03:34.254916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.044647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T01:03:34.255005Z","caller":"traceutil/trace.go:171","msg":"trace[995596493] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:778; }","duration":"133.188029ms","start":"2026-08-06T01:03:34.121795Z","end":"2026-08-06T01:03:34.254983Z","steps":["trace[995596493] 'agreement among raft nodes before linearized reading' (duration: 133.024235ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:03:34.255101Z","caller":"traceutil/trace.go:171","msg":"trace[1279558272] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"174.386004ms","start":"2026-08-06T01:03:34.080685Z","end":"2026-08-06T01:03:34.255071Z","steps":["trace[1279558272] 'process raft request' (duration: 173.479433ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:03:34.256932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.116377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T01:03:34.257026Z","caller":"traceutil/trace.go:171","msg":"trace[619772934] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:778; }","duration":"136.2573ms","start":"2026-08-06T01:03:34.120748Z","end":"2026-08-06T01:03:34.257006Z","steps":["trace[619772934] 'agreement among raft nodes before linearized reading' (duration: 133.67646ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:04:09.981698Z","caller":"traceutil/trace.go:171","msg":"trace[231021838] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"148.265408ms","start":"2026-08-06T01:04:09.833406Z","end":"2026-08-06T01:04:09.981671Z","steps":["trace[231021838] 'process raft request' (duration: 148.109365ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:04:36.233497Z","caller":"traceutil/trace.go:171","msg":"trace[1332069286] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"108.275251ms","start":"2026-08-06T01:04:36.125171Z","end":"2026-08-06T01:04:36.233447Z","steps":["trace[1332069286] 'process raft request' (duration: 108.024356ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:04:36.825559Z","caller":"traceutil/trace.go:171","msg":"trace[433109469] linearizableReadLoop","detail":"{readStateIndex:1122; appliedIndex:1120; }","duration":"192.846231ms","start":"2026-08-06T01:04:36.632684Z","end":"2026-08-06T01:04:36.82553Z","steps":["trace[433109469] 'read index received' (duration: 12.132148ms)","trace[433109469] 'applied index is now lower than readState.Index' (duration: 180.712513ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T01:04:36.825599Z","caller":"traceutil/trace.go:171","msg":"trace[1523744094] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"193.916537ms","start":"2026-08-06T01:04:36.631625Z","end":"2026-08-06T01:04:36.825541Z","steps":["trace[1523744094] 'process raft request' (duration: 172.7204ms)","trace[1523744094] 'compare' (duration: 20.9149ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T01:04:36.825974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.574618ms","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-08-06T01:04:36.826029Z","caller":"traceutil/trace.go:171","msg":"trace[1766687494] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1082; }","duration":"186.653759ms","start":"2026-08-06T01:04:36.63936Z","end":"2026-08-06T01:04:36.826014Z","steps":["trace[1766687494] 'agreement among raft nodes before linearized reading' (duration: 186.406034ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:04:36.825716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.017995ms","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-08-06T01:04:36.826668Z","caller":"traceutil/trace.go:171","msg":"trace[1921651370] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1082; }","duration":"194.006868ms","start":"2026-08-06T01:04:36.632647Z","end":"2026-08-06T01:04:36.826654Z","steps":["trace[1921651370] 'agreement among raft nodes before linearized reading' (duration: 192.974885ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:04:37.777785Z","caller":"traceutil/trace.go:171","msg":"trace[40694856] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"233.529545ms","start":"2026-08-06T01:04:37.544231Z","end":"2026-08-06T01:04:37.777761Z","steps":["trace[40694856] 'process raft request' (duration: 233.399241ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:04:38.236663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.865075ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-08-06T01:04:38.236827Z","caller":"traceutil/trace.go:171","msg":"trace[1573597435] linearizableReadLoop","detail":"{readStateIndex:1126; appliedIndex:1125; }","duration":"285.548506ms","start":"2026-08-06T01:04:37.951251Z","end":"2026-08-06T01:04:38.2368Z","steps":["trace[1573597435] 'read index received' (duration: 50.484207ms)","trace[1573597435] 'applied index is now lower than readState.Index' (duration: 235.061849ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T01:04:38.236931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.656479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T01:04:38.236959Z","caller":"traceutil/trace.go:171","msg":"trace[1917307341] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1085; }","duration":"285.739241ms","start":"2026-08-06T01:04:37.951209Z","end":"2026-08-06T01:04:38.236948Z","steps":["trace[1917307341] 'agreement among raft nodes before linearized reading' (duration: 285.651049ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:04:38.236972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:04:37.826417Z","time spent":"410.536212ms","remote":"127.0.0.1:42748","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-08-06T01:04:39.094103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.289541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-06T01:04:39.094166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.644745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-06T01:04:39.094179Z","caller":"traceutil/trace.go:171","msg":"trace[1335608712] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1088; }","duration":"251.413203ms","start":"2026-08-06T01:04:38.842749Z","end":"2026-08-06T01:04:39.094162Z","steps":["trace[1335608712] 'range keys from in-memory index tree' (duration: 251.078336ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:04:39.094189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.680489ms","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-08-06T01:04:39.094221Z","caller":"traceutil/trace.go:171","msg":"trace[574215969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1088; }","duration":"263.720697ms","start":"2026-08-06T01:04:38.830473Z","end":"2026-08-06T01:04:39.094194Z","steps":["trace[574215969] 'range keys from in-memory index tree' (duration: 263.530302ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:04:39.094237Z","caller":"traceutil/trace.go:171","msg":"trace[1250459260] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1088; }","duration":"230.77285ms","start":"2026-08-06T01:04:38.86345Z","end":"2026-08-06T01:04:39.094223Z","steps":["trace[1250459260] 'range keys from in-memory index tree' (duration: 230.543676ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:04:55.22308Z","caller":"traceutil/trace.go:171","msg":"trace[244471326] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"453.321303ms","start":"2026-08-06T01:04:54.76973Z","end":"2026-08-06T01:04:55.223051Z","steps":["trace[244471326] 'process raft request' (duration: 453.066268ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:04:55.223211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:04:54.769702Z","time spent":"453.443907ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T01:04:55.403663Z","caller":"traceutil/trace.go:171","msg":"trace[258287594] linearizableReadLoop","detail":"{readStateIndex:1239; appliedIndex:1238; }","duration":"140.964231ms","start":"2026-08-06T01:04:55.262672Z","end":"2026-08-06T01:04:55.403636Z","steps":["trace[258287594] 'read index received' (duration: 138.217898ms)","trace[258287594] 'applied index is now lower than readState.Index' (duration: 2.745533ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T01:04:55.404068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.893807ms","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-08-06T01:04:55.404099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.402473ms","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-08-06T01:04:55.404129Z","caller":"traceutil/trace.go:171","msg":"trace[798591797] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1193; }","duration":"139.99624ms","start":"2026-08-06T01:04:55.264116Z","end":"2026-08-06T01:04:55.404112Z","steps":["trace[798591797] 'agreement among raft nodes before linearized reading' (duration: 139.821826ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:04:55.40416Z","caller":"traceutil/trace.go:171","msg":"trace[318582517] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1193; }","duration":"141.510385ms","start":"2026-08-06T01:04:55.262629Z","end":"2026-08-06T01:04:55.40414Z","steps":["trace[318582517] 'agreement among raft nodes before linearized reading' (duration: 141.333061ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:04:55.404373Z","caller":"traceutil/trace.go:171","msg":"trace[364330004] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"177.600842ms","start":"2026-08-06T01:04:55.226758Z","end":"2026-08-06T01:04:55.404359Z","steps":["trace[364330004] 'process raft request' (duration: 174.155853ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:05:12.105228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.075623ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T01:05:12.10571Z","caller":"traceutil/trace.go:171","msg":"trace[1411112533] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"536.969309ms","start":"2026-08-06T01:05:11.568716Z","end":"2026-08-06T01:05:12.105685Z","steps":["trace[1411112533] 'process raft request' (duration: 536.880217ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:05:12.105809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:05:11.56871Z","time spent":"537.054413ms","remote":"127.0.0.1:43166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9375,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T01:05:12.106323Z","caller":"traceutil/trace.go:171","msg":"trace[142887260] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"541.72306ms","start":"2026-08-06T01:05:11.564584Z","end":"2026-08-06T01:05:12.106307Z","steps":["trace[142887260] 'process raft request' (duration: 256.43599ms)","trace[142887260] 'compare' (duration: 283.799416ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T01:05:12.106404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:05:11.564557Z","time spent":"541.810443ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T01:05:12.106682Z","caller":"traceutil/trace.go:171","msg":"trace[2070203108] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"541.612007ms","start":"2026-08-06T01:05:11.565057Z","end":"2026-08-06T01:05:12.106669Z","steps":["trace[2070203108] 'process raft request' (duration: 540.311886ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:05:12.106761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:05:11.565046Z","time spent":"541.671489ms","remote":"127.0.0.1:42984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1508,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T01:05:12.106997Z","caller":"traceutil/trace.go:171","msg":"trace[831799233] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"540.032081ms","start":"2026-08-06T01:05:11.566947Z","end":"2026-08-06T01:05:12.106979Z","steps":["trace[831799233] 'process raft request' (duration: 538.537236ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:05:12.107098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:05:11.566933Z","time spent":"540.113523ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T01:05:12.107433Z","caller":"traceutil/trace.go:171","msg":"trace[1934241886] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"539.935019ms","start":"2026-08-06T01:05:11.56744Z","end":"2026-08-06T01:05:12.107375Z","steps":["trace[1934241886] 'process raft request' (duration: 538.095916ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:05:12.107508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:05:11.56743Z","time spent":"540.035351ms","remote":"127.0.0.1:42870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":915,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T01:05:12.141953Z","caller":"traceutil/trace.go:171","msg":"trace[586799174] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"238.383165ms","start":"2026-08-06T01:05:11.903538Z","end":"2026-08-06T01:05:12.141921Z","steps":["trace[586799174] 'process raft request' (duration: 238.215961ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:05:12.639385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.164623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-06T01:05:12.639459Z","caller":"traceutil/trace.go:171","msg":"trace[39303937] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1269; }","duration":"150.306886ms","start":"2026-08-06T01:05:12.489135Z","end":"2026-08-06T01:05:12.639442Z","steps":["trace[39303937] 'count revisions from in-memory index tree' (duration: 150.076221ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:05:12.63975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.869124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-06T01:05:12.639761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.884098ms","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-08-06T01:05:12.639824Z","caller":"traceutil/trace.go:171","msg":"trace[2128687962] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1269; }","duration":"323.994728ms","start":"2026-08-06T01:05:12.315804Z","end":"2026-08-06T01:05:12.639798Z","steps":["trace[2128687962] 'range keys from in-memory index tree' (duration: 323.765812ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:05:12.639858Z","caller":"traceutil/trace.go:171","msg":"trace[1742389300] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1269; }","duration":"127.042372ms","start":"2026-08-06T01:05:12.512792Z","end":"2026-08-06T01:05:12.639835Z","steps":["trace[1742389300] 'range keys from in-memory index tree' (duration: 126.629732ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:05:12.639862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:05:12.315776Z","time spent":"324.0788ms","remote":"127.0.0.1:42714","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-08-06T01:05:12.803292Z","caller":"traceutil/trace.go:171","msg":"trace[905910161] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"159.057476ms","start":"2026-08-06T01:05:12.6442Z","end":"2026-08-06T01:05:12.803257Z","steps":["trace[905910161] 'process raft request' (duration: 158.855161ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:05:13.520728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.578501ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-06T01:05:13.520837Z","caller":"traceutil/trace.go:171","msg":"trace[411505139] linearizableReadLoop","detail":"{readStateIndex:1320; appliedIndex:1319; }","duration":"204.833256ms","start":"2026-08-06T01:05:13.315976Z","end":"2026-08-06T01:05:13.520809Z","steps":["trace[411505139] 'read index received' (duration: 34.089872ms)","trace[411505139] 'applied index is now lower than readState.Index' (duration: 170.742224ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T01:05:13.520997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.02058ms","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-08-06T01:05:13.521022Z","caller":"traceutil/trace.go:171","msg":"trace[1265764998] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1270; }","duration":"205.095662ms","start":"2026-08-06T01:05:13.315919Z","end":"2026-08-06T01:05:13.521015Z","steps":["trace[1265764998] 'agreement among raft nodes before linearized reading' (duration: 204.967119ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:05:13.521523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.470867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T01:05:13.521552Z","caller":"traceutil/trace.go:171","msg":"trace[2056873593] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1271; }","duration":"204.500869ms","start":"2026-08-06T01:05:13.317043Z","end":"2026-08-06T01:05:13.521544Z","steps":["trace[2056873593] 'agreement among raft nodes before linearized reading' (duration: 204.450248ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:05:13.521701Z","caller":"traceutil/trace.go:171","msg":"trace[993361208] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"159.944776ms","start":"2026-08-06T01:05:13.361709Z","end":"2026-08-06T01:05:13.521654Z","steps":["trace[993361208] 'process raft request' (duration: 159.68766ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:05:13.790204Z","caller":"traceutil/trace.go:171","msg":"trace[1660717435] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"199.228198ms","start":"2026-08-06T01:05:13.590947Z","end":"2026-08-06T01:05:13.790175Z","steps":["trace[1660717435] 'process raft request' (duration: 188.185675ms)","trace[1660717435] 'compare' (duration: 10.91217ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T01:05:14.253582Z","caller":"traceutil/trace.go:171","msg":"trace[361602166] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"132.320493ms","start":"2026-08-06T01:05:14.121233Z","end":"2026-08-06T01:05:14.253553Z","steps":["trace[361602166] 'process raft request' (duration: 132.043517ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:05:14.272224Z","caller":"traceutil/trace.go:171","msg":"trace[2006954415] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"125.456287ms","start":"2026-08-06T01:05:14.146737Z","end":"2026-08-06T01:05:14.272193Z","steps":["trace[2006954415] 'process raft request' (duration: 125.409576ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:05:14.272472Z","caller":"traceutil/trace.go:171","msg":"trace[844256972] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"149.982399ms","start":"2026-08-06T01:05:14.12247Z","end":"2026-08-06T01:05:14.272453Z","steps":["trace[844256972] 'process raft request' (duration: 149.503138ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:05:28.021602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.309821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-06T01:05:28.021685Z","caller":"traceutil/trace.go:171","msg":"trace[1260001416] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1368; }","duration":"170.431655ms","start":"2026-08-06T01:05:27.851235Z","end":"2026-08-06T01:05:28.021667Z","steps":["trace[1260001416] 'range keys from in-memory index tree' (duration: 169.876771ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:05:28.021793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.267078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T01:05:28.022046Z","caller":"traceutil/trace.go:171","msg":"trace[1597057530] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1368; }","duration":"246.391661ms","start":"2026-08-06T01:05:27.775456Z","end":"2026-08-06T01:05:28.021848Z","steps":["trace[1597057530] 'count revisions from in-memory index tree' (duration: 246.102964ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:05:28.022335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.612869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.194\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-06T01:05:28.022424Z","caller":"traceutil/trace.go:171","msg":"trace[1325459150] range","detail":"{range_begin:/registry/masterleases/199.19.213.194; range_end:; response_count:1; response_revision:1368; }","duration":"195.702151ms","start":"2026-08-06T01:05:27.826701Z","end":"2026-08-06T01:05:28.022403Z","steps":["trace[1325459150] 'range keys from in-memory index tree' (duration: 195.418805ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:05:28.522053Z","caller":"traceutil/trace.go:171","msg":"trace[445615757] transaction","detail":"{read_only:false; response_revision:1369; number_of_response:1; }","duration":"495.385153ms","start":"2026-08-06T01:05:28.026642Z","end":"2026-08-06T01:05:28.522027Z","steps":["trace[445615757] 'process raft request' (duration: 495.212759ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:05:28.522381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:05:28.026618Z","time spent":"495.508245ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T01:05:28.524707Z","caller":"traceutil/trace.go:171","msg":"trace[512471101] transaction","detail":"{read_only:false; response_revision:1371; number_of_response:1; }","duration":"198.414566ms","start":"2026-08-06T01:05:28.326266Z","end":"2026-08-06T01:05:28.524681Z","steps":["trace[512471101] 'process raft request' (duration: 198.272671ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:05:28.524824Z","caller":"traceutil/trace.go:171","msg":"trace[413783775] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"368.845349ms","start":"2026-08-06T01:05:28.1559Z","end":"2026-08-06T01:05:28.524745Z","steps":["trace[413783775] 'process raft request' (duration: 368.436209ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:05:28.525003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:05:28.155881Z","time spent":"369.033914ms","remote":"127.0.0.1:42748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T01:05:28.524617Z","caller":"traceutil/trace.go:171","msg":"trace[1882814454] linearizableReadLoop","detail":"{readStateIndex:1423; appliedIndex:1421; }","duration":"210.937696ms","start":"2026-08-06T01:05:28.313652Z","end":"2026-08-06T01:05:28.524589Z","steps":["trace[1882814454] 'read index received' (duration: 208.304835ms)","trace[1882814454] 'applied index is now lower than readState.Index' (duration: 2.631971ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T01:05:28.525359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.714805ms","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-08-06T01:05:28.525762Z","caller":"traceutil/trace.go:171","msg":"trace[2146113108] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1371; }","duration":"212.152255ms","start":"2026-08-06T01:05:28.313589Z","end":"2026-08-06T01:05:28.525741Z","steps":["trace[2146113108] 'agreement among raft nodes before linearized reading' (duration: 211.663294ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:05:28.526681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.329613ms","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-08-06T01:05:28.526826Z","caller":"traceutil/trace.go:171","msg":"trace[1964825282] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1371; }","duration":"195.487026ms","start":"2026-08-06T01:05:28.331279Z","end":"2026-08-06T01:05:28.526766Z","steps":["trace[1964825282] 'agreement among raft nodes before linearized reading' (duration: 194.738549ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:08:21.551011Z","caller":"traceutil/trace.go:171","msg":"trace[1445800682] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"112.193376ms","start":"2026-08-06T01:08:21.438708Z","end":"2026-08-06T01:08:21.550901Z","steps":["trace[1445800682] 'process raft request' (duration: 111.997562ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T01:08:21.551672Z","caller":"traceutil/trace.go:171","msg":"trace[216112281] linearizableReadLoop","detail":"{readStateIndex:2252; appliedIndex:2250; }","duration":"109.469164ms","start":"2026-08-06T01:08:21.442162Z","end":"2026-08-06T01:08:21.551631Z","steps":["trace[216112281] 'read index received' (duration: 108.610383ms)","trace[216112281] 'applied index is now lower than readState.Index' (duration: 857.291µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T01:08:21.55175Z","caller":"traceutil/trace.go:171","msg":"trace[1655796393] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"111.145343ms","start":"2026-08-06T01:08:21.44053Z","end":"2026-08-06T01:08:21.551675Z","steps":["trace[1655796393] 'process raft request' (duration: 110.899497ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:08:21.551947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.747211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-06T01:08:21.552003Z","caller":"traceutil/trace.go:171","msg":"trace[1279301200] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2165; }","duration":"109.863533ms","start":"2026-08-06T01:08:21.442124Z","end":"2026-08-06T01:08:21.551987Z","steps":["trace[1279301200] 'agreement among raft nodes before linearized reading' (duration: 109.651238ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:08:57.176622Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5039422243479120406,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-06T01:08:57.676795Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5039422243479120406,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-06T01:08:58.177721Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5039422243479120406,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-06T01:08:58.428221Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.790627803s","expected-duration":"1s"} {"level":"info","ts":"2026-08-06T01:08:58.428656Z","caller":"traceutil/trace.go:171","msg":"trace[263176178] transaction","detail":"{read_only:false; response_revision:2326; number_of_response:1; }","duration":"1.791133505s","start":"2026-08-06T01:08:56.637493Z","end":"2026-08-06T01:08:58.428626Z","steps":["trace[263176178] 'process raft request' (duration: 1.790961961s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:08:58.428838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:08:56.637479Z","time spent":"1.791229067s","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T01:08:58.471227Z","caller":"traceutil/trace.go:171","msg":"trace[640413059] linearizableReadLoop","detail":"{readStateIndex:2421; appliedIndex:2420; }","duration":"1.79569505s","start":"2026-08-06T01:08:56.675507Z","end":"2026-08-06T01:08:58.471202Z","steps":["trace[640413059] 'read index received' (duration: 1.753601964s)","trace[640413059] 'applied index is now lower than readState.Index' (duration: 42.092006ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T01:08:58.471279Z","caller":"traceutil/trace.go:171","msg":"trace[1378999445] transaction","detail":"{read_only:false; response_revision:2327; number_of_response:1; }","duration":"1.151470811s","start":"2026-08-06T01:08:57.319776Z","end":"2026-08-06T01:08:58.471246Z","steps":["trace[1378999445] 'process raft request' (duration: 1.151199695s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:08:58.471447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:08:57.319745Z","time spent":"1.151593493s","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T01:08:58.471551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.72025935s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-06T01:08:58.47161Z","caller":"traceutil/trace.go:171","msg":"trace[1011597316] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:2328; }","duration":"1.720374873s","start":"2026-08-06T01:08:56.751225Z","end":"2026-08-06T01:08:58.4716Z","steps":["trace[1011597316] 'agreement among raft nodes before linearized reading' (duration: 1.720281131s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:08:58.471636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:08:56.751195Z","time spent":"1.720432304s","remote":"127.0.0.1:42766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":31,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-08-06T01:08:58.471479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.795969627s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-08-06T01:08:58.471766Z","caller":"traceutil/trace.go:171","msg":"trace[1943660380] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2328; }","duration":"1.796263553s","start":"2026-08-06T01:08:56.675462Z","end":"2026-08-06T01:08:58.471726Z","steps":["trace[1943660380] 'agreement among raft nodes before linearized reading' (duration: 1.795875104s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:08:58.471795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.783964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-06T01:08:58.471819Z","caller":"traceutil/trace.go:171","msg":"trace[725742453] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2328; }","duration":"744.826124ms","start":"2026-08-06T01:08:57.726982Z","end":"2026-08-06T01:08:58.471808Z","steps":["trace[725742453] 'agreement among raft nodes before linearized reading' (duration: 744.767763ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:08:58.471815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:08:56.675439Z","time spent":"1.796362846s","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-08-06T01:08:58.471837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:08:57.726964Z","time spent":"744.868646ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-06T01:08:58.471919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.759916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-06T01:08:58.47194Z","caller":"traceutil/trace.go:171","msg":"trace[596348031] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2328; }","duration":"745.831167ms","start":"2026-08-06T01:08:57.726103Z","end":"2026-08-06T01:08:58.471934Z","steps":["trace[596348031] 'agreement among raft nodes before linearized reading' (duration: 745.773956ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:08:58.4719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.901059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"warn","ts":"2026-08-06T01:08:58.471958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:08:57.726075Z","time spent":"745.879229ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-06T01:08:58.47199Z","caller":"traceutil/trace.go:171","msg":"trace[1886173482] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2328; }","duration":"512.069073ms","start":"2026-08-06T01:08:57.959897Z","end":"2026-08-06T01:08:58.471966Z","steps":["trace[1886173482] 'agreement among raft nodes before linearized reading' (duration: 511.751676ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:08:58.472033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:08:57.959865Z","time spent":"512.159755ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-08-06T01:08:58.472067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.15489455s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T01:08:58.472086Z","caller":"traceutil/trace.go:171","msg":"trace[2144590711] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2328; }","duration":"1.154957691s","start":"2026-08-06T01:08:57.317122Z","end":"2026-08-06T01:08:58.47208Z","steps":["trace[2144590711] 'agreement among raft nodes before linearized reading' (duration: 1.154926641s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:08:58.472101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:08:57.317101Z","time spent":"1.154996413s","remote":"127.0.0.1:42714","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-08-06T01:08:58.472038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.218376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-06T01:08:58.47226Z","caller":"traceutil/trace.go:171","msg":"trace[1831458931] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2328; }","duration":"746.470402ms","start":"2026-08-06T01:08:57.725769Z","end":"2026-08-06T01:08:58.472239Z","steps":["trace[1831458931] 'agreement among raft nodes before linearized reading' (duration: 746.232667ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:08:58.47232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:08:57.725745Z","time spent":"746.558675ms","remote":"127.0.0.1:42974","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-08-06T01:08:58.472221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.276240177s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-06T01:08:58.472473Z","caller":"traceutil/trace.go:171","msg":"trace[1049482772] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:2328; }","duration":"1.276555174s","start":"2026-08-06T01:08:57.195911Z","end":"2026-08-06T01:08:58.472466Z","steps":["trace[1049482772] 'agreement among raft nodes before linearized reading' (duration: 1.276275968s)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:08:58.472497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:08:57.195883Z","time spent":"1.276607516s","remote":"127.0.0.1:42894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":13,"response size":29,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-08-06T01:08:58.472679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.611914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-08-06T01:08:58.472733Z","caller":"traceutil/trace.go:171","msg":"trace[2115211362] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2328; }","duration":"340.740687ms","start":"2026-08-06T01:08:58.13197Z","end":"2026-08-06T01:08:58.472711Z","steps":["trace[2115211362] 'agreement among raft nodes before linearized reading' (duration: 340.45816ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T01:08:58.47284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T01:08:58.13194Z","time spent":"340.885019ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":553,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}